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.UIFjKITyoj', 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: 6ff05407-beb8-494f-9c00-4acd98bcf827 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-24T03:02:00Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-24T03:02:00Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-24T03:02:00Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-24T03:02:00Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-24T03:02:00Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-24T03:02:00Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-24T03:02:00Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-24T03:02:00Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-24T03:02:00Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-24T03:02:00Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-24T03:02:00Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-24T03:02:00Z INFO virtiofsd] Client connected, servicing requests machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.57 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT @1792058300 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 s187672 r8192 d115432 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/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/init regInfo=/nix/.ro-store/8wh26jzkjix8qmcqz82sh98g12vadrlj-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/8wh26jzkjix8qmcqz82sh98g12vadrlj-closure-info/registration", will be passed to user space. machine # [ 0.000000] printk: log buffer data + meta data: 1048576 + 3670016 = 4718592 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 75301 entries in 296 pages machine # [ 0.000000] ftrace: allocated 296 pages with 3 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 @450e0000 (indirect, esz 8, psz 64K, shr 1) machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @450f0000 (flat, esz 8, psz 64K, shr 1) machine # [ 0.000000] GICv3: using LPI property table @0x0000000045100000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000045110000 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.000050] arm-pv: using stolen time PV machine # [ 0.000619] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000841] Console: colour dummy device 80x25 machine # [ 0.000850] printk: legacy console [tty0] enabled machine # [ 0.001061] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.001069] pid_max: default: 32768 minimum: 301 machine # [ 0.001169] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima machine # [ 0.001374] landlock: Up and running. machine # [ 0.001378] Yama: becoming mindful. machine # [ 0.002000] LSM support for eBPF active machine # [ 0.002147] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.002172] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.004386] rcu: Hierarchical SRCU implementation. machine # [ 0.004394] rcu: Max phase no-delay instances is 1000. machine # [ 0.005880] fsl-mc MSI: its@8080000 domain created machine # [ 0.006008] EFI services will not be available. machine # [ 0.006094] smp: Bringing up secondary CPUs ... machine # [ 0.006106] smp: Brought up 1 node, 1 CPU machine # [ 0.006109] SMP: Total of 1 processors activated. machine # [ 0.006112] CPU: All CPU(s) started at EL1 machine # [ 0.006126] CPU features: detected: Branch Target Identification machine # [ 0.006130] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.006133] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.006137] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.006145] CPU features: detected: Common not Private translations machine # [ 0.006149] CPU features: detected: CRC32 instructions machine # [ 0.006152] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.006155] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.006158] CPU features: detected: Data independent timing control (DIT) machine # [ 0.006161] CPU features: detected: E0PD machine # [ 0.006164] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.006167] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.006170] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.006174] CPU features: detected: Fine Grained Traps machine # [ 0.006177] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.006182] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.006185] CPU features: detected: LSE atomic instructions machine # [ 0.006188] CPU features: detected: Privileged Access Never machine # [ 0.006190] CPU features: detected: PMUv3 machine # [ 0.006193] CPU features: detected: RAS Extension Support machine # [ 0.006196] CPU features: detected: RASv1p1 Extension Support machine # [ 0.006198] CPU features: detected: Random Number Generator machine # [ 0.006204] CPU features: detected: Speculation barrier (SB) machine # [ 0.006207] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.006210] CPU features: detected: TLB range maintenance instructions machine # [ 0.006215] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.006259] alternatives: applying system-wide alternatives machine # [ 0.009561] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.009809] Memory: 886692K/1048576K available (24640K kernel code, 10246K rwdata, 26664K rodata, 7808K init, 2086K bss, 120600K reserved, 32768K cma-reserved) machine # [ 0.010206] devtmpfs: initialized machine # [ 0.012178] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.012204] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.012404] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.012409] 0 pages in range for non-PLT usage machine # [ 0.012410] 506368 pages in range for PLT usage machine # [ 0.012568] pinctrl core: initialized pinctrl subsystem machine # [ 0.013745] DMI not present or invalid. machine # [ 0.017605] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.020088] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.020237] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.020409] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.020441] audit: initializing netlink subsys (disabled) machine # [ 0.021322] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.021325] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.021329] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.021332] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.021335] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.021364] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 machine # [ 0.021376] cpuidle: using governor ladder machine # [ 0.021383] cpuidle: using governor menu machine # [ 0.021586] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.021625] ASID allocator initialised with 65536 entries machine # [ 0.023306] Serial: AMBA PL011 UART driver machine # [ 0.029571] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.029796] printk: console [ttyAMA0] enabled machine # [ 0.162826] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.162840] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.162843] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.162846] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.162849] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.162851] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.162854] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.162857] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.164286] fbcon: Taking over console machine # [ 0.164298] ACPI: Interpreter disabled. machine # [ 0.174305] iommu: Default domain type: Translated machine # [ 0.174313] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.182880] SCSI subsystem initialized machine # [ 0.183144] usbcore: registered new interface driver usbfs machine # [ 0.183176] usbcore: registered new interface driver hub machine # [ 0.183191] usbcore: registered new device driver usb machine # [ 0.183523] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.183528] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.183535] PTP clock support registered machine # [ 0.183577] EDAC MC: Ver: 3.0.0 machine # [ 0.183759] scmi_core: SCMI protocol bus registered machine # [ 0.184149] FPGA manager framework machine # [ 0.184728] vgaarb: loaded machine # [ 0.185042] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.196248] VFS: Disk quotas dquot_6.6.0 machine # [ 0.196284] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.198790] netfs: FS-Cache loaded machine # [ 0.198921] pnp: PnP ACPI: disabled machine # [ 0.205233] NET: Registered PF_INET protocol family machine # [ 0.205409] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.240383] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.240435] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.240461] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.240512] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.240586] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.240683] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.240782] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.240834] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.240917] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.241016] NET: Registered PF_XDP protocol family machine # [ 0.241038] PCI: CLS 0 bytes, default 64 machine # [ 0.251164] Trying to unpack rootfs image as initramfs... machine # [ 0.261106] kvm [1]: HYP mode not available machine # [ 0.453727] Initialise system trusted keyrings machine # [ 0.453773] Key type blacklist registered machine # [ 0.453915] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.454321] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.454384] 9p: Installing v9fs 9p2000 file system support machine # [ 0.454504] integrity: Platform Keyring initialized machine # [ 0.454513] integrity: Machine keyring initialized machine # [ 0.486587] Key type asymmetric registered machine # [ 0.486606] Asymmetric key parser 'x509' registered machine # [ 0.486707] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.486890] io scheduler mq-deadline registered machine # [ 0.486895] io scheduler kyber registered machine # [ 0.499607] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.500278] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.500687] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.500703] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.500730] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.500738] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.500884] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.500908] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.500991] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.500999] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.501004] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.501007] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.501010] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.521521] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.522074] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.522267] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.522281] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.522307] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.522319] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.522792] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.522983] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.522996] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.523023] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.523517] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.523709] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.523722] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.523748] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.524222] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.524409] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.524421] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.524447] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.524459] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.524953] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.542925] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.542956] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.543524] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.543718] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.543744] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.544145] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.544330] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.544590] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.544800] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.544826] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.554432] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.554629] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.554656] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.555124] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.555317] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.555344] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.555823] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.556092] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.556108] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.556135] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.556608] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.556889] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.556902] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.556929] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.577764] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.577782] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.577786] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.577845] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.577892] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.577939] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.577985] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.578038] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.578085] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.578132] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.578178] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.578225] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.578368] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.578414] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.578432] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.578450] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.578469] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.578487] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.578506] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.578526] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.578546] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.578565] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.578583] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.578602] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.578621] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.578640] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.578658] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.578676] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned machine # [ 0.578697] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned machine # [ 0.578716] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.578735] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.578759] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.578765] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.578768] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.579654] pci 0000:00:07.0: enabling device (0000 -> 0002) machine # [ 0.634027] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.636169] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.646788] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.649019] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.658755] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002) machine # [ 0.669230] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002) machine # [ 0.671671] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.681777] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.683943] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.687954] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.698744] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.710372] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.712605] msm_serial: driver initialized machine # [ 0.712783] SuperH (H)SCI(F) driver initialized machine # [ 0.712847] STM32 USART driver initialized machine # [ 0.751208] loop: module loaded machine # [ 0.751429] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 0.752368] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.765981] megasas: 07.734.00.00-rc1 machine # [ 0.766839] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.770802] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.770825] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.772969] Using buffer write method machine # [ 0.773023] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.778813] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.778838] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.780550] Using buffer write method machine # [ 0.780574] Concatenating MTD devices: machine # [ 0.780576] (0): "0.flash" machine # [ 0.780579] (1): "0.flash" machine # [ 0.780581] into device "0.flash" machine # [ 1.105334] Freeing initrd memory: 26060K machine # [ 1.111748] tun: Universal TUN/TAP device driver, 1.6 machine # [ 1.116569] thunder_xcv, ver 1.0 machine # [ 1.116636] thunder_bgx, ver 1.0 machine # [ 1.116657] nicpf, ver 1.0 machine # [ 1.118812] e1000: Intel(R) PRO/1000 Network Driver machine # [ 1.118818] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 1.118841] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 1.118851] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 1.118882] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 1.118886] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 1.118907] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 1.118912] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 1.119053] sky2: driver version 1.30 machine # [ 1.121016] usbcore: registered new interface driver usb-storage machine # [ 1.121806] ehci-pci 0000:00:07.0: EHCI Host Controller machine # [ 1.121830] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1 machine # [ 1.122076] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000 machine # [ 1.132181] usbcore: registered new interface driver usbserial_generic machine # [ 1.132208] usbserial: USB Serial support registered for generic machine # [ 1.133096] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00 machine # [ 1.133487] hub 1-0:1.0: USB hub found machine # [ 1.133504] hub 1-0:1.0: 6 ports detected machine # [ 1.137760] hv_vmbus: registering driver hyperv_keyboard machine # [ 1.138834] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 1.138868] rtc-pl031 9010000.pl031: setting system clock to 2026-10-24T03:02:02 UTC (1792810922) machine # [ 1.139211] i2c_dev: i2c /dev entries driver machine # [ 1.146156] sdhci: Secure Digital Host Controller Interface driver machine # [ 1.146164] sdhci: Copyright(c) Pierre Ossman machine # [ 1.146475] Synopsys Designware Multimedia Card Interface Driver machine # [ 1.146913] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 1.148690] hid: raw HID events driver (C) Jiri Kosina machine # [ 1.152769] usbcore: registered new interface driver usbhid machine # [ 1.152776] usbhid: USB HID core driver machine # [ 1.155398] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 1.158741] drop_monitor: Initializing network drop monitor service machine # [ 1.158914] NET: Registered PF_INET6 protocol family machine # [ 1.159531] Segment Routing with IPv6 machine # [ 1.159545] In-situ OAM (IOAM) with IPv6 machine # [ 1.159576] NET: Registered PF_PACKET protocol family machine # [ 1.159636] 9pnet: Installing 9P2000 support machine # [ 1.159686] Key type dns_resolver registered machine # [ 1.171021] registered taskstats version 1 machine # [ 1.171200] Loading compiled-in X.509 certificates machine # [ 1.180939] Demotion targets for Node 0: null machine # [ 1.181124] Key type .fscrypt registered machine # [ 1.181127] Key type fscrypt-provisioning registered machine # [ 1.181238] ima: No TPM chip found, activating TPM-bypass! machine # [ 1.181265] ima: Allocated hash algorithm: sha1 machine # [ 1.181292] ima: No architecture policies found machine # [ 1.185879] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 1.211038] clk: Disabling unused clocks machine # [ 1.211063] PM: genpd: Disabling unused power domains machine # [ 1.217263] Freeing unused kernel memory: 7808K machine # [ 1.217483] Run /init as init process machine # [ 1.236650] fuse: module verification failed: signature and/or required key missing - tainting kernel machine # [ 1.241584] fuse: init (API version 7.45) machine # [ 1.244873] virtiofs virtio6: discovered new tag: nix-store machine # [ 1.247103] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 1.262810] virtiofs virtio7: discovered new tag: shared machine # [ 1.263698] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 1.267289] virtiofs virtio8: discovered new tag: xchg machine # [ 1.268064] virtiofs virtio8: virtio_fs_setup_dax: No cache capability machine # [ 1.280252] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.280937] systemd[1]: systemd 263-0f0682b 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.280953] systemd[1]: Detected virtualization qemu. machine # [ 1.280975] systemd[1]: Detected architecture arm64. machine # [ 1.280982] systemd[1]: Running in initrd. machine # [ 1.281397] systemd[1]: Initializing machine ID from random generator. machine # [ 1.281500] systemd[1]: Hostname set to . machine # [ 1.381136] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.395131] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.463416] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.468331] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.468532] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.468563] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.468591] systemd[1]: Reached target Path Units. machine # [ 1.468609] systemd[1]: Reached target Slice Units. machine # [ 1.468628] systemd[1]: Reached target Swaps. machine # [ 1.468644] systemd[1]: Reached target Timer Units. machine # [ 1.468919] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.475205] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.475368] systemd[1]: Listening on Journal Sockets. machine # [ 1.475454] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.475663] systemd[1]: Listening on udev Varlink Socket. machine # [ 1.475685] systemd[1]: Reached target Socket Units. machine # [ 1.481194] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.481317] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.489270] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.500571] systemd[1]: Starting Journal Service... machine # [ 1.526639] systemd[1]: Starting Load Kernel Modules... machine # [ 1.526862] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.533008] 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.549318] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.552980] systemd-journald[71]: Collecting audit messages is disabled. machine # [ 1.562070] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.590274] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.591069] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.623489] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.623952] 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.651133] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.655271] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.663442] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0 machine # [ 1.663701] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.663708] [drm] features: -context_init machine # [ 1.664524] [drm] number of scanouts: 1 machine # [ 1.664540] [drm] number of cap sets: 0 machine # [ 1.668698] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.690217] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic machine # [ 1.690235] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0 machine # [ 1.721396] Console: switching to colour frame buffer device 160x50 machine # [ 1.741152] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.743195] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.748360] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.751386] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.751560] systemd[1]: Reached target Local File Systems. machine # [ 1.737218] systemd-modules-load[72]: Inserted module 'dm_mod' machine # [ 1.741945] systemd-modules-load[72]: Module 'virtio_balloon' is built in machine # [ 1.764543] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.752713] systemd-modules-load[72]: Module 'virtio_console' is built in machine # [ 1.756435] systemd-modules-load[72]: Inserted module 'virtio_gpu' machine # [ 1.757620] systemd-modules-load[72]: Module 'virtio_rng' is built in machine # [ 1.781305] systemd[1]: Started Journal Service. machine # [ 1.765644] systemd[1]: Finished Load Kernel Modules. machine # [ 1.792351] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.809073] systemd[1]: Starting Create System Files and Directories... machine # [ 1.879524] systemd-udevd[78]: Using default interface naming scheme 'v261'. machine # [ 1.883850] systemd[1]: Finished Create System Files and Directories. machine # [ 1.889168] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.920373] 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.920715] 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.930819] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 2.061390] systemd[1]: Starting Virtual Console Setup... machine # [ 2.150470] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.156427] systemd[1]: Finished Virtual Console Setup. machine # [ 2.864388] (udev-worker)[95]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.907212] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.910722] systemd[1]: Reached target System Initialization. machine # [ 2.916341] systemd[1]: Reached target Basic System. machine # [ 2.920507] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.922766] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.943884] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.945177] systemd[1]: Reached target Initrd Root Device. machine # [ 2.948775] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 3.008577] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 3.016133] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 3.022532] systemd[1]: Mounting /sysroot... machine # [ 3.185587] EXT4-fs (vda): mounted filesystem 6ff05407-beb8-494f-9c00-4acd98bcf827 r/w with ordered data mode. Quota mode: none. machine # [ 3.171774] systemd[1]: Mounted /sysroot. machine # [ 3.173763] systemd[1]: Reached target Initrd Root File System. machine # [ 3.184222] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 3.215075] systemd-sysroot-fstab-check[119]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 3.222551] systemd[1]: Reload requested from client PID 119 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 3.228410] systemd[1]: Reloading... machine # [ 3.460811] systemd[1]: Reloading finished in 233 ms. machine # [ 3.497929] systemd-sysroot-fstab-check[119]: Requesting initrd-fs.target/start/replace... machine # [ 3.503032] systemd-sysroot-fstab-check[119]: Requesting swap.target/start/replace... machine # [ 3.512162] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.515131] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.518279] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.536174] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.548539] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.571988] systemd[1]: Mounting /sysroot/run... machine # [ 3.584436] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.622104] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.686554] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.696600] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.699142] systemd[1]: Mounted /sysroot/run. machine # [ 3.715182] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.719911] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.732619] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.768902] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.770756] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.449737] (udev-worker)[94]: mtd0ro: Failed to find and pin callout binary "/nix/store/2g8v5yf619hqwad8g5jcynn5sz166dvl-systemd-263-0f0682b/lib/udev/mtd_probe": No such file or directory machine # [ 4.453633] (udev-worker)[94]: 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.488706] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.491391] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.496430] systemd[1]: Stopping Virtual Console Setup... machine # [ 4.497357] systemd[1]: Starting Virtual Console Setup... machine # [ 4.528817] systemd-vconsole-setup[151]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 4.534747] systemd[1]: Mounting /sysroot/nix/store... machine # [ 4.540952] systemd[1]: Finished Virtual Console Setup. machine # [ 4.542978] systemd[1]: sysroot-run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. machine # [ 4.577653] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.580261] systemd[1]: Reached target Initrd File Systems. machine # [ 4.584198] systemd[1]: Starting Find NixOS closure... machine # [ 4.592385] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.631344] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.637239] systemd[1]: Finished Find NixOS closure. machine # [ 4.639981] systemd[1]: Reached target Initrd Default Target. machine # [ 4.641739] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.671631] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.677283] systemd[1]: Stopped target Basic System. machine # [ 4.678303] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.679914] systemd[1]: Stopped target Path Units. machine # [ 4.683329] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.686428] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.692319] systemd[1]: Stopped target Slice Units. machine # [ 4.693343] systemd[1]: Stopped target Socket Units. machine # [ 4.694148] systemd[1]: Stopped target System Initialization. machine # [ 4.696098] systemd[1]: Stopped target Swaps. machine # [ 4.697627] systemd[1]: Stopped target Timer Units. machine # [ 4.699449] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.705743] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.710142] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.718043] systemd[1]: Stopped Find NixOS closure. machine # [ 4.720552] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.728422] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.736475] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.737773] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.742111] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.744170] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.748462] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.754277] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.759215] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.764426] systemd[1]: Stopped target Local File Systems. machine # [ 4.765327] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.766326] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.767376] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.770725] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.775272] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.776933] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.778105] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.779128] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.780447] systemd[1]: systemd-udevd.service: Consumed 1.541s CPU time over 2.998s wall clock time, 25.4M memory peak. machine # [ 4.781921] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.782901] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.783979] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully. machine # [ 4.790456] systemd[1]: Closed udev Varlink Socket. machine # [ 4.792634] systemd[1]: Starting Cleanup udev Database... machine # [ 4.796668] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.798186] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.800238] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.804193] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.808166] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.809256] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.810179] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.812292] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.846072] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.851469] systemd[1]: Finished Cleanup udev Database. machine # [ 4.853052] systemd[1]: Reached target Switch Root. machine # [ 4.856702] systemd[1]: Starting NixOS Activation... machine # [ 4.955125] initrd-nixos-activation-start[174]: booting system configuration /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test machine # [ 4.994858] initrd-nixos-activation-start[174]: running activation script... machine # [ 5.323512] initrd-nixos-activation-start[197]: setting up /etc... machine # [ 5.471110] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 5.474939] systemd[1]: Finished NixOS Activation. machine # [ 5.476521] systemd[1]: Starting Switch Root... machine # [ 5.504443] systemd[1]: Switching root. machine # [ 5.696014] systemd-journald[71]: Received SIGTERM from PID 1 (systemd). machine # [ 5.801577] NET: Registered PF_VSOCK protocol family machine # [ 5.885133] systemd[1]: systemd 263-0f0682b 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.886122] systemd[1]: Detected virtualization qemu. machine # [ 5.887056] systemd[1]: Detected architecture arm64. machine # [ 5.887141] systemd[1]: Detected first boot. machine # [ 5.888832] systemd[1]: Initializing machine ID from random generator. machine # [ 6.115549] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 6.388902] systemd[1]: Applying preset policy. machine # [ 6.648761] systemd[1]: Populated /etc with preset unit settings. machine # [ 6.906798] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 6.907450] systemd[1]: Stopped initrd-switch-root.service. machine # [ 6.913724] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 6.916980] systemd[1]: Created slice Slice /system/getty. machine # [ 6.922298] systemd[1]: Created slice User and Session Slice. machine # [ 6.923127] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 6.924101] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 6.925011] systemd[1]: Expecting device /dev/hvc0... machine # [ 6.930270] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 6.930888] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 6.931766] systemd[1]: Stopped target initrd-fs.target. machine # [ 6.932485] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 6.937019] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 6.939496] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 6.940037] systemd[1]: Reached target Path Units. machine # [ 6.943388] systemd[1]: Reached target Remote File Systems. machine # [ 6.943929] systemd[1]: Reached target Slice Units. machine # [ 6.947203] systemd[1]: Reached target Swaps. machine # [ 6.950295] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 6.954490] systemd[1]: Listening on Process Core Dump Socket. machine # [ 6.956111] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 6.963772] systemd[1]: Listening on Factory Reset Management. machine # [ 6.964503] systemd[1]: Listening on Hostname Service Socket. machine # [ 6.971456] systemd[1]: Starting Journal Log Access Socket... machine # [ 6.974586] systemd[1]: Listening on Journal Audit Socket. machine # [ 6.979326] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 6.982494] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 6.983985] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.987701] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 6.994085] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 6.994909] systemd[1]: Listening on udev Varlink Socket. machine # [ 7.000466] systemd[1]: Mounting Huge Pages File System... machine # [ 7.008103] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 7.022268] systemd[1]: Mounting Kernel Debug File System... machine # [ 7.038384] systemd[1]: Mounting Kernel Trace File System... machine # [ 7.060300] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 7.071450] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 7.090476] systemd[1]: Mounting Kernel Configuration File System... machine # [ 7.097489] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 7.098215] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 7.109304] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 7.142961] systemd[1]: Mounting FUSE Control File System... machine # [ 7.143526] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 7.184534] systemd[1]: Starting Journal Service... machine # [ 7.213537] systemd[1]: Starting Load Kernel Modules... machine # [ 7.244492] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 7.276414] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 7.291743] systemd-journald[268]: Collecting audit messages is enabled. machine # [ 7.279369] systemd[1]: Queued start job for default target Multi-User System. machine # [ 7.302026] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.286192] systemd[1]: Unnecessary job was removed for /sys/devices/platform/9000000.pl011/9000000.pl011:0/9000000.pl011:0.0/tty/ttyAMA0. machine # [ 7.292695] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0. machine # [ 7.294140] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 7.340994] systemd[1]: Starting Coldplug All udev Devices... machine # [ 7.327739] systemd-modules-load[269]: Module 'atkbd' is built in machine # [ 7.333140] systemd-modules-load[269]: Module 'loop' is built in machine # [ 7.360835] systemd[1]: Started Journal Service. machine # [ 7.364680] systemd[1]: Listening on Journal Log Access Socket. machine # [ 7.373611] systemd[1]: Mounted Huge Pages File System. machine # [ 7.374734] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 7.375783] systemd[1]: Mounted Kernel Debug File System. machine # [ 7.387729] systemd[1]: Mounted Kernel Trace File System. machine # [ 7.392592] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 7.393680] systemd[1]: Mounted Kernel Configuration File System. machine # [ 7.394635] systemd[1]: Finished Load Kernel Modules. machine # [ 7.418824] EXT4-fs (vda): re-mounted 6ff05407-beb8-494f-9c00-4acd98bcf827. machine # [ 7.424468] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 7.429649] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 7.444174] systemd[1]: Starting Firewall... machine # [ 7.460175] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 7.463914] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 7.478359] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 7.502425] systemd[1]: Starting Apply Kernel Variables... machine # [ 7.520565] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 7.521909] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.523294] systemd[1]: Mounted FUSE Control File System. machine # [ 7.540578] systemd-oomd[271]: No swap; memory pressure usage will be degraded machine # [ 7.560271] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 7.675725] systemd-journald[268]: Received client request to flush runtime journal. machine # [ 7.753095] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 7.754226] systemd[1]: Reached target First Boot Complete. machine # [ 7.773123] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 7.775921] systemd[1]: Finished Apply Kernel Variables. machine # [ 7.869481] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 7.879961] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 8.030945] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 8.035690] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 8.046374] systemd[1]: Mounting /run/wrappers... machine # [ 8.049757] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 8.150230] systemd[1]: Mounted /run/wrappers. machine # [ 8.151161] systemd[1]: Reached target Local File Systems. machine # [ 8.159183] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 8.177492] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 8.178576] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 8.189231] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 8.208087] systemd[1]: Starting Create System Files and Directories... machine # [ 8.238974] systemd-udevd[310]: Using default interface naming scheme 'v261'. machine # [ 8.477283] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 8.513283] systemd[1]: Finished Create System Files and Directories. machine # [ 8.533873] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 8.547460] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 8.677756] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 8.743831] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 8.782093] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 8.797556] systemd[1]: Starting Update is Completed... machine # [ 8.884888] systemd[1]: Finished Update is Completed. machine # [ 8.894765] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 9.113753] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 9.194470] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 9.384290] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 9.392711] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 9.598436] systemd[1]: Finished Coldplug All udev Devices. machine # [ 9.603402] systemd[1]: Reached target System Initialization. machine # [ 9.607480] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 9.614391] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 9.615467] systemd[1]: Reached target Timer Units. machine # [ 9.622808] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 9.626443] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 9.636360] systemd[1]: Reached target Socket Units. machine # [ 9.637395] systemd[1]: Reached target Basic System. machine # [ 9.638232] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 9.639378] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 9.648683] systemd[1]: Starting Post-Boot Actions... machine # [ 9.696436] systemd[1]: Started Reset console on configuration changes. machine # [ 9.706775] systemd[1]: Starting resolvconf update... machine # [ 9.741324] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 9.848114] systemd[1]: Starting D-Bus System Message Bus... machine # [ 9.887093] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 9.894451] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 9.895522] systemd[1]: Reached target User and Group Name Lookups. machine # [ 9.946133] nsncd[429]: Oct 24 03:02:11.327 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 9.972930] systemd[1]: Starting User Login Management... machine # [ 9.989407] systemd[1]: Finished Post-Boot Actions. machine # [ 10.008395] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 10.059688] systemd[1]: Started backdoor.service. machine # [ 10.089098] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 10.193660] dbus-broker-launch[439]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 10.207313] dbus-broker-launch[439]: NSS returned no entry for 'systemd-timesync' machine # [ 10.215944] dbus-broker-launch[439]: Invalid user-name in /nix/store/x7v4an52090izyd15zqx0yaxdwfad8hl-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 10.262841] (udev-worker)[407]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 10.281913] (udev-worker)[407]: Network interface NamePolicy= disabled on kernel command line. machine # [ 10.283252] systemd[1]: Started D-Bus System Message Bus. machine # connecting to host... machine # [ 10.297698] (udev-worker)[396]: Network interface NamePolicy= disabled on kernel command line. machine # [ 10.344903] systemd-logind[453]: New seat seat0. machine # [ 10.364152] dbus-broker-launch[439]: Ready machine # [ 10.364972] systemd[1]: Started User Login Management. machine # [ 10.375953] systemd[1]: Starting linger-users.service... machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 10.95 seconds) machine: (finished: waiting for the VM to finish booting, in 11.47 seconds) machine # [ 10.498726] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 10.499917] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 10.513687] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 10.521837] systemd[1]: Stopping User and Group Name Lookups... machine # [ 10.522848] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 10.523929] systemd[1]: nscd.service: Deactivated successfully. machine # [ 10.540340] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 10.586275] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 10.725838] nsncd[537]: Oct 24 03:02:12.105 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 10.766192] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 10.775136] systemd[1]: Finished resolvconf update. machine # [ 10.870902] systemd[1]: Created slice Slice /user/1001. machine # [ 10.906995] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 10.936725] systemd[1]: Reached target User and Group Name Lookups. machine # [ 10.937833] systemd[1]: Starting DHCP Client... machine # [ 10.991126] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 11.011130] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 11.028536] systemd[1]: Finished linger-users.service. machine # [ 11.029440] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 11.030648] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 11.084310] systemd-logind[453]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # [ 11.125911] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 11.127094] systemd[1]: Starting User Manager for UID 1001... machine # [ 11.297059] (systemd)[584]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 11.313941] systemd[1]: Finished Firewall. machine # [ 11.314754] systemd[1]: Reached target Preparation for Network. machine # [ 11.321023] systemd[1]: Starting Address configuration of eth1... machine # [ 11.340392] systemd[1]: Starting Extra networking commands.... machine # [ 11.341499] systemd-logind[453]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 11.369586] mousedev: PS/2 mouse device common for all mice machine # [ 11.397974] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 11.765872] systemd[584]: Queued start job for default target Main User Target. machine # [ 11.813776] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 11.815578] systemd[584]: Created slice User Application Slice. machine # [ 11.889922] systemd[584]: Started Daily Cleanup of User's Temporary Directories. machine # [ 11.931748] systemd[584]: Reached target Paths. machine # [ 11.947785] systemd[584]: Reached target Timers. machine # [ 11.957746] systemd[584]: Starting D-Bus User Message Bus Socket... machine # [ 11.976954] systemd[584]: Starting Create User Files and Directories... machine # [ 11.978173] systemd[584]: Finished Create User Files and Directories. machine # [ 11.979173] systemd[584]: Listening on D-Bus User Message Bus Socket. machine # [ 11.998843] systemd[584]: Reached target Sockets. machine # [ 12.010439] network-addresses-eth1-start[591]: adding address 192.168.1.1/24... done machine # [ 12.015318] systemd[584]: Reached target Basic System. machine # [ 12.025271] systemd[1]: Started User Manager for UID 1001. machine # [ 12.026274] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 12.027563] systemd-logind[453]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 12.046299] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 12.047436] network-addresses-eth1-start[591]: adding address 2001:db8:1::1/64... done machine # [ 12.059878] systemd[584]: Reached target Main User Target. machine # [ 12.063932] dhcpcd[599]: dhcpcd-10.3.2 starting machine # [ 12.076548] systemd[584]: Startup finished in 616ms. machine # [ 12.077887] dhcpcd[640]: dev: loaded udev machine # [ 12.092216] systemd[1]: Finished Address configuration of eth1. machine # [ 12.143668] 8021q: 802.1Q VLAN Support v1.8 machine # [ 12.144061] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 12.272805] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 12.282219] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 12.282730] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 12.284878] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 12.285290] cfg80211: failed to load regulatory.db machine # [ 12.585518] dhcpcd[676]: /nix/store/48w99jvsb41hnyml943xqzrklzdb5fww-openresolv-3.17.4/sbin/.resolvconf-wrapped: line 1250: kill: (602) - Operation not permitted machine # [ 12.587583] dhcpcd[676]: .resolvconf-wrapped: clearing stale lock pid 602 machine # [ 12.749905] systemd[1]: Finished Extra networking commands.. machine # [ 12.750875] systemd[1]: Reached target Network. machine # [ 12.772269] systemd[1]: Starting Permit User Sessions... machine # [ 12.854407] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 12.846256] dhcpcd[640]: eth0: waiting for carrier machine # [ 12.847189] dhcpcd[640]: eth0: carrier acquired machine # [ 12.955235] dhcpcd[640]: DUID 00:01:00:01:32:6e:dc:36:52:54:00:12:34:56 machine # [ 12.969275] dhcpcd[640]: eth0: IAID 00:12:34:56 machine # [ 12.970070] dhcpcd[640]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 13.047083] systemd[1]: Finished Permit User Sessions. machine # [ 13.065292] systemd[1]: Started Getty on tty1. machine # [ 13.066141] systemd[1]: Reached target Login Prompts. machine # [ 13.092569] dhcpcd[640]: eth0: soliciting a DHCP lease machine # [ 13.109633] dhcpcd[640]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 13.110655] dhcpcd[640]: eth0: probing address 10.0.2.15/24 machine # [ 13.318273] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3 machine # [ 13.685486] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 13.738086] systemd[1]: Starting Virtual Console Setup... machine # [ 13.790732] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 13.802627] systemd[1]: Stopped Virtual Console Setup. machine # [ 13.803917] systemd-logind[453]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 13.816470] systemd[1]: Starting Virtual Console Setup... machine # [ 13.976823] systemd-vconsole-setup[712]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 13.983152] systemd[1]: Finished Virtual Console Setup. machine # [ 15.202674] dhcpcd[640]: eth0: soliciting an IPv6 router machine # [ 15.204298] dhcpcd[640]: eth0: Router Advertisement from fe80::2 machine # [ 15.205822] dhcpcd[640]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 15.207345] dhcpcd[640]: eth0: adding route to fec0::/64 machine # [ 15.208701] dhcpcd[640]: eth0: adding default route via fe80::2 machine # [ 17.570963] dhcpcd[640]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 17.573036] dhcpcd[640]: eth0: adding route to 10.0.2.0/24 machine # [ 17.574492] dhcpcd[640]: eth0: adding default route via 10.0.2.2 machine # [ 17.695307] systemd[1]: Started DHCP Client. machine # [ 17.697448] systemd[1]: Reached target Multi-User System. machine # [ 17.703793] systemd[1]: Startup finished in 1.202s (kernel) + 4.554s (initrd) + 11.941s (userspace) = 17.698s. machine: (finished: waiting for unit multi-user.target, in 19.24 seconds) machine: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 18.433367] nixos[816]: switching to system configuration /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test machine # [ 18.436324] systemd[1]: Stopped target Local File Systems. machine # activating the configuration... machine # [ 18.439739] systemd[1]: Stopped target Remote File Systems. machine # setting up /etc... machine # [ 18.798064] systemd[1]: Reload requested from client PID 816 ('.switch-to-conf') (unit backdoor.service)... machine # [ 18.800590] systemd[1]: Reloading... machine # [ 19.210916] systemd[1]: Reloading finished in 408 ms. machine # reloading user units for usertest... machine # [ 19.275578] systemd[584]: Created slice User Core Session Slice. machine # [ 19.279001] systemd[584]: Starting D-Bus User Message Bus... machine # [ 19.340206] dbus-broker-launch[886]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/x7v4an52090izyd15zqx0yaxdwfad8hl-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 19.343579] dbus-broker-launch[886]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/x7v4an52090izyd15zqx0yaxdwfad8hl-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 19.347011] dbus-broker-launch[886]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/x7v4an52090izyd15zqx0yaxdwfad8hl-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 19.350517] dbus-broker-launch[886]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/x7v4an52090izyd15zqx0yaxdwfad8hl-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 19.357732] systemd[584]: Started D-Bus User Message Bus. machine # [ 19.358737] dbus-broker-launch[886]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 19.364253] dbus-broker-launch[886]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 19.366177] dbus-broker-launch[886]: Ready machine # [ 19.412115] systemd[584]: Reexecution requested from client PID 885 ('switch-to-confi')... machine # [ 19.416084] systemd[584]: Reexecuting. machine # [ 19.480654] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.609264] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.616796] systemd[584]: Reload requested from client PID 885 ('switch-to-confi')... machine # [ 19.621174] systemd[584]: Reloading... machine # [ 19.742033] systemd[584]: Reloading finished in 121 ms. machine # [ 19.764484] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 19.776720] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 19.779703] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 19.782623] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 19.817556] systemd[584]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 19.832563] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 19.932447] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 19.933888] systemd[1]: Reached target Reactivate sysinit units. machine # [ 19.938382] systemd[1]: Reached target Local File Systems. machine # [ 19.941885] systemd[1]: Reached target Remote File Systems. machine # [ 19.947821] systemd[1]: Starting linger-users.service... machine # [ 19.953515] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 19.965621] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 19.966668] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 19.976429] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 19.978883] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 19.987454] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.994421] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.995892] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.999473] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 20.057238] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 20.063984] systemd[1]: Finished linger-users.service. machine # [ 20.241765] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 20.243790] systemd[1]: Finished Create SUID/SGID Wrappers. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 20.504403] nixos[816]: finished switching to system configuration /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test machine: (finished: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/bin/switch-to-configuration test, in 2.34 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.03 seconds) machine: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/wqxxapckxn04jf828s6fyvvjv9jgl6l2-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/wqxxapckxn04jf828s6fyvvjv9jgl6l2-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 20.791253] nixos[964]: switching to system configuration /nix/store/wqxxapckxn04jf828s6fyvvjv9jgl6l2-nixos-system-other-test machine # [ 20.793957] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # [ 20.797239] systemd[1]: Stopped target Local File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 21.122568] systemd[1]: Reload requested from client PID 964 ('.switch-to-conf') (unit backdoor.service)... machine # [ 21.125181] systemd[1]: Reloading... machine # [ 21.528146] systemd[1]: Reloading finished in 401 ms. machine # reloading user units for usertest... machine # [ 21.636533] systemd[584]: Reexecution requested from client PID 1035 ('switch-to-confi')... machine # [ 21.639594] systemd[584]: Reexecuting. machine # [ 21.696184] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.821303] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.828839] systemd[584]: Reload requested from client PID 1035 ('switch-to-confi')... machine # [ 21.833182] systemd[584]: Reloading... machine # [ 21.948599] systemd[584]: Reloading finished in 116 ms. machine # [ 21.964202] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 21.975154] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 21.977929] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 21.980722] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 22.015074] systemd[584]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 22.020486] systemd[1]: Stopped target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service machine # [ 22.024512] systemd[1]: Stopping Reactivate sysinit units... machine # [ 22.025454] systemd[1]: Reached target Reactivate sysinit units. machine # [ 22.028257] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 22.029723] dbus-broker-launch[439]: Caught SIGHUP, trigger reload. machine # [ 22.036329] dbus-broker-launch[439]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 22.038737] dbus-broker-launch[439]: NSS returned no entry for 'systemd-timesync' machine # [ 22.039908] dbus-broker-launch[439]: Invalid user-name in /nix/store/hasd3fxws02hfy6rgqazqgyh3wkrlfjk-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 22.066491] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 22.074648] systemd[1]: Stopping Address configuration of eth1... machine # [ 22.109087] network-addresses-eth1-pre-stop[1047]: deleting address 192.168.1.1/24... done machine # [ 22.116299] network-addresses-eth1-pre-stop[1047]: deleting address 2001:db8:1::1/64... done machine # [ 22.124001] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 22.128505] systemd[1]: Stopped Address configuration of eth1. machine # [ 22.131597] systemd[1]: Starting Address configuration of eth1... machine # [ 22.177802] network-addresses-eth1-start[1052]: adding address 192.168.1.2/24... done machine # [ 22.185413] network-addresses-eth1-start[1052]: adding address 2001:db8:1::2/64... done machine # [ 22.196163] systemd[1]: Finished Address configuration of eth1. machine # [ 22.204790] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.208409] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 22.212490] systemd[1]: Reached target Remote File Systems. machine # [ 22.215859] systemd[1]: Starting linger-users.service... machine # [ 22.221216] systemd[1]: Reached target Local File Systems. machine # [ 22.228595] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 22.233643] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 22.234650] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 22.235956] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 22.254064] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 22.255843] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.265346] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.316526] linger-users-start[1066]: id: ‘usertest’: no such user machine # [ 22.322168] linger-users-start[1063]: Removing linger for missing user usertest machine # [ 22.337294] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 22.342580] systemd[1]: Finished linger-users.service. machine # [ 22.539371] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 22.543252] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 22.797598] nixos[964]: finished switching to system configuration /nix/store/wqxxapckxn04jf828s6fyvvjv9jgl6l2-nixos-system-other-test machine: (finished: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/wqxxapckxn04jf828s6fyvvjv9jgl6l2-nixos-system-other-test/bin/switch-to-configuration test, in 2.26 seconds) subtest: services machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 23.028132] nixos[1131]: switching to system configuration /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test machine # [ 23.033097] systemd[1]: Stopped target Local File Systems. machine # [ 23.034722] systemd[1]: Stopped target Remote File Systems. machine # [ 23.344823] systemd[1]: Reload requested from client PID 1131 ('.switch-to-conf') (unit backdoor.service)... machine # [ 23.346949] systemd[1]: Reloading... machine # [ 23.720134] systemd[1]: Reloading finished in 371 ms. machine # [ 23.822005] systemd[584]: Reexecution requested from client PID 1200 ('switch-to-confi')... machine # [ 23.827114] systemd[584]: Reexecuting. machine # [ 23.888862] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.015697] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.023670] systemd[584]: Reload requested from client PID 1200 ('switch-to-confi')... machine # [ 24.028305] systemd[584]: Reloading... machine # [ 24.145420] systemd[584]: Reloading finished in 118 ms. machine # [ 24.161794] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.173728] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 24.176172] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 24.179440] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 24.215028] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 24.220202] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 24.225059] systemd[1]: Stopping Reactivate sysinit units... machine # [ 24.226097] systemd[1]: Reached target Reactivate sysinit units. machine # [ 24.227111] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 24.231835] dbus-broker-launch[439]: Caught SIGHUP, trigger reload. machine # [ 24.234973] dbus-broker-launch[439]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 24.237468] dbus-broker-launch[439]: NSS returned no entry for 'systemd-timesync' machine # [ 24.238742] dbus-broker-launch[439]: Invalid user-name in /nix/store/x7v4an52090izyd15zqx0yaxdwfad8hl-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 24.252983] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 24.259731] systemd[1]: Stopping Address configuration of eth1... machine # [ 24.295114] network-addresses-eth1-pre-stop[1212]: deleting address 192.168.1.2/24... done machine # [ 24.303083] network-addresses-eth1-pre-stop[1212]: deleting address 2001:db8:1::2/64... done machine # [ 24.311355] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 24.314567] systemd[1]: Stopped Address configuration of eth1. machine # [ 24.319808] systemd[1]: Starting Address configuration of eth1... machine # [ 24.371616] network-addresses-eth1-start[1217]: adding address 192.168.1.1/24... done machine # [ 24.380967] network-addresses-eth1-start[1217]: adding address 2001:db8:1::1/64... done machine # [ 24.392240] systemd[1]: Finished Address configuration of eth1. machine # [ 24.398256] systemd[1]: Reached target Remote File Systems. machine # [ 24.407047] systemd[1]: Starting linger-users.service... machine # [ 24.412412] systemd[1]: Reached target Local File Systems. machine # [ 24.418964] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.426292] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 24.427934] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 24.443297] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 24.445222] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 24.450226] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 24.455051] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 24.459324] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.464667] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.502421] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 24.506792] systemd[1]: Finished linger-users.service. machine # [ 24.677574] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 24.681177] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 24.938556] nixos[1131]: finished switching to system configuration /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.14 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 25.173094] nixos[1286]: switching to system configuration /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test machine # [ 25.176141] systemd[1]: Stopped target Local File Systems. machine # [ 25.179147] systemd[1]: Stopped target Remote File Systems. machine # [ 25.505626] systemd[1]: Reload requested from client PID 1286 ('.switch-to-conf') (unit backdoor.service)... machine # [ 25.507863] systemd[1]: Reloading... machine # [ 25.872130] systemd[1]: Reloading finished in 362 ms. machine # [ 25.989442] systemd[584]: Reexecution requested from client PID 1354 ('switch-to-confi')... machine # [ 25.993377] systemd[584]: Reexecuting. machine # [ 26.052853] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.174919] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.182639] systemd[584]: Reload requested from client PID 1354 ('switch-to-confi')... machine # [ 26.185557] systemd[584]: Reloading... machine # [ 26.305466] systemd[584]: Reloading finished in 118 ms. machine # [ 26.321851] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.333305] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 26.336227] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 26.338816] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 26.377650] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 26.382506] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 26.385220] systemd[1]: Stopping Reactivate sysinit units... machine # [ 26.386190] systemd[1]: Reached target Reactivate sysinit units. machine # [ 26.389074] systemd[1]: Reached target Remote File Systems. machine # [ 26.395082] systemd[1]: Starting linger-users.service... machine # [ 26.405425] systemd[1]: Reached target Local File Systems. machine # [ 26.406430] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 26.420310] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 26.421372] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 26.422677] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 26.439903] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 26.445785] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.450957] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.456536] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.458057] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 26.515862] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 26.519649] systemd[1]: Finished linger-users.service. machine # [ 26.672949] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 26.675911] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 26.932650] nixos[1286]: finished switching to system configuration /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.99 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 27.179829] nixos[1427]: switching to system configuration /nix/store/11l3gm5zxjs59rpvjicwjnpswv2adlml-nixos-system-machine-test machine # [ 27.185328] systemd[1]: Stopped target Local File Systems. machine # [ 27.186278] systemd[1]: Stopped target Remote File Systems. machine # [ 27.507084] systemd[1]: Reload requested from client PID 1427 ('.switch-to-conf') (unit backdoor.service)... machine # [ 27.509474] systemd[1]: Reloading... machine # [ 27.857727] systemd[1]: Reloading finished in 346 ms. machine # [ 27.945068] systemd[584]: Reexecution requested from client PID 1496 ('switch-to-confi')... machine # [ 27.948909] systemd[584]: Reexecuting. machine # [ 27.987195] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.099851] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.107067] systemd[584]: Reload requested from client PID 1496 ('switch-to-confi')... machine # [ 28.111265] systemd[584]: Reloading... machine # [ 28.221399] systemd[584]: Reloading finished in 111 ms. machine # [ 28.236216] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.247384] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 28.248732] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 28.251242] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 28.286024] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 28.290794] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 28.293879] systemd[1]: Stopping Reactivate sysinit units... machine # [ 28.294821] systemd[1]: Reached target Reactivate sysinit units. machine # [ 28.297153] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.306092] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 28.307642] systemd[1]: Reached target Remote File Systems. machine # [ 28.320718] systemd[1]: Starting linger-users.service... machine # [ 28.321603] systemd[1]: Starting test.service... machine # [ 28.322301] systemd[1]: Reached target Local File Systems. machine # [ 28.331661] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 28.344532] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 28.345490] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 28.346740] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 28.360488] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 28.362259] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.374992] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.401081] systemd[1]: Finished test.service. machine # [ 28.438259] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 28.441193] systemd[1]: Finished linger-users.service. machine # [ 28.581301] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 28.584247] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 28.842731] nixos[1427]: finished switching to system configuration /nix/store/11l3gm5zxjs59rpvjicwjnpswv2adlml-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.91 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 29.112236] nixos[1569]: switching to system configuration /nix/store/11l3gm5zxjs59rpvjicwjnpswv2adlml-nixos-system-machine-test machine # [ 29.117873] systemd[1]: Stopped target Remote File Systems. machine # [ 29.118804] systemd[1]: Stopped target Local File Systems. machine # [ 29.417517] systemd[1]: Reload requested from client PID 1569 ('.switch-to-conf') (unit backdoor.service)... machine # [ 29.419593] systemd[1]: Reloading... machine # [ 29.774387] systemd[1]: Reloading finished in 353 ms. machine # [ 29.868297] systemd[584]: Reexecution requested from client PID 1639 ('switch-to-confi')... machine # [ 29.872272] systemd[584]: Reexecuting. machine # [ 29.932155] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.047943] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.056493] systemd[584]: Reload requested from client PID 1639 ('switch-to-confi')... machine # [ 30.060215] systemd[584]: Reloading... machine # [ 30.173057] systemd[584]: Reloading finished in 113 ms. machine # [ 30.184195] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.195024] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 30.197722] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 30.200214] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 30.237840] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 30.243202] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 30.247786] systemd[1]: Stopping Reactivate sysinit units... machine # [ 30.250850] systemd[1]: Reached target Reactivate sysinit units. machine # [ 30.251924] systemd[1]: Reached target Remote File Systems. machine # [ 30.254407] systemd[1]: Reached target Local File Systems. machine # [ 30.257087] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 30.264892] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 30.265934] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 30.267265] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 30.283958] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 30.285796] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.287124] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.289220] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.290569] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 30.489960] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 30.493624] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 30.499176] systemd[1]: Starting linger-users.service... machine # [ 30.546698] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 30.548660] systemd[1]: Finished linger-users.service. machine # [ 30.806029] nixos[1569]: finished switching to system configuration /nix/store/11l3gm5zxjs59rpvjicwjnpswv2adlml-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.96 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 31.050582] nixos[1710]: switching to system configuration /nix/store/bw7qiwrklmpn853wyvb9s0c0cp58ayhn-nixos-system-machine-test machine # [ 31.053627] systemd[1]: Stopped target Remote File Systems. machine # [ 31.055351] systemd[1]: Stopped target Local File Systems. machine # [ 31.366554] systemd[1]: Reload requested from client PID 1710 ('.switch-to-conf') (unit backdoor.service)... machine # [ 31.368950] systemd[1]: Reloading... machine # [ 31.769807] systemd[1]: Reloading finished in 399 ms. machine # [ 31.864228] systemd[584]: Reexecution requested from client PID 1779 ('switch-to-confi')... machine # [ 31.868765] systemd[584]: Reexecuting. machine # [ 31.927810] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.047954] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.055974] systemd[584]: Reload requested from client PID 1779 ('switch-to-confi')... machine # [ 32.058203] systemd[584]: Reloading... machine # [ 32.169788] systemd[584]: Reloading finished in 110 ms. machine # [ 32.184190] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.196668] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 32.199288] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 32.201791] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 32.244178] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 32.249445] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 32.250497] systemd[1]: Stopping Reactivate sysinit units... machine # [ 32.251324] systemd[1]: Reached target Reactivate sysinit units. machine # [ 32.260938] systemd[1]: Reached target Remote File Systems. machine # [ 32.261890] systemd[1]: Starting linger-users.service... machine # [ 32.281151] systemd[1]: Reached target Local File Systems. machine # [ 32.282144] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 32.283738] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 32.301794] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 32.303190] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 32.317024] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 32.324313] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.334424] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.341597] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.343100] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 32.414024] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 32.415141] systemd[1]: Finished linger-users.service. machine # [ 32.585088] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 32.587101] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 32.845948] nixos[1710]: finished switching to system configuration /nix/store/bw7qiwrklmpn853wyvb9s0c0cp58ayhn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 2.04 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 33.090288] nixos[1851]: switching to system configuration /nix/store/23nnh7vda0gizqh38gslgjpxb153sw83-nixos-system-machine-test machine # [ 33.093645] systemd[1]: Stopped target Local File Systems. machine # [ 33.099170] systemd[1]: Stopped target Remote File Systems. machine # [ 33.100867] systemd[1]: test.service: Deactivated successfully. machine # [ 33.101778] systemd[1]: Stopped Test unit. machine # [ 33.441552] systemd[1]: Reload requested from client PID 1851 ('.switch-to-conf') (unit backdoor.service)... machine # [ 33.443677] systemd[1]: Reloading... machine # [ 33.801174] systemd[1]: Reloading finished in 355 ms. machine # [ 33.891767] systemd[584]: Reexecution requested from client PID 1919 ('switch-to-confi')... machine # [ 33.896493] systemd[584]: Reexecuting. machine # [ 33.960801] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.081501] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.088360] systemd[584]: Reload requested from client PID 1919 ('switch-to-confi')... machine # [ 34.092047] systemd[584]: Reloading... machine # [ 34.203268] systemd[584]: Reloading finished in 111 ms. machine # [ 34.220183] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.231994] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 34.234531] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 34.236950] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 34.272464] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 34.277296] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 34.283345] systemd[1]: Stopping Reactivate sysinit units... machine # [ 34.287711] systemd[1]: Reached target Reactivate sysinit units. machine # [ 34.297056] systemd[1]: Starting test.service... machine # [ 34.297858] systemd[1]: Reached target Local File Systems. machine # [ 34.298653] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 34.311093] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 34.318987] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 34.326496] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 34.333066] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 34.339281] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.344439] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.345750] systemd[1]: Reached target Remote File Systems. machine # [ 34.346549] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.347962] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 34.361771] systemd[1]: Finished test.service. machine # [ 34.520839] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 34.526426] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 34.529122] systemd[1]: Starting linger-users.service... machine # [ 34.572636] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 34.576294] systemd[1]: Finished linger-users.service. machine # [ 34.831888] nixos[1851]: finished switching to system configuration /nix/store/23nnh7vda0gizqh38gslgjpxb153sw83-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.99 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 35.089439] nixos[1993]: switching to system configuration /nix/store/dr3ilxghz1xrg7di0pdgp7sqw437pn3k-nixos-system-machine-test machine # [ 35.092375] systemd[1]: Stopped target Local File Systems. machine # [ 35.095072] systemd[1]: Stopped target Remote File Systems. machine # [ 35.421988] systemd[1]: Reload requested from client PID 1993 ('.switch-to-conf') (unit backdoor.service)... machine # [ 35.424165] systemd[1]: Reloading... machine # [ 35.786850] systemd[1]: Reloading finished in 360 ms. machine # [ 35.919892] systemd[584]: Reexecution requested from client PID 2062 ('switch-to-confi')... machine # [ 35.922141] systemd[584]: Reexecuting. machine # [ 35.972147] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.086261] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.093567] systemd[584]: Reload requested from client PID 2062 ('switch-to-confi')... machine # [ 36.097663] systemd[584]: Reloading... machine # [ 36.211090] systemd[584]: Reloading finished in 114 ms. machine # [ 36.228205] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.239216] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 36.241950] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 36.244981] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 36.280155] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 36.284796] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 36.287040] systemd[1]: Stopping Reactivate sysinit units... machine # [ 36.292206] systemd[1]: Reached target Reactivate sysinit units. machine # [ 36.293189] systemd[1]: test.service: Deactivated successfully. machine # [ 36.294050] systemd[1]: Stopped test.service. machine # [ 36.294750] systemd[1]: Stopping test.service... machine # [ 36.296682] systemd[1]: Starting test.service... machine # [ 36.323757] systemd[1]: Finished test.service. machine # [ 36.333722] systemd[1]: Reached target Local File Systems. machine # [ 36.337833] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 36.342781] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 36.343803] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 36.352752] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 36.355151] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 36.360319] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.361707] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.364944] systemd[1]: Reached target Remote File Systems. machine # [ 36.372679] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.374215] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 36.549575] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 36.551576] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 36.557696] systemd[1]: Starting linger-users.service... machine # [ 36.613761] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 36.615664] systemd[1]: Finished linger-users.service. machine # [ 36.874068] nixos[1993]: finished switching to system configuration /nix/store/dr3ilxghz1xrg7di0pdgp7sqw437pn3k-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.04 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 37.120584] nixos[2136]: switching to system configuration /nix/store/0pgyiw9m39p2k9d9bfi9nvwrkyc3vw3v-nixos-system-machine-test machine # [ 37.123618] systemd[1]: Stopped target Remote File Systems. machine # [ 37.126084] systemd[1]: Stopped target Local File Systems. machine # [ 37.440314] systemd[1]: Reload requested from client PID 2136 ('.switch-to-conf') (unit backdoor.service)... machine # [ 37.442326] systemd[1]: Reloading... machine # [ 37.779268] systemd[1]: Reloading finished in 335 ms. machine # [ 37.871685] systemd[584]: Reexecution requested from client PID 2205 ('switch-to-confi')... machine # [ 37.876404] systemd[584]: Reexecuting. machine # [ 37.931669] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.045493] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.052171] systemd[584]: Reload requested from client PID 2205 ('switch-to-confi')... machine # [ 38.056122] systemd[584]: Reloading... machine # [ 38.164745] systemd[584]: Reloading finished in 109 ms. machine # [ 38.180222] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.190154] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 38.192934] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 38.195338] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 38.230682] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 38.235593] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 38.241074] systemd[1]: Stopping Reactivate sysinit units... machine # [ 38.242021] systemd[1]: Reached target Reactivate sysinit units. machine # [ 38.244647] systemd[1]: Reloading test.service... machine # [ 38.272846] systemd[1]: Reloaded test.service. machine # [ 38.279658] systemd[1]: Reached target Local File Systems. machine # [ 38.284444] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 38.292743] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 38.293849] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 38.295162] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 38.303890] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 38.307181] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.313594] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.314979] systemd[1]: Reached target Remote File Systems. machine # [ 38.316764] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.318704] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 38.484951] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 38.487964] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.493475] systemd[1]: Starting linger-users.service... machine # [ 38.541444] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 38.543256] systemd[1]: Finished linger-users.service. machine # [ 38.801509] nixos[2136]: finished switching to system configuration /nix/store/0pgyiw9m39p2k9d9bfi9nvwrkyc3vw3v-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 1.93 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 39.105420] nixos[2278]: switching to system configuration /nix/store/26kgqpn6pqlb7m87fy88ib26czqqb05r-nixos-system-machine-test machine # [ 39.108327] systemd[1]: Stopped target Remote File Systems. machine # [ 39.110915] systemd[1]: Stopped target Local File Systems. machine # [ 39.435002] systemd[1]: Reload requested from client PID 2278 ('.switch-to-conf') (unit backdoor.service)... machine # [ 39.437478] systemd[1]: Reloading... machine # [ 39.781186] systemd[1]: Reloading finished in 342 ms. machine # [ 39.872432] systemd[584]: Reexecution requested from client PID 2349 ('switch-to-confi')... machine # [ 39.876297] systemd[584]: Reexecuting. machine # [ 39.923316] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.033830] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.040568] systemd[584]: Reload requested from client PID 2349 ('switch-to-confi')... machine # [ 40.042963] systemd[584]: Reloading... machine # [ 40.150989] systemd[584]: Reloading finished in 106 ms. machine # [ 40.168181] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.179466] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 40.181943] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 40.184197] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 40.217156] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 40.221005] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 40.223138] systemd[1]: Stopping Reactivate sysinit units... machine # [ 40.224628] systemd[1]: Reached target Reactivate sysinit units. machine # [ 40.229125] systemd[1]: Reached target Remote File Systems. machine # [ 40.231225] systemd[1]: Starting linger-users.service... machine # [ 40.241151] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.242744] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 40.250185] systemd[1]: Reached target Local File Systems. machine # [ 40.257549] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 40.259315] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 40.272634] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 40.274021] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 40.283976] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 40.286999] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.289971] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.333095] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 40.338077] systemd[1]: Finished linger-users.service. machine # [ 40.477874] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 40.481532] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 40.737464] nixos[2278]: finished switching to system configuration /nix/store/26kgqpn6pqlb7m87fy88ib26czqqb05r-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.94 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.31 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 41.236895] nixos[2430]: switching to system configuration /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test machine # [ 41.240068] systemd[1]: Stopped target Local File Systems. machine # [ 41.243911] systemd[1]: test.service: Deactivated successfully. machine # [ 41.246009] systemd[1]: Stopped test.service. machine # [ 41.246749] systemd[1]: Stopped target Remote File Systems. machine # [ 41.560731] systemd[1]: Reload requested from client PID 2430 ('.switch-to-conf') (unit backdoor.service)... machine # [ 41.562879] systemd[1]: Reloading... machine # [ 41.893782] systemd[1]: Reloading finished in 329 ms. machine # [ 41.988502] systemd[584]: Reexecution requested from client PID 2498 ('switch-to-confi')... machine # [ 41.993071] systemd[584]: Reexecuting. machine # [ 42.044000] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.159039] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.167868] systemd[584]: Reload requested from client PID 2498 ('switch-to-confi')... machine # [ 42.171868] systemd[584]: Reloading... machine # [ 42.346585] systemd[584]: Reloading finished in 176 ms. machine # [ 42.364256] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.375732] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 42.378516] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 42.381175] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 42.414561] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 42.418769] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 42.421917] systemd[1]: Stopping Reactivate sysinit units... machine # [ 42.422866] systemd[1]: Reached target Reactivate sysinit units. machine # [ 42.427965] systemd[1]: Reached target Local File Systems. machine # [ 42.429078] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 42.441068] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 42.442161] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 42.443549] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 42.455091] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 42.459786] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.461738] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.463044] systemd[1]: Reached target Remote File Systems. machine # [ 42.465172] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.466558] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 42.649792] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 42.655680] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 42.657936] systemd[1]: Starting linger-users.service... machine # [ 42.706855] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 42.708901] systemd[1]: Finished linger-users.service. machine # [ 42.966077] nixos[2430]: finished switching to system configuration /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.92 seconds) machine: must succeed: /nix/store/2g87fsrk8byby7b5z93wsns84kk9l85r-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 43.185084] nixos[2571]: switching to system configuration /nix/store/mv54dbch38xl14n72m2hhvplwabplaa7-nixos-system-machine-test machine # [ 43.188561] systemd[1]: Stopped target Local File Systems. machine # [ 43.190841] systemd[1]: Stopped target Remote File Systems. machine # [ 43.507842] systemd[1]: Reload requested from client PID 2571 ('.switch-to-conf') (unit backdoor.service)... machine # [ 43.510166] systemd[1]: Reloading... machine # [ 43.871277] systemd[1]: Reloading finished in 359 ms. machine # [ 43.974710] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 43.979486] systemd[584]: Reexecution requested from client PID 2640 ('switch-to-confi')... machine # [ 43.982673] systemd[584]: Reexecuting. machine # [ 44.048938] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.177234] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.185229] systemd[584]: Reload requested from client PID 2640 ('switch-to-confi')... machine # [ 44.189598] systemd[584]: Reloading... machine # [ 44.302448] systemd[584]: Reloading finished in 113 ms. machine # [ 44.320216] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.334794] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 44.335944] systemd[1]: Stopping Reactivate sysinit units... machine # [ 44.337729] systemd[1]: Reached target Reactivate sysinit units. machine # [ 44.343245] systemd[1]: Reached target Remote File Systems. machine # [ 44.350356] systemd[1]: Starting linger-users.service... machine # [ 44.355163] systemd[1]: Starting test.service... machine # [ 44.366382] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.367904] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 44.381394] systemd[1]: Reached target Local File Systems. machine # [ 44.382342] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 44.383957] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 44.399490] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 44.403981] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 44.415431] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 44.428127] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.434738] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.445603] systemd[1]: Finished test.service. machine # [ 44.482067] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 44.485036] systemd[1]: Finished linger-users.service. machine # [ 44.661965] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 44.665608] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 44.924574] nixos[2571]: finished switching to system configuration /nix/store/mv54dbch38xl14n72m2hhvplwabplaa7-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2g87fsrk8byby7b5z93wsns84kk9l85r-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.96 seconds) machine: must succeed: ! test -e /run/current-system/activate machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.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/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 45.223802] nixos[2719]: switching to system configuration /nix/store/7n7p35xpdcbyb77zfcwy0s5m0fz469cl-nixos-system-machine-test machine # [ 45.226864] systemd[1]: Stopped target Remote File Systems. machine # [ 45.229910] systemd[1]: Stopped target Local File Systems. machine # [ 45.233380] systemd[1]: test.service: Deactivated successfully. machine # [ 45.234369] systemd[1]: Stopped test.service. machine # [ 45.588334] systemd[1]: Reload requested from client PID 2719 ('.switch-to-conf') (unit backdoor.service)... machine # [ 45.590706] systemd[1]: Reloading... machine # [ 45.969452] systemd[1]: Reloading finished in 376 ms. machine # [ 46.098971] systemd[584]: Reexecution requested from client PID 2788 ('switch-to-confi')... machine # [ 46.102078] systemd[584]: Reexecuting. machine # [ 46.169057] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.291321] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.298834] systemd[584]: Reload requested from client PID 2788 ('switch-to-confi')... machine # [ 46.303152] systemd[584]: Reloading... machine # [ 46.417424] systemd[584]: Reloading finished in 115 ms. machine # [ 46.433766] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.443363] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 46.482428] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 46.487872] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 46.490842] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 46.496739] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 46.498271] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 46.499202] systemd[1]: Stopping Reactivate sysinit units... machine # [ 46.508590] systemd[1]: Reached target Reactivate sysinit units. machine # [ 46.511516] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.516675] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 46.521415] systemd[1]: Started test.service. machine # [ 46.530269] systemd[1]: Reached target Local File Systems. machine # [ 46.544852] systemd[1]: Reached target Remote File Systems. machine # [ 46.550992] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 46.563134] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 46.570536] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 46.576892] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 46.579329] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 46.590478] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.592969] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.594292] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 46.604530] systemd[1]: test.service: Deactivated successfully. machine # [ 46.787892] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 46.790788] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 46.795658] systemd[1]: Starting linger-users.service... machine # [ 46.841182] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 46.843167] systemd[1]: Finished linger-users.service. machine # [ 47.100297] nixos[2719]: finished switching to system configuration /nix/store/7n7p35xpdcbyb77zfcwy0s5m0fz469cl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 2.11 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 47.347576] nixos[2865]: switching to system configuration /nix/store/yxnzx3mg3zflyb7df40p1qln9i14pb3i-nixos-system-machine-test machine # [ 47.353067] systemd[1]: Stopped target Local File Systems. machine # [ 47.354014] systemd[1]: Stopped target Remote File Systems. machine # [ 47.674096] systemd[1]: Reload requested from client PID 2865 ('.switch-to-conf') (unit backdoor.service)... machine # [ 47.676361] systemd[1]: Reloading... machine # [ 48.043966] systemd[1]: Reloading finished in 366 ms. machine # [ 48.140518] systemd[584]: Reexecution requested from client PID 2934 ('switch-to-confi')... machine # [ 48.142067] systemd[584]: Reexecuting. machine # [ 48.204079] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.331164] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.338825] systemd[584]: Reload requested from client PID 2934 ('switch-to-confi')... machine # [ 48.343470] systemd[584]: Reloading... machine # [ 48.464884] systemd[584]: Reloading finished in 122 ms. machine # [ 48.480328] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.493709] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 48.496734] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 48.499128] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 48.538239] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 48.543019] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 48.546015] systemd[1]: Stopping Reactivate sysinit units... machine # [ 48.546943] systemd[1]: Reached target Reactivate sysinit units. machine # [ 48.554161] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.558253] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 48.559771] systemd[1]: Reached target Local File Systems. machine # [ 48.564416] systemd[1]: Reached target Remote File Systems. machine # [ 48.567736] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 48.576464] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 48.577539] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 48.578889] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 48.589753] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 48.592273] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.593658] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.776102] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 48.777962] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 48.783488] systemd[1]: Starting escaped\x2ddash.service... machine # [ 48.789564] systemd[1]: Starting linger-users.service... machine # [ 48.829638] systemd[1]: Finished escaped\x2ddash.service. machine # [ 48.853901] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 48.855813] systemd[1]: Finished linger-users.service. machine # [ 49.114681] nixos[2865]: finished switching to system configuration /nix/store/yxnzx3mg3zflyb7df40p1qln9i14pb3i-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 2.01 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 49.373807] nixos[3007]: switching to system configuration /nix/store/nh09p4yc4hb8ma84bf4qbjggn2xf2ig5-nixos-system-machine-test machine # [ 49.376581] systemd[1]: Stopped target Remote File Systems. machine # [ 49.379688] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 49.382360] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 49.383387] systemd[1]: Stopped target Local File Systems. machine # [ 49.703144] systemd[1]: Reload requested from client PID 3007 ('.switch-to-conf') (unit backdoor.service)... machine # [ 49.705542] systemd[1]: Reloading... machine # [ 50.095691] systemd[1]: Reloading finished in 388 ms. machine # [ 50.195389] systemd[584]: Reexecution requested from client PID 3076 ('switch-to-confi')... machine # [ 50.200799] systemd[584]: Reexecuting. machine # [ 50.264999] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.394009] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.401070] systemd[584]: Reload requested from client PID 3076 ('switch-to-confi')... machine # [ 50.405336] systemd[584]: Reloading... machine # [ 50.522526] systemd[584]: Reloading finished in 118 ms. machine # [ 50.540195] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.550664] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 50.553351] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 50.555880] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 50.590152] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 50.594689] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 50.596480] systemd[1]: Stopping Reactivate sysinit units... machine # [ 50.597367] systemd[1]: Reached target Reactivate sysinit units. machine # [ 50.601338] systemd[1]: Reached target Local File Systems. machine # [ 50.604929] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.606416] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 50.608577] systemd[1]: Reached target Remote File Systems. machine # [ 50.616341] systemd[1]: Starting escaped\x2ddash.service... machine # [ 50.631733] systemd[1]: Starting linger-users.service... machine # [ 50.640290] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 50.641940] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 50.642776] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 50.656406] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 50.658850] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 50.669508] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.670937] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.695575] systemd[1]: Finished escaped\x2ddash.service. machine # [ 50.741436] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 50.743685] systemd[1]: Finished linger-users.service. machine # [ 50.887630] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 50.891040] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 51.147279] nixos[3007]: finished switching to system configuration /nix/store/nh09p4yc4hb8ma84bf4qbjggn2xf2ig5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 2.03 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 51.399616] nixos[3149]: switching to system configuration /nix/store/7q0w9cxdnw8qbqyag76m1fkn0b9p9qf0-nixos-system-machine-test machine # [ 51.403605] systemd[1]: Stopped target Local File Systems. machine # [ 51.405615] systemd[1]: Stopped target Remote File Systems. machine # [ 51.409290] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 51.410424] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 51.730054] systemd[1]: Reload requested from client PID 3149 ('.switch-to-conf') (unit backdoor.service)... machine # [ 51.732364] systemd[1]: Reloading... machine # [ 52.073711] systemd[1]: Reloading finished in 339 ms. machine # [ 52.161174] systemd[584]: Reexecution requested from client PID 3218 ('switch-to-confi')... machine # [ 52.165781] systemd[584]: Reexecuting. machine # [ 52.219851] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.333477] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.340321] systemd[584]: Reload requested from client PID 3218 ('switch-to-confi')... machine # [ 52.342911] systemd[584]: Reloading... machine # [ 52.449768] systemd[584]: Reloading finished in 105 ms. machine # [ 52.464199] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.473499] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 52.476166] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 52.478427] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 52.513500] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 52.517909] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 52.520701] systemd[1]: Stopping Reactivate sysinit units... machine # [ 52.521627] systemd[1]: Reached target Reactivate sysinit units. machine # [ 52.524893] systemd[1]: Reached target Local File Systems. machine # [ 52.531008] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 52.540948] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 52.541875] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 52.543118] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 52.548503] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 52.550232] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.551543] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.561068] systemd[1]: Reached target Remote File Systems. machine # [ 52.562964] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.566412] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 52.720718] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 52.726017] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 52.728276] systemd[1]: Starting -.service... machine # [ 52.731669] systemd[1]: Starting linger-users.service... machine # [ 52.773606] systemd[1]: Finished -.service. machine # [ 52.793644] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 52.796181] systemd[1]: Finished linger-users.service. machine # [ 53.052978] nixos[3149]: finished switching to system configuration /nix/store/7q0w9cxdnw8qbqyag76m1fkn0b9p9qf0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.90 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 53.288855] nixos[3291]: switching to system configuration /nix/store/rqybpjbsizq96pk51g6mjy5v67mrsk7z-nixos-system-machine-test machine # [ 53.292817] systemd[1]: Stopped target Local File Systems. machine # [ 53.294628] systemd[1]: Stopped target Remote File Systems. machine # [ 53.596888] systemd[1]: Reload requested from client PID 3291 ('.switch-to-conf') (unit backdoor.service)... machine # [ 53.598941] systemd[1]: Reloading... machine # [ 53.941550] systemd[1]: Reloading finished in 340 ms. machine # [ 54.026438] systemd[584]: Reexecution requested from client PID 3360 ('switch-to-confi')... machine # [ 54.027887] systemd[584]: Reexecuting. machine # [ 54.093297] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.209998] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.217268] systemd[584]: Reload requested from client PID 3360 ('switch-to-confi')... machine # [ 54.220207] systemd[584]: Reloading... machine # [ 54.334325] systemd[584]: Reloading finished in 112 ms. machine # [ 54.349835] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.358451] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 54.361247] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 54.363688] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 54.399074] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 54.403845] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 54.408805] systemd[1]: Stopping Reactivate sysinit units... machine # [ 54.409665] systemd[1]: Reached target Reactivate sysinit units. machine # [ 54.412175] systemd[1]: Reloading -.service... machine # [ 54.439381] systemd[1]: Reloaded -.service. machine # [ 54.443980] systemd[1]: Reached target Local File Systems. machine # [ 54.448695] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 54.459021] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 54.464739] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 54.466198] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 54.474715] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 54.478868] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.480515] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.481792] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.483109] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 54.485746] systemd[1]: Reached target Remote File Systems. machine # [ 54.646110] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 54.651552] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 54.654306] systemd[1]: Starting linger-users.service... machine # [ 54.699454] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 54.701616] systemd[1]: Finished linger-users.service. machine # [ 54.958201] nixos[3291]: finished switching to system configuration /nix/store/rqybpjbsizq96pk51g6mjy5v67mrsk7z-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.91 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 55.194848] nixos[3433]: switching to system configuration /nix/store/0ncq24f1iaiqmgwg9f9lffdx9rxqqngj-nixos-system-machine-test machine # [ 55.197709] systemd[1]: -.service: Deactivated successfully. machine # [ 55.201721] systemd[1]: Stopped -.service. machine # [ 55.202488] systemd[1]: Stopped target Remote File Systems. machine # [ 55.203388] systemd[1]: Stopped target Local File Systems. machine # [ 55.507973] systemd[1]: Reload requested from client PID 3433 ('.switch-to-conf') (unit backdoor.service)... machine # [ 55.510190] systemd[1]: Reloading... machine # [ 55.853874] systemd[1]: Reloading finished in 341 ms. machine # [ 55.945089] systemd[584]: Reexecution requested from client PID 3502 ('switch-to-confi')... machine # [ 55.949582] systemd[584]: Reexecuting. machine # [ 56.012607] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.130286] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.137952] systemd[584]: Reload requested from client PID 3502 ('switch-to-confi')... machine # [ 56.141653] systemd[584]: Reloading... machine # [ 56.248821] systemd[584]: Reloading finished in 108 ms. machine # [ 56.264199] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.273668] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 56.276143] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 56.278679] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 56.313146] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 56.317234] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 56.320815] systemd[1]: Stopping Reactivate sysinit units... machine # [ 56.321762] systemd[1]: Reached target Reactivate sysinit units. machine # [ 56.325294] systemd[1]: Reached target Remote File Systems. machine # [ 56.331542] systemd[1]: Starting linger-users.service... machine # [ 56.335737] systemd[1]: Starting required-service.service... machine # [ 56.345386] systemd[1]: Starting test-service.service... machine # [ 56.362341] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.363884] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 56.384335] systemd[1]: Reached target Local File Systems. machine # [ 56.385266] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 56.394992] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 56.401190] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 56.402764] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 56.421607] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 56.423459] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.438929] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.444702] systemd[1]: Finished test-service.service. machine # [ 56.445552] systemd[1]: Finished required-service.service. machine # [ 56.475131] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 56.477347] systemd[1]: Finished linger-users.service. machine # [ 56.618884] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 56.622857] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 56.877653] nixos[3433]: finished switching to system configuration /nix/store/0ncq24f1iaiqmgwg9f9lffdx9rxqqngj-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.92 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 57.110482] nixos[3577]: switching to system configuration /nix/store/k680adzm5kxv0a2i74xi8m9zzyyzbx8a-nixos-system-machine-test machine # [ 57.113741] systemd[1]: Stopped target Local File Systems. machine # [ 57.115570] systemd[1]: Stopped target Remote File Systems. machine # [ 57.119387] systemd[1]: required-service.service: Deactivated successfully. machine # [ 57.121576] systemd[1]: Stopped required-service.service. machine # [ 57.122391] systemd[1]: test-service.service: Deactivated successfully. machine # [ 57.123335] systemd[1]: Stopped test-service.service. machine # [ 57.426217] systemd[1]: Reload requested from client PID 3577 ('.switch-to-conf') (unit backdoor.service)... machine # [ 57.428614] systemd[1]: Reloading... machine # [ 57.765854] systemd[1]: Reloading finished in 335 ms. machine # [ 57.854277] systemd[584]: Reexecution requested from client PID 3646 ('switch-to-confi')... machine # [ 57.858999] systemd[584]: Reexecuting. machine # [ 57.911965] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.024434] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.030917] systemd[584]: Reload requested from client PID 3646 ('switch-to-confi')... machine # [ 58.034874] systemd[584]: Reloading... machine # [ 58.141616] systemd[584]: Reloading finished in 107 ms. machine # [ 58.156205] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.166491] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 58.169084] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 58.171304] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 58.205496] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 58.209978] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 58.212279] systemd[1]: Stopping Reactivate sysinit units... machine # [ 58.213176] systemd[1]: Reached target Reactivate sysinit units. machine # [ 58.217540] systemd[1]: Reached target Local File Systems. machine # [ 58.220972] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 58.225425] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 58.226404] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 58.227791] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 58.236955] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 58.238666] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.245937] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.247286] systemd[1]: Reached target Remote File Systems. machine # [ 58.257523] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.258980] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 58.416142] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 58.419044] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 58.424405] systemd[1]: Starting linger-users.service... machine # [ 58.428809] systemd[1]: Starting required-service.service... machine # [ 58.436571] systemd[1]: Starting test-service.service... machine # [ 58.487771] systemd[1]: Finished test-service.service. machine # [ 58.491310] systemd[1]: Finished required-service.service. machine # [ 58.510465] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 58.513774] systemd[1]: Finished linger-users.service. machine # [ 58.770015] nixos[3577]: finished switching to system configuration /nix/store/k680adzm5kxv0a2i74xi8m9zzyyzbx8a-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.89 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 58.999326] nixos[3721]: switching to system configuration /nix/store/safc8ax34l8dlghlqya7r7yi7h00kafl-nixos-system-machine-test machine # [ 59.002001] systemd[1]: Stopped target Remote File Systems. machine # [ 59.006543] systemd[1]: Stopped target Local File Systems. machine # [ 59.007462] systemd[1]: required-service.service: Deactivated successfully. machine # [ 59.009879] systemd[1]: Stopped required-service.service. machine # [ 59.010755] systemd[1]: test-service.service: Deactivated successfully. machine # [ 59.011819] systemd[1]: Stopped test-service.service. machine # [ 59.304593] systemd[1]: Reload requested from client PID 3721 ('.switch-to-conf') (unit backdoor.service)... machine # [ 59.306588] systemd[1]: Reloading... machine # [ 59.636166] systemd[1]: Reloading finished in 328 ms. machine # [ 59.722239] systemd[584]: Reexecution requested from client PID 3790 ('switch-to-confi')... machine # [ 59.726686] systemd[584]: Reexecuting. machine # [ 59.783887] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.897458] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.904546] systemd[584]: Reload requested from client PID 3790 ('switch-to-confi')... machine # [ 59.907355] systemd[584]: Reloading... machine # [ 60.013992] systemd[584]: Reloading finished in 105 ms. machine # [ 60.028200] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.039239] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 60.041711] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 60.043890] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 60.077265] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 60.081533] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 60.083699] systemd[1]: Stopping Reactivate sysinit units... machine # [ 60.089513] systemd[1]: Reached target Reactivate sysinit units. machine # [ 60.090468] systemd[1]: Reached target Local File Systems. machine # [ 60.091292] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 60.104447] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 60.105399] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 60.106636] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 60.117940] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 60.119767] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.121184] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.122390] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.123736] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 60.125905] systemd[1]: Reached target Remote File Systems. machine # [ 60.288820] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 60.290648] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 60.296211] systemd[1]: Starting linger-users.service... machine # [ 60.302112] systemd[1]: Starting required-service.service... machine # [ 60.312714] systemd[1]: Starting test-service.service... machine # [ 60.364367] systemd[1]: Finished required-service.service. machine # [ 60.367548] systemd[1]: Finished test-service.service. machine # [ 60.386237] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 60.389171] systemd[1]: Finished linger-users.service. machine # [ 60.645116] nixos[3721]: finished switching to system configuration /nix/store/safc8ax34l8dlghlqya7r7yi7h00kafl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.88 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 60.883446] nixos[3865]: switching to system configuration /nix/store/hfbzq025jjdb4v9cxnl3l7r4v571sznm-nixos-system-machine-test machine # [ 60.886404] systemd[1]: test-service.service: Deactivated successfully. machine # [ 60.890526] systemd[1]: Stopped test-service.service. machine # [ 60.891544] systemd[1]: Stopped target Remote File Systems. machine # [ 60.894381] systemd[1]: Stopped target Local File Systems. machine # [ 60.895354] systemd[1]: required-service.service: Deactivated successfully. machine # [ 60.896826] systemd[1]: Stopped required-service.service. machine # [ 61.217534] systemd[1]: Reload requested from client PID 3865 ('.switch-to-conf') (unit backdoor.service)... machine # [ 61.219636] systemd[1]: Reloading... machine # [ 61.569883] systemd[1]: Reloading finished in 347 ms. machine # [ 61.660512] systemd[584]: Reexecution requested from client PID 3934 ('switch-to-confi')... machine # [ 61.664767] systemd[584]: Reexecuting. machine # [ 61.724323] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.838391] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.845469] systemd[584]: Reload requested from client PID 3934 ('switch-to-confi')... machine # [ 61.849559] systemd[584]: Reloading... machine # [ 61.959686] systemd[584]: Reloading finished in 111 ms. machine # [ 61.976194] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.986155] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 61.988936] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 61.991347] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 62.026082] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 62.029817] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 62.032990] systemd[1]: Stopping Reactivate sysinit units... machine # [ 62.033906] systemd[1]: Reached target Reactivate sysinit units. machine # [ 62.034758] systemd[1]: Reached target Remote File Systems. machine # [ 62.041174] systemd[1]: Created slice Slice /system/instantiated. machine # [ 62.046756] systemd[1]: Starting instantiated@one.service... machine # [ 62.051486] systemd[1]: Starting instantiated@two.service... machine # [ 62.064312] systemd[1]: Starting linger-users.service... machine # [ 62.075983] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.077506] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 62.078813] systemd[1]: Reached target Local File Systems. machine # [ 62.079653] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 62.105795] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 62.106757] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 62.117324] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 62.132200] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 62.146481] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.152791] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.154141] systemd[1]: Finished instantiated@two.service. machine # [ 62.154920] systemd[1]: Finished instantiated@one.service. machine # [ 62.190235] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 62.192209] systemd[1]: Finished linger-users.service. machine # [ 62.337167] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 62.339510] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 62.597543] nixos[3865]: finished switching to system configuration /nix/store/hfbzq025jjdb4v9cxnl3l7r4v571sznm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.95 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 62.849923] nixos[4009]: switching to system configuration /nix/store/ghwqpv3kal66f82r0i6c1gkpzn2rzn6l-nixos-system-machine-test machine # [ 62.857520] systemd[1]: Stopped target Remote File Systems. machine # [ 62.858456] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 62.859442] systemd[1]: Stopped instantiated@two.service. machine # [ 62.862343] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 62.865217] systemd[1]: Stopped instantiated@one.service. machine # [ 62.866042] systemd[1]: Stopped target Local File Systems. machine # [ 63.179691] systemd[1]: Reload requested from client PID 4009 ('.switch-to-conf') (unit backdoor.service)... machine # [ 63.181981] systemd[1]: Reloading... machine # [ 63.526981] systemd[1]: Reloading finished in 343 ms. machine # [ 63.616523] systemd[584]: Reexecution requested from client PID 4078 ('switch-to-confi')... machine # [ 63.619146] systemd[584]: Reexecuting. machine # [ 63.679795] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.789152] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.796105] systemd[584]: Reload requested from client PID 4078 ('switch-to-confi')... machine # [ 63.797522] systemd[584]: Reloading... machine # [ 63.906929] systemd[584]: Reloading finished in 107 ms. machine # [ 63.924269] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.935394] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 63.938069] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 63.941099] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 63.974405] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 63.979474] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 63.983599] systemd[1]: Stopping Reactivate sysinit units... machine # [ 63.986293] systemd[1]: Reached target Reactivate sysinit units. machine # [ 63.990815] systemd[1]: Reached target Local File Systems. machine # [ 63.996193] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 63.997974] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 63.998808] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 64.009738] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 64.018851] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 64.022976] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.025514] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.026839] systemd[1]: Reached target Remote File Systems. machine # [ 64.028637] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.030985] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 64.195090] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 64.200539] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 64.204323] systemd[1]: Starting instantiated@one.service... machine # [ 64.208210] systemd[1]: Starting instantiated@two.service... machine # [ 64.213847] systemd[1]: Starting linger-users.service... machine # [ 64.266314] systemd[1]: Finished instantiated@two.service. machine # [ 64.275803] systemd[1]: Finished instantiated@one.service. machine # [ 64.303001] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 64.306123] systemd[1]: Finished linger-users.service. machine # [ 64.562171] nixos[4009]: finished switching to system configuration /nix/store/ghwqpv3kal66f82r0i6c1gkpzn2rzn6l-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.97 seconds) (finished: subtest: services, in 41.76 seconds) subtest: failing units machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 64.780609] nixos[4153]: switching to system configuration /nix/store/23nnh7vda0gizqh38gslgjpxb153sw83-nixos-system-machine-test machine # [ 64.783525] systemd[1]: Stopped target Remote File Systems. machine # [ 64.785376] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 64.789803] systemd[1]: Stopped instantiated@two.service. machine # [ 64.790741] systemd[1]: Stopped target Local File Systems. machine # [ 64.791685] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 64.793296] systemd[1]: Stopped instantiated@one.service. machine # [ 65.074497] systemd[1]: Reload requested from client PID 4153 ('.switch-to-conf') (unit backdoor.service)... machine # [ 65.076797] systemd[1]: Reloading... machine # [ 65.406221] systemd[1]: Reloading finished in 328 ms. machine # [ 65.498377] systemd[584]: Reexecution requested from client PID 4222 ('switch-to-confi')... machine # [ 65.502296] systemd[584]: Reexecuting. machine # [ 65.555835] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.669545] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.676330] systemd[584]: Reload requested from client PID 4222 ('switch-to-confi')... machine # [ 65.678998] systemd[584]: Reloading... machine # [ 65.787295] systemd[584]: Reloading finished in 107 ms. machine # [ 65.804176] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.814493] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 65.817183] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 65.819515] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 65.853129] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 65.857451] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 65.859995] systemd[1]: Stopping Reactivate sysinit units... machine # [ 65.862204] systemd[1]: Reached target Reactivate sysinit units. machine # [ 65.863061] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.866828] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 65.873063] systemd[1]: Reached target Local File Systems. machine # [ 65.873961] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 65.877678] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 65.878620] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 65.888928] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 65.891385] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 65.897882] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.899328] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.900977] systemd[1]: Reached target Remote File Systems. machine # [ 66.108400] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 66.112987] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 66.118033] systemd[1]: Starting linger-users.service... machine # [ 66.124261] systemd[1]: Starting test.service... machine # [ 66.163974] systemd[1]: Finished test.service. machine # [ 66.184971] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 66.186945] systemd[1]: Finished linger-users.service. machine # [ 66.444521] nixos[4153]: finished switching to system configuration /nix/store/23nnh7vda0gizqh38gslgjpxb153sw83-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.88 seconds) machine: must fail: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 66.676749] nixos[4295]: switching to system configuration /nix/store/n9x63rhjafll96wbdq3y9gbvl3a3d7a5-nixos-system-machine-test machine # [ 66.679595] systemd[1]: test.service: Deactivated successfully. machine # [ 66.682593] systemd[1]: Stopped test.service. machine # [ 66.683343] systemd[1]: Stopped target Local File Systems. machine # [ 66.685878] systemd[1]: Stopped target Remote File Systems. machine # [ 66.990266] systemd[1]: Reload requested from client PID 4295 ('.switch-to-conf') (unit backdoor.service)... machine # [ 66.991962] systemd[1]: Reloading... machine # [ 67.328249] systemd[1]: Reloading finished in 334 ms. machine # [ 67.416436] systemd[584]: Reexecution requested from client PID 4364 ('switch-to-confi')... machine # [ 67.420286] systemd[584]: Reexecuting. machine # [ 67.455733] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.563357] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.569939] systemd[584]: Reload requested from client PID 4364 ('switch-to-confi')... machine # [ 67.574088] systemd[584]: Reloading... machine # [ 67.679801] systemd[584]: Reloading finished in 106 ms. machine # [ 67.692186] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.702285] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 67.704865] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 67.707132] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 67.740808] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 67.744451] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 67.747519] systemd[1]: Stopping Reactivate sysinit units... machine # [ 67.752806] systemd[1]: Reached target Reactivate sysinit units. machine # [ 67.753749] systemd[1]: Reached target Local File Systems. machine # [ 67.754533] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 67.768235] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 67.769175] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 67.770485] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 67.779733] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 67.782232] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.783571] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.785802] systemd[1]: Reached target Remote File Systems. machine # [ 67.787262] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.790919] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 67.945755] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 67.948243] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 67.954720] systemd[1]: Starting linger-users.service... machine # [ 67.960375] systemd[1]: Starting test.service... machine # [ 67.995917] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 68.000953] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 68.002269] systemd[1]: Failed to start test.service. machine # [ 68.021629] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 68.023492] systemd[1]: Finished linger-users.service. machine # [ 68.303271] nixos[4295]: switching to system configuration /nix/store/n9x63rhjafll96wbdq3y9gbvl3a3d7a5-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.86 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 68.523347] nixos[4438]: switching to system configuration /nix/store/zh417gm4qgc19wkvlk3smrag7l1far8k-nixos-system-machine-test machine # [ 68.526308] systemd[1]: Stopped target Local File Systems. machine # [ 68.529079] systemd[1]: Stopped target Remote File Systems. machine # [ 68.823821] systemd[1]: Reload requested from client PID 4438 ('.switch-to-conf') (unit backdoor.service)... machine # [ 68.826414] systemd[1]: Reloading... machine # [ 69.155863] systemd[1]: Reloading finished in 327 ms. machine # [ 69.241736] systemd[584]: Reexecution requested from client PID 4507 ('switch-to-confi')... machine # [ 69.246310] systemd[584]: Reexecuting. machine # [ 69.304312] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.419032] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.426061] systemd[584]: Reload requested from client PID 4507 ('switch-to-confi')... machine # [ 69.429852] systemd[584]: Reloading... machine # [ 69.533598] systemd[584]: Reloading finished in 104 ms. machine # [ 69.548172] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.558404] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 69.560992] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 69.563299] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 69.596562] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 69.600978] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 69.604766] systemd[1]: Stopping Reactivate sysinit units... machine # [ 69.605723] systemd[1]: Reached target Reactivate sysinit units. machine # [ 69.606585] systemd[1]: Reached target Local File Systems. machine # [ 69.612777] systemd[1]: Reached target Remote File Systems. machine # [ 69.618382] systemd[1]: Started autorestart.service. machine # [ 69.622513] systemd[1]: Starting linger-users.service... machine # [ 69.633439] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 69.635086] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 69.635939] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 69.650910] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 69.659700] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 69.666496] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.673789] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.675308] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.688337] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 69.697806] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 69.731462] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 69.734838] systemd[1]: Finished linger-users.service. machine # [ 69.864905] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 69.868153] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.125484] nixos[4438]: finished switching to system configuration /nix/store/zh417gm4qgc19wkvlk3smrag7l1far8k-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.82 seconds) machine # [ 70.172719] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 70.384392] nixos[4585]: switching to system configuration /nix/store/zh417gm4qgc19wkvlk3smrag7l1far8k-nixos-system-machine-test machine # [ 70.387025] systemd[1]: Stopped target Local File Systems. machine # [ 70.390324] systemd[1]: Stopped target Remote File Systems. machine # [ 70.674570] systemd[1]: Reload requested from client PID 4585 ('.switch-to-conf') (unit backdoor.service)... machine # [ 70.676871] systemd[1]: Reloading... machine # [ 70.993403] systemd[1]: Reloading finished in 314 ms. machine # [ 71.079447] systemd[584]: Reexecution requested from client PID 4654 ('switch-to-confi')... machine # [ 71.082503] systemd[584]: Reexecuting. machine # [ 71.143995] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.256831] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.263822] systemd[584]: Reload requested from client PID 4654 ('switch-to-confi')... machine # [ 71.267312] systemd[584]: Reloading... machine # [ 71.373969] systemd[584]: Reloading finished in 107 ms. machine # [ 71.388226] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.398984] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 71.400346] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 71.402865] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 71.437338] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 71.441885] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 71.444942] systemd[1]: Stopping Reactivate sysinit units... machine # [ 71.445891] systemd[1]: Reached target Reactivate sysinit units. machine # [ 71.446781] systemd[1]: Reached target Local File Systems. machine # [ 71.449986] systemd[1]: Reached target Remote File Systems. machine # [ 71.457766] systemd[1]: Started autorestart.service. machine # [ 71.469104] systemd[1]: Starting linger-users.service... machine # [ 71.470083] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.471561] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 71.486527] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 71.496354] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 71.504113] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 71.505611] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 71.516929] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 71.526276] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.527794] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.541018] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 71.588145] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 71.592599] systemd[1]: Finished linger-users.service. machine # [ 71.730244] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 71.734538] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 71.990018] nixos[4585]: finished switching to system configuration /nix/store/zh417gm4qgc19wkvlk3smrag7l1far8k-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine # [ 72.033107] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 72.261617] nixos[4732]: switching to system configuration /nix/store/7jdx4d2x95f9izc719js4r3vc7i2yzfd-nixos-system-machine-test machine # [ 72.264437] systemd[1]: Stopped target Local File Systems. machine # [ 72.267343] systemd[1]: Stopped target Remote File Systems. machine # [ 72.577314] systemd[1]: Reload requested from client PID 4732 ('.switch-to-conf') (unit backdoor.service)... machine # [ 72.579442] systemd[1]: Reloading... machine # [ 72.927325] systemd[1]: Reloading finished in 345 ms. machine # [ 73.024213] systemd[584]: Reexecution requested from client PID 4800 ('switch-to-confi')... machine # [ 73.025652] systemd[584]: Reexecuting. machine # [ 73.083671] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.199109] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.206776] systemd[584]: Reload requested from client PID 4800 ('switch-to-confi')... machine # [ 73.209462] systemd[584]: Reloading... machine # [ 73.320179] systemd[584]: Reloading finished in 109 ms. machine # [ 73.340230] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.350903] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 73.353821] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 73.356082] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 73.389352] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 73.393673] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 73.400842] systemd[1]: Stopping Reactivate sysinit units... machine # [ 73.401950] systemd[1]: Reached target Reactivate sysinit units. machine # [ 73.402877] systemd[1]: Reached target Local File Systems. machine # [ 73.403691] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 73.407812] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 73.412534] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 73.413860] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 73.425228] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 73.426959] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.429661] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.431145] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.437856] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 73.439684] systemd[1]: Reached target Remote File Systems. machine # [ 73.604126] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 73.608794] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 73.612282] systemd[1]: Started autorestart.service. machine # [ 73.616732] systemd[1]: Starting linger-users.service... machine # [ 73.655332] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 73.658303] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 73.681097] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 73.684255] systemd[1]: Finished linger-users.service. machine # [ 73.964267] nixos[4732]: switching to system configuration /nix/store/7jdx4d2x95f9izc719js4r3vc7i2yzfd-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.93 seconds) (finished: subtest: failing units, in 9.40 seconds) subtest: unit file parser machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 74.173262] nixos[4875]: switching to system configuration /nix/store/dr3ilxghz1xrg7di0pdgp7sqw437pn3k-nixos-system-machine-test machine # [ 74.176526] systemd[1]: Stopped autorestart.service. machine # [ 74.180940] systemd[1]: Stopped target Local File Systems. machine # [ 74.181911] systemd[1]: Stopped target Remote File Systems. machine # [ 74.462442] systemd[1]: Reload requested from client PID 4875 ('.switch-to-conf') (unit backdoor.service)... machine # [ 74.464745] systemd[1]: Reloading... machine # [ 74.781897] systemd[1]: Reloading finished in 315 ms. machine # [ 74.870443] systemd[584]: Reexecution requested from client PID 4944 ('switch-to-confi')... machine # [ 74.875105] systemd[584]: Reexecuting. machine # [ 74.928238] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.043828] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.051303] systemd[584]: Reload requested from client PID 4944 ('switch-to-confi')... machine # [ 75.053832] systemd[584]: Reloading... machine # [ 75.163852] systemd[584]: Reloading finished in 108 ms. machine # [ 75.180224] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.191139] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 75.193898] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 75.196241] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 75.230349] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 75.236863] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 75.240939] systemd[1]: Stopping Reactivate sysinit units... machine # [ 75.241987] systemd[1]: Reached target Reactivate sysinit units. machine # [ 75.247277] systemd[1]: Reached target Remote File Systems. machine # [ 75.251663] systemd[1]: Starting linger-users.service... machine # [ 75.257086] systemd[1]: Starting test.service... machine # [ 75.272089] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.273631] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 75.279434] systemd[1]: Reached target Local File Systems. machine # [ 75.293131] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 75.294757] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 75.295818] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 75.311258] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 75.321874] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 75.323666] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.337383] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.338759] systemd[1]: Finished test.service. machine # [ 75.374000] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 75.377214] systemd[1]: Finished linger-users.service. machine # [ 75.515451] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 75.519103] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 75.774506] nixos[4875]: finished switching to system configuration /nix/store/dr3ilxghz1xrg7di0pdgp7sqw437pn3k-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 76.012761] nixos[5017]: switching to system configuration /nix/store/z809042bdc8dxk67psyy7kh65zwzjfbz-nixos-system-machine-test machine # [ 76.015499] systemd[1]: Stopped target Local File Systems. machine # [ 76.018342] systemd[1]: Stopped target Remote File Systems. machine # [ 76.316679] systemd[1]: Reload requested from client PID 5017 ('.switch-to-conf') (unit backdoor.service)... machine # [ 76.318915] systemd[1]: Reloading... machine # [ 76.653342] systemd[1]: Reloading finished in 332 ms. machine # [ 76.742625] systemd[584]: Reexecution requested from client PID 5086 ('switch-to-confi')... machine # [ 76.747229] systemd[584]: Reexecuting. machine # [ 76.803658] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.921759] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.929098] systemd[584]: Reload requested from client PID 5086 ('switch-to-confi')... machine # [ 76.933191] systemd[584]: Reloading... machine # [ 77.040450] systemd[584]: Reloading finished in 108 ms. machine # [ 77.056179] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.067317] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 77.069848] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 77.072302] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 77.104103] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 77.108207] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 77.109992] systemd[1]: Stopping Reactivate sysinit units... machine # [ 77.110866] systemd[1]: Reached target Reactivate sysinit units. machine # [ 77.115103] systemd[1]: test.service: Deactivated successfully. machine # [ 77.117674] systemd[1]: Stopped test.service. machine # [ 77.118442] systemd[1]: Stopping test.service... machine # [ 77.119232] systemd[1]: Starting test.service... machine # [ 77.145473] systemd[1]: Finished test.service. machine # [ 77.150302] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.154457] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 77.159234] systemd[1]: Reached target Local File Systems. machine # [ 77.163049] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 77.172530] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 77.173536] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 77.174831] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 77.182776] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 77.184604] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.185871] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.187172] systemd[1]: Reached target Remote File Systems. machine # [ 77.343263] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 77.347812] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 77.350217] systemd[1]: Starting linger-users.service... machine # [ 77.395170] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 77.398012] systemd[1]: Finished linger-users.service. machine # [ 77.653778] nixos[5017]: finished switching to system configuration /nix/store/z809042bdc8dxk67psyy7kh65zwzjfbz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.88 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 77.886910] nixos[5159]: switching to system configuration /nix/store/5v5bcay0d60iba3zmg9ya7da3gqli69y-nixos-system-machine-test machine # [ 77.889914] systemd[1]: Stopped target Local File Systems. machine # [ 77.892423] systemd[1]: Stopped target Remote File Systems. machine # [ 78.188622] systemd[1]: Reload requested from client PID 5159 ('.switch-to-conf') (unit backdoor.service)... machine # [ 78.190666] systemd[1]: Reloading... machine # [ 78.524294] systemd[1]: Reloading finished in 331 ms. machine # [ 78.619624] systemd[584]: Reexecution requested from client PID 5228 ('switch-to-confi')... machine # [ 78.624836] systemd[584]: Reexecuting. machine # [ 78.671643] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.782827] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.790586] systemd[584]: Reload requested from client PID 5228 ('switch-to-confi')... machine # [ 78.794057] systemd[584]: Reloading... machine # [ 78.899261] systemd[584]: Reloading finished in 106 ms. machine # [ 78.916196] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.926056] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 78.928631] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 78.930873] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 78.965032] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 78.969255] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 78.971346] systemd[1]: Stopping Reactivate sysinit units... machine # [ 78.975661] systemd[1]: Reached target Reactivate sysinit units. machine # [ 78.976951] systemd[1]: test.service: Deactivated successfully. machine # [ 78.977795] systemd[1]: Stopped test.service. machine # [ 78.978455] systemd[1]: Stopping test.service... machine # [ 78.980451] systemd[1]: Starting test.service... machine # [ 79.005223] systemd[1]: Finished test.service. machine # [ 79.016451] systemd[1]: Reached target Remote File Systems. machine # [ 79.020878] systemd[1]: Starting linger-users.service... machine # [ 79.023558] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.032952] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 79.034335] systemd[1]: Reached target Local File Systems. machine # [ 79.035258] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 79.045027] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 79.045972] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 79.047332] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 79.058829] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 79.063758] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.069973] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.114442] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 79.117583] systemd[1]: Finished linger-users.service. machine # [ 79.254005] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 79.257326] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 79.514067] nixos[5159]: finished switching to system configuration /nix/store/5v5bcay0d60iba3zmg9ya7da3gqli69y-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.86 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 79.728206] nixos[5301]: switching to system configuration /nix/store/dr3ilxghz1xrg7di0pdgp7sqw437pn3k-nixos-system-machine-test machine # [ 79.731545] systemd[1]: Stopped target Local File Systems. machine # [ 79.733863] systemd[1]: Stopped target Remote File Systems. machine # [ 80.014874] systemd[1]: Reload requested from client PID 5301 ('.switch-to-conf') (unit backdoor.service)... machine # [ 80.017175] systemd[1]: Reloading... machine # [ 80.338196] systemd[1]: Reloading finished in 319 ms. machine # [ 80.431910] systemd[584]: Reexecution requested from client PID 5370 ('switch-to-confi')... machine # [ 80.434192] systemd[584]: Reexecuting. machine # [ 80.491475] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.605797] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.612967] systemd[584]: Reload requested from client PID 5370 ('switch-to-confi')... machine # [ 80.615290] systemd[584]: Reloading... machine # [ 80.722082] systemd[584]: Reloading finished in 105 ms. machine # [ 80.736187] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.746731] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 80.749295] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 80.751645] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 80.786367] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 80.791371] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 80.796780] systemd[1]: Stopping Reactivate sysinit units... machine # [ 80.797715] systemd[1]: Reached target Reactivate sysinit units. machine # [ 80.798579] systemd[1]: test.service: Deactivated successfully. machine # [ 80.799450] systemd[1]: Stopped test.service. machine # [ 80.800879] systemd[1]: Stopping test.service... machine # [ 80.802836] systemd[1]: Starting test.service... machine # [ 80.831257] systemd[1]: Finished test.service. machine # [ 80.837189] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.841275] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 80.844118] systemd[1]: Reached target Local File Systems. machine # [ 80.846929] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 80.855337] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 80.860668] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 80.869766] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 80.873526] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 80.875328] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.876668] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.877847] systemd[1]: Reached target Remote File Systems. machine # [ 81.036512] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 81.039809] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 81.044816] systemd[1]: Starting linger-users.service... machine # [ 81.087668] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 81.090596] systemd[1]: Finished linger-users.service. machine # [ 81.346458] nixos[5301]: finished switching to system configuration /nix/store/dr3ilxghz1xrg7di0pdgp7sqw437pn3k-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.83 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 81.585281] nixos[5443]: switching to system configuration /nix/store/fh52fy0if4hg139bqhf6gfmwkfd4vqw7-nixos-system-machine-test machine # [ 81.588077] systemd[1]: Stopped target Local File Systems. machine # [ 81.590795] systemd[1]: Stopped target Remote File Systems. machine # [ 81.890520] systemd[1]: Reload requested from client PID 5443 ('.switch-to-conf') (unit backdoor.service)... machine # [ 81.892958] systemd[1]: Reloading... machine # [ 82.220130] systemd[1]: Reloading finished in 325 ms. machine # [ 82.313646] systemd[584]: Reexecution requested from client PID 5512 ('switch-to-confi')... machine # [ 82.317735] systemd[584]: Reexecuting. machine # [ 82.371361] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.485517] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.492820] systemd[584]: Reload requested from client PID 5512 ('switch-to-confi')... machine # [ 82.497551] systemd[584]: Reloading... machine # [ 82.605538] systemd[584]: Reloading finished in 109 ms. machine # [ 82.620178] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.630296] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 82.632894] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 82.635256] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 82.668934] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 82.673182] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 82.675293] systemd[1]: Stopping Reactivate sysinit units... machine # [ 82.679116] systemd[1]: Reached target Reactivate sysinit units. machine # [ 82.681242] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.682594] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 82.686231] systemd[1]: Reached target Remote File Systems. machine # [ 82.689886] systemd[1]: Reached target Local File Systems. machine # [ 82.692952] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 82.698134] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 82.703661] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 82.708344] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 82.710648] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 82.715502] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.720236] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.873530] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 82.878450] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 82.880983] systemd[1]: Starting linger-users.service... machine # [ 82.923652] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 82.926869] systemd[1]: Finished linger-users.service. machine # [ 83.181713] nixos[5443]: finished switching to system configuration /nix/store/fh52fy0if4hg139bqhf6gfmwkfd4vqw7-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.83 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 83.412737] nixos[5583]: switching to system configuration /nix/store/aimlgny0w4d7kzcl5s18aarxndx2lsy5-nixos-system-machine-test machine # [ 83.415246] systemd[1]: Stopped target Local File Systems. machine # [ 83.417421] systemd[1]: Stopped target Remote File Systems. machine # [ 83.713896] systemd[1]: Reload requested from client PID 5583 ('.switch-to-conf') (unit backdoor.service)... machine # [ 83.715574] systemd[1]: Reloading... machine # [ 84.049851] systemd[1]: Reloading finished in 331 ms. machine # [ 84.142894] systemd[584]: Reexecution requested from client PID 5652 ('switch-to-confi')... machine # [ 84.145326] systemd[584]: Reexecuting. machine # [ 84.203681] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.317240] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.324094] systemd[584]: Reload requested from client PID 5652 ('switch-to-confi')... machine # [ 84.325497] systemd[584]: Reloading... machine # [ 84.436601] systemd[584]: Reloading finished in 109 ms. machine # [ 84.452177] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.464081] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 84.465160] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 84.467618] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 84.500464] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 84.504590] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 84.506821] systemd[1]: Stopping Reactivate sysinit units... machine # [ 84.507747] systemd[1]: Reached target Reactivate sysinit units. machine # [ 84.512286] systemd[1]: test.service: Deactivated successfully. machine # [ 84.513248] systemd[1]: Stopped test.service. machine # [ 84.513883] systemd[1]: Stopping test.service... machine # [ 84.515795] systemd[1]: Starting test.service... machine # [ 84.541892] systemd[1]: Finished test.service. machine # [ 84.547163] systemd[1]: Reached target Local File Systems. machine # [ 84.554123] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.555624] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 84.564737] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 84.566347] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 84.567186] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 84.570179] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 84.580919] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 84.582684] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.585661] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.589496] systemd[1]: Reached target Remote File Systems. machine # [ 84.740127] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 84.744277] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 84.747667] systemd[1]: Starting linger-users.service... machine # [ 84.790681] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 84.793554] systemd[1]: Finished linger-users.service. machine # [ 85.050011] nixos[5583]: finished switching to system configuration /nix/store/aimlgny0w4d7kzcl5s18aarxndx2lsy5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.87 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 85.281333] nixos[5725]: switching to system configuration /nix/store/d0c4i4jj4hf1805473vppz2hy63wxjp3-nixos-system-machine-test machine # [ 85.284770] systemd[1]: Stopped target Remote File Systems. machine # [ 85.287232] systemd[1]: Stopped target Local File Systems. machine # [ 85.585227] systemd[1]: Reload requested from client PID 5725 ('.switch-to-conf') (unit backdoor.service)... machine # [ 85.587540] systemd[1]: Reloading... machine # [ 85.977442] systemd[1]: Reloading finished in 387 ms. machine # [ 86.074489] systemd[584]: Reexecution requested from client PID 5794 ('switch-to-confi')... machine # [ 86.077499] systemd[584]: Reexecuting. machine # [ 86.144169] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.269144] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.276312] systemd[584]: Reload requested from client PID 5794 ('switch-to-confi')... machine # [ 86.280181] systemd[584]: Reloading... machine # [ 86.397628] systemd[584]: Reloading finished in 118 ms. machine # [ 86.413991] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.423997] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 86.426752] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 86.428977] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 86.467379] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 86.473196] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 86.474200] systemd[1]: Stopping Reactivate sysinit units... machine # [ 86.475042] systemd[1]: Reached target Reactivate sysinit units. machine # [ 86.478209] systemd[1]: test.service: Deactivated successfully. machine # [ 86.481767] systemd[1]: Stopped test.service. machine # [ 86.482557] systemd[1]: Stopping test.service... machine # [ 86.484794] systemd[1]: Starting test.service... machine # [ 86.513039] systemd[1]: Finished test.service. machine # [ 86.519428] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.524855] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 86.528677] systemd[1]: Reached target Local File Systems. machine # [ 86.533453] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 86.542020] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 86.543187] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 86.552616] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 86.555074] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 86.561289] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.562808] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.567605] systemd[1]: Reached target Remote File Systems. machine # [ 86.750512] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 86.753957] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 86.759074] systemd[1]: Starting linger-users.service... machine # [ 86.807566] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 86.809711] systemd[1]: Finished linger-users.service. machine # [ 87.067750] nixos[5725]: finished switching to system configuration /nix/store/d0c4i4jj4hf1805473vppz2hy63wxjp3-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 2.02 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 87.345715] nixos[5867]: switching to system configuration /nix/store/y7v56awzjbyl910qr87glv2m66jsihs0-nixos-system-machine-test machine # [ 87.348649] systemd[1]: Stopped target Remote File Systems. machine # [ 87.352317] systemd[1]: Stopped target Local File Systems. machine # [ 87.699406] systemd[1]: Reload requested from client PID 5867 ('.switch-to-conf') (unit backdoor.service)... machine # [ 87.701766] systemd[1]: Reloading... machine # [ 88.098691] systemd[1]: Reloading finished in 395 ms. machine # [ 88.203185] systemd[584]: Reexecution requested from client PID 5936 ('switch-to-confi')... machine # [ 88.208282] systemd[584]: Reexecuting. machine # [ 88.269027] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 88.412808] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 88.421292] systemd[584]: Reload requested from client PID 5936 ('switch-to-confi')... machine # [ 88.426176] systemd[584]: Reloading... machine # [ 88.555470] systemd[584]: Reloading finished in 130 ms. machine # [ 88.572336] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 88.585406] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 88.588084] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 88.590322] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 88.629752] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 88.634663] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 88.636887] systemd[1]: Stopping Reactivate sysinit units... machine # [ 88.637872] systemd[1]: Reached target Reactivate sysinit units. machine # [ 88.643153] systemd[1]: test.service: Deactivated successfully. machine # [ 88.646707] systemd[1]: Stopped test.service. machine # [ 88.647483] systemd[1]: Stopping test.service... machine # [ 88.652579] systemd[1]: Starting test.service... machine # [ 88.680196] systemd[1]: Finished test.service. machine # [ 88.684838] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 88.689544] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 88.690993] systemd[1]: Reached target Remote File Systems. machine # [ 88.696221] systemd[1]: Reached target Local File Systems. machine # [ 88.701210] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 88.702789] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 88.703999] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 88.713818] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 88.725317] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 88.727208] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 88.728705] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 88.913411] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 88.917214] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 88.923535] systemd[1]: Starting linger-users.service... machine # [ 88.977405] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 88.979646] systemd[1]: Finished linger-users.service. machine # [ 89.237657] nixos[5867]: finished switching to system configuration /nix/store/y7v56awzjbyl910qr87glv2m66jsihs0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 2.17 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 89.494444] nixos[6009]: switching to system configuration /nix/store/dr3ilxghz1xrg7di0pdgp7sqw437pn3k-nixos-system-machine-test machine # [ 89.497358] systemd[1]: Stopped target Local File Systems. machine # [ 89.500682] systemd[1]: Stopped target Remote File Systems. machine # [ 89.820727] systemd[1]: Reload requested from client PID 6009 ('.switch-to-conf') (unit backdoor.service)... machine # [ 89.822812] systemd[1]: Reloading... machine # [ 90.185462] systemd[1]: Reloading finished in 359 ms. machine # [ 90.283668] systemd[584]: Reexecution requested from client PID 6078 ('switch-to-confi')... machine # [ 90.288606] systemd[584]: Reexecuting. machine # [ 90.352108] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 90.484388] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 90.492275] systemd[584]: Reload requested from client PID 6078 ('switch-to-confi')... machine # [ 90.496596] systemd[584]: Reloading... machine # [ 90.613882] systemd[584]: Reloading finished in 118 ms. machine # [ 90.628213] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 90.641861] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 90.642967] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 90.649560] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 90.683203] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 90.687951] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 90.689542] systemd[1]: Stopping Reactivate sysinit units... machine # [ 90.690381] systemd[1]: Reached target Reactivate sysinit units. machine # [ 90.693180] systemd[1]: test.service: Deactivated successfully. machine # [ 90.696338] systemd[1]: Stopped test.service. machine # [ 90.697109] systemd[1]: Stopping test.service... machine # [ 90.699313] systemd[1]: Starting test.service... machine # [ 90.730162] systemd[1]: Finished test.service. machine # [ 90.735251] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 90.738562] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 90.745947] systemd[1]: Reached target Local File Systems. machine # [ 90.751955] systemd[1]: Reached target Remote File Systems. machine # [ 90.753174] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 90.758523] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 90.759607] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 90.768378] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 90.770723] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 90.784766] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 90.786180] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 90.987120] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 90.992697] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 90.995925] systemd[1]: Starting linger-users.service... machine # [ 91.041811] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 91.045053] systemd[1]: Finished linger-users.service. machine # [ 91.303043] nixos[6009]: finished switching to system configuration /nix/store/dr3ilxghz1xrg7di0pdgp7sqw437pn3k-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.06 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 91.568710] nixos[6151]: switching to system configuration /nix/store/dn5ixy46xnbp86zs0lv55rzdgxbr3r74-nixos-system-machine-test machine # [ 91.571360] systemd[1]: Stopped target Local File Systems. machine # [ 91.574608] systemd[1]: Stopped target Remote File Systems. machine # [ 91.912319] systemd[1]: Reload requested from client PID 6151 ('.switch-to-conf') (unit backdoor.service)... machine # [ 91.914364] systemd[1]: Reloading... machine # [ 92.278610] systemd[1]: Reloading finished in 362 ms. machine # [ 92.368463] systemd[584]: Reexecution requested from client PID 6219 ('switch-to-confi')... machine # [ 92.372119] systemd[584]: Reexecuting. machine # [ 92.432294] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.561080] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.568835] systemd[584]: Reload requested from client PID 6219 ('switch-to-confi')... machine # [ 92.573438] systemd[584]: Reloading... machine # [ 92.694385] systemd[584]: Reloading finished in 122 ms. machine # [ 92.708172] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.719729] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 92.722984] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 92.725994] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 92.762215] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 92.766734] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 92.768715] systemd[1]: Stopping Reactivate sysinit units... machine # [ 92.769635] systemd[1]: Reached target Reactivate sysinit units. machine # [ 92.775388] systemd[1]: Reloading test.service... machine # [ 92.802202] systemd[1]: Reloaded test.service. machine # [ 92.813601] systemd[1]: Reached target Local File Systems. machine # [ 92.816533] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 92.821988] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 92.823068] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 92.832424] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 92.834746] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 92.842136] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 92.843529] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 92.844926] systemd[1]: Reached target Remote File Systems. machine # [ 92.845737] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 92.847159] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 93.023816] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 93.027443] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 93.032789] systemd[1]: Starting linger-users.service... machine # [ 93.077939] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 93.080121] systemd[1]: Finished linger-users.service. machine # [ 93.338422] nixos[6151]: finished switching to system configuration /nix/store/dn5ixy46xnbp86zs0lv55rzdgxbr3r74-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 2.04 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 93.600893] nixos[6293]: switching to system configuration /nix/store/d3adqmbhym6rl42j7cq8abyn6k9vzix6-nixos-system-machine-test machine # [ 93.603911] systemd[1]: Stopped target Remote File Systems. machine # [ 93.607166] systemd[1]: Stopped target Local File Systems. machine # [ 93.936990] systemd[1]: Reload requested from client PID 6293 ('.switch-to-conf') (unit backdoor.service)... machine # [ 93.938692] systemd[1]: Reloading... machine # [ 94.333743] systemd[1]: Reloading finished in 393 ms. machine # [ 94.434056] systemd[584]: Reexecution requested from client PID 6362 ('switch-to-confi')... machine # [ 94.438663] systemd[584]: Reexecuting. machine # [ 94.487551] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.609911] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.617701] systemd[584]: Reload requested from client PID 6362 ('switch-to-confi')... machine # [ 94.620392] systemd[584]: Reloading... machine # [ 94.737100] systemd[584]: Reloading finished in 115 ms. machine # [ 94.752182] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.763063] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 94.765610] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 94.767822] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 94.802302] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 94.807080] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 94.811954] systemd[1]: Stopping Reactivate sysinit units... machine # [ 94.813172] systemd[1]: Reached target Reactivate sysinit units. machine # [ 94.815462] systemd[1]: Reloading test.service... machine # [ 94.843803] systemd[1]: Reloaded test.service. machine # [ 94.849828] systemd[1]: Reached target Local File Systems. machine # [ 94.853163] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 94.858817] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 94.859873] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 94.868759] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 94.871204] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 94.881893] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.883359] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.889167] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.890610] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 94.893565] systemd[1]: Reached target Remote File Systems. machine # [ 95.065241] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 95.067588] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 95.073107] systemd[1]: Starting linger-users.service... machine # [ 95.117441] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 95.120370] systemd[1]: Finished linger-users.service. machine # [ 95.377914] nixos[6293]: finished switching to system configuration /nix/store/d3adqmbhym6rl42j7cq8abyn6k9vzix6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 2.04 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 95.686604] nixos[6435]: switching to system configuration /nix/store/1wci6xgn4y1hw7530n0b7w1nk49fnp12-nixos-system-machine-test machine # [ 95.689721] systemd[1]: Stopped target Local File Systems. machine # [ 95.693346] systemd[1]: Stopped target Remote File Systems. machine # [ 96.041112] systemd[1]: Reload requested from client PID 6435 ('.switch-to-conf') (unit backdoor.service)... machine # [ 96.043272] systemd[1]: Reloading... machine # [ 96.419576] systemd[1]: Reloading finished in 374 ms. machine # [ 96.510360] systemd[584]: Reexecution requested from client PID 6504 ('switch-to-confi')... machine # [ 96.511931] systemd[584]: Reexecuting. machine # [ 96.572542] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.701349] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.709249] systemd[584]: Reload requested from client PID 6504 ('switch-to-confi')... machine # [ 96.713943] systemd[584]: Reloading... machine # [ 96.828780] systemd[584]: Reloading finished in 116 ms. machine # [ 96.840179] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.853194] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 96.855943] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 96.858335] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 96.894002] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 96.899352] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 96.901211] systemd[1]: Stopping Reactivate sysinit units... machine # [ 96.902167] systemd[1]: Reached target Reactivate sysinit units. machine # [ 96.905069] systemd[1]: test.service: Deactivated successfully. machine # [ 96.908440] systemd[1]: Stopped test.service. machine # [ 96.909227] systemd[1]: Stopping test.service... machine # [ 96.911619] systemd[1]: Starting test.service... machine # [ 96.938787] systemd[1]: Finished test.service. machine # [ 96.945049] systemd[1]: Reached target Local File Systems. machine # [ 96.948357] systemd[1]: Reached target Remote File Systems. machine # [ 96.955234] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 96.965383] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 96.966373] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 96.967829] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 96.977805] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 96.979818] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.981384] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.982599] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.983897] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 97.159022] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 97.164737] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 97.167813] systemd[1]: Starting linger-users.service... machine # [ 97.213341] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 97.216946] systemd[1]: Finished linger-users.service. machine # [ 97.474462] nixos[6435]: finished switching to system configuration /nix/store/1wci6xgn4y1hw7530n0b7w1nk49fnp12-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 2.10 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 97.704108] nixos[6577]: switching to system configuration /nix/store/aimlgny0w4d7kzcl5s18aarxndx2lsy5-nixos-system-machine-test machine # [ 97.709902] systemd[1]: Stopped target Local File Systems. machine # [ 97.710967] systemd[1]: Stopped target Remote File Systems. machine # [ 98.017408] systemd[1]: Reload requested from client PID 6577 ('.switch-to-conf') (unit backdoor.service)... machine # [ 98.019551] systemd[1]: Reloading... machine # [ 98.366574] systemd[1]: Reloading finished in 345 ms. machine # [ 98.456527] systemd[584]: Reexecution requested from client PID 6646 ('switch-to-confi')... machine # [ 98.460586] systemd[584]: Reexecuting. machine # [ 98.520175] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.641324] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.649103] systemd[584]: Reload requested from client PID 6646 ('switch-to-confi')... machine # [ 98.653572] systemd[584]: Reloading... machine # [ 98.763772] systemd[584]: Reloading finished in 111 ms. machine # [ 98.780209] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.791996] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 98.794886] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 98.797542] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 98.830720] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 98.835005] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 98.837728] systemd[1]: Stopping Reactivate sysinit units... machine # [ 98.838609] systemd[1]: Reached target Reactivate sysinit units. machine # [ 98.842380] systemd[1]: Reached target Remote File Systems. machine # [ 98.846526] systemd[1]: Starting linger-users.service... machine # [ 98.852336] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.853884] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 98.864777] systemd[1]: Reached target Local File Systems. machine # [ 98.866934] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 98.873896] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 98.874973] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 98.886990] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 98.897941] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 98.899741] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.905921] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.952173] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 98.957018] systemd[1]: Finished linger-users.service. machine # [ 99.104685] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 99.107139] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 99.364427] nixos[6577]: finished switching to system configuration /nix/store/aimlgny0w4d7kzcl5s18aarxndx2lsy5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.89 seconds) (finished: subtest: unit file parser, in 25.40 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 99.592606] nixos[6717]: switching to system configuration /nix/store/26kgqpn6pqlb7m87fy88ib26czqqb05r-nixos-system-machine-test machine # [ 99.595438] systemd[1]: Stopped target Remote File Systems. machine # [ 99.598083] systemd[1]: Stopped target Local File Systems. machine # [ 99.899693] systemd[1]: Reload requested from client PID 6717 ('.switch-to-conf') (unit backdoor.service)... machine # [ 99.902070] systemd[1]: Reloading... machine # [ 100.244561] systemd[1]: Reloading finished in 340 ms. machine # [ 100.336511] systemd[584]: Reexecution requested from client PID 6786 ('switch-to-confi')... machine # [ 100.340119] systemd[584]: Reexecuting. machine # [ 100.404865] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 100.521870] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 100.528681] systemd[584]: Reload requested from client PID 6786 ('switch-to-confi')... machine # [ 100.532145] systemd[584]: Reloading... machine # [ 100.641762] systemd[584]: Reloading finished in 110 ms. machine # [ 100.656189] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 100.667007] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 100.668280] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 100.670667] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 100.704949] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 100.709685] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 100.711783] systemd[1]: Stopping Reactivate sysinit units... machine # [ 100.714617] systemd[1]: Reached target Reactivate sysinit units. machine # [ 100.718875] systemd[1]: Reached target Local File Systems. machine # [ 100.719789] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 100.728607] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 100.729535] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 100.730882] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 100.743540] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 100.747099] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 100.748983] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 100.750276] systemd[1]: Reached target Remote File Systems. machine # [ 100.751607] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 100.754286] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 100.937515] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 100.943535] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 100.947638] systemd[1]: Starting linger-users.service... machine # [ 100.992357] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 100.994166] systemd[1]: Finished linger-users.service. machine # [ 101.251225] nixos[6717]: finished switching to system configuration /nix/store/26kgqpn6pqlb7m87fy88ib26czqqb05r-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.89 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 101.482544] nixos[6857]: switching to system configuration /nix/store/1d290issiyaj6kn9af321ardgspdzwf0-nixos-system-machine-test machine # [ 101.485276] systemd[1]: test.service: Deactivated successfully. machine # [ 101.488311] systemd[1]: Stopped test.service. machine # [ 101.489111] systemd[1]: Stopped target Local File Systems. machine # [ 101.490461] systemd[1]: Stopped target Remote File Systems. machine # [ 101.801474] systemd[1]: Reload requested from client PID 6857 ('.switch-to-conf') (unit backdoor.service)... machine # [ 101.803556] systemd[1]: Reloading... machine # [ 102.144737] systemd[1]: Reloading finished in 339 ms. machine # [ 102.239542] systemd[584]: Reexecution requested from client PID 6928 ('switch-to-confi')... machine # [ 102.242197] systemd[584]: Reexecuting. machine # [ 102.303533] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 102.418895] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 102.426366] systemd[584]: Reload requested from client PID 6928 ('switch-to-confi')... machine # [ 102.428676] systemd[584]: Reloading... machine # [ 102.536128] systemd[584]: Reloading finished in 106 ms. machine # [ 102.552195] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 102.561573] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 102.564116] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 102.566431] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 102.601247] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 102.605266] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 102.606342] systemd[1]: Stopping Reactivate sysinit units... machine # [ 102.607289] systemd[1]: Reached target Reactivate sysinit units. machine # [ 102.614403] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 102.619103] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 102.638669] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 102.641766] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 102.647643] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 102.649521] systemd[1]: Reached target Remote File Systems. machine # [ 102.656912] systemd[1]: Starting linger-users.service... machine # [ 102.657934] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 102.676814] systemd[1]: Starting reload-triggers.service... machine # [ 102.683023] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 102.691344] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 102.710169] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 102.731573] systemd[1]: Starting simple-reload-service.service... machine # [ 102.744506] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 102.767285] systemd[1]: Starting no-restart-service.service... machine # [ 102.777202] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 102.778401] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 102.815506] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 102.837875] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 102.839591] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 102.896455] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 102.931524] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 102.956287] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 102.957827] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 102.959178] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 103.002837] systemd[1]: Reached target Local File Systems. machine # [ 103.017461] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 103.035937] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 103.041683] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 103.043064] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 103.063209] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 103.070934] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.075572] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.078202] systemd[1]: Finished reload-triggers.service. machine # [ 103.079049] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 103.084477] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 103.085685] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 103.086644] systemd[1]: Finished simple-reload-service.service. machine # [ 103.087500] systemd[1]: Finished no-restart-service.service. machine # [ 103.089415] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 103.091230] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 103.094007] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 103.095238] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 103.098025] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 103.099831] systemd[1]: Finished linger-users.service. machine # [ 103.236337] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 103.239536] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 103.244289] systemd[1]: Starting simple-restart-service.service... machine # [ 103.248813] systemd[1]: Starting simple-service.service... machine # [ 103.291597] systemd[1]: Finished simple-restart-service.service. machine # [ 103.295443] systemd[1]: Finished simple-service.service. machine # [ 103.552533] nixos[6857]: finished switching to system configuration /nix/store/1d290issiyaj6kn9af321ardgspdzwf0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.30 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 103.804513] nixos[7027]: switching to system configuration /nix/store/1d290issiyaj6kn9af321ardgspdzwf0-nixos-system-machine-test machine # [ 103.807136] systemd[1]: Stopped target Remote File Systems. machine # [ 103.810168] systemd[1]: Stopped target Local File Systems. machine # [ 104.135108] systemd[1]: Reload requested from client PID 7027 ('.switch-to-conf') (unit backdoor.service)... machine # [ 104.137541] systemd[1]: Reloading... machine # [ 104.482432] systemd[1]: Reloading finished in 343 ms. machine # [ 104.576554] systemd[584]: Reexecution requested from client PID 7098 ('switch-to-confi')... machine # [ 104.579392] systemd[584]: Reexecuting. machine # [ 104.635495] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 104.747515] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 104.754191] systemd[584]: Reload requested from client PID 7098 ('switch-to-confi')... machine # [ 104.758041] systemd[584]: Reloading... machine # [ 104.864113] systemd[584]: Reloading finished in 107 ms. machine # [ 104.880179] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 104.890817] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 104.893217] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 104.895551] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 104.928834] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 104.933043] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 104.935512] systemd[1]: Stopping Reactivate sysinit units... machine # [ 104.939954] systemd[1]: Reached target Reactivate sysinit units. machine # [ 104.942128] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 104.947765] systemd[1]: Reloading reload-triggers.service... machine # [ 104.955921] systemd[1]: Reloading simple-reload-service.service... machine # [ 104.968935] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 104.986338] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 104.998246] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 105.047792] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 105.076667] systemd[1]: Reloaded reload-triggers.service. machine # [ 105.082461] systemd[1]: Reloaded simple-reload-service.service. machine # [ 105.083577] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 105.089912] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 105.094985] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 105.098937] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 105.102877] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 105.103905] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 105.106869] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 105.116808] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 105.117979] systemd[1]: Stopped simple-restart-service.service. machine # [ 105.118990] systemd[1]: Stopping simple-restart-service.service... machine # [ 105.119854] systemd[1]: Starting simple-restart-service.service... machine # [ 105.145835] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 105.146909] systemd[1]: Stopped simple-service.service. machine # [ 105.147657] systemd[1]: Stopping simple-service.service... machine # [ 105.163930] systemd[1]: Starting simple-service.service... machine # [ 105.171439] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 105.185107] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 105.196223] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 105.208487] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 105.223191] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 105.235900] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 105.246358] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 105.247698] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 105.260928] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 105.262330] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 105.263468] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 105.267166] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 105.269636] systemd[1]: Finished simple-restart-service.service. machine # [ 105.273111] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 105.274211] systemd[1]: Finished simple-service.service. machine # [ 105.275084] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 105.278109] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 105.279430] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 105.287057] systemd[1]: Reached target Remote File Systems. machine # [ 105.292381] systemd[1]: Starting linger-users.service... machine # [ 105.300877] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 105.302300] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 105.306854] systemd[1]: Reached target Local File Systems. machine # [ 105.307819] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 105.318352] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 105.319368] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 105.328752] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 105.331162] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 105.339947] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 105.345655] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 105.393530] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 105.397889] systemd[1]: Finished linger-users.service. machine # [ 105.553384] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 105.556441] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 105.813598] nixos[7027]: finished switching to system configuration /nix/store/1d290issiyaj6kn9af321ardgspdzwf0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.26 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 106.093431] nixos[7193]: switching to system configuration /nix/store/yka2qjwgp43ggxd0a70cpd2a2c88v6ha-nixos-system-machine-test machine # [ 106.096072] systemd[1]: Stopped target Remote File Systems. machine # [ 106.098709] systemd[1]: Stopped target Local File Systems. machine # [ 106.446930] systemd[1]: Reload requested from client PID 7193 ('.switch-to-conf') (unit backdoor.service)... machine # [ 106.449475] systemd[1]: Reloading... machine # [ 106.819684] systemd[1]: Reloading finished in 369 ms. machine # [ 106.920501] systemd[584]: Reexecution requested from client PID 7263 ('switch-to-confi')... machine # [ 106.924096] systemd[584]: Reexecuting. machine # [ 106.983508] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.097353] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.104136] systemd[584]: Reload requested from client PID 7263 ('switch-to-confi')... machine # [ 107.106839] systemd[584]: Reloading... machine # [ 107.214498] systemd[584]: Reloading finished in 106 ms. machine # [ 107.232206] systemd[584]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.243013] systemd[584]: Stopped Run user-specific NixOS activation. machine # [ 107.245504] systemd[584]: Stopping Run user-specific NixOS activation... machine # [ 107.247827] systemd[584]: Starting Run user-specific NixOS activation... machine # [ 107.280122] systemd[584]: Finished Run user-specific NixOS activation. machine # [ 107.284105] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 107.288393] systemd[1]: Stopping Reactivate sysinit units... machine # [ 107.289334] systemd[1]: Reached target Reactivate sysinit units. machine # [ 107.292887] systemd[1]: Reloading reload-triggers.service... machine # [ 107.303400] systemd[1]: Reloading simple-reload-service.service... machine # [ 107.312658] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 107.320497] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 107.372784] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 107.379497] systemd[1]: Reloaded reload-triggers.service. machine # [ 107.383206] systemd[1]: Reloaded simple-reload-service.service. machine # [ 107.384581] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 107.388244] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 107.389483] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 107.390478] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 107.394270] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 107.398376] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 107.399655] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 107.408615] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 107.409633] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 107.410546] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 107.411590] systemd[1]: Stopped simple-restart-service.service. machine # [ 107.443132] systemd[1]: Stopping simple-restart-service.service... machine # [ 107.456232] systemd[1]: Starting simple-restart-service.service... machine # [ 107.457232] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 107.458335] systemd[1]: Stopped simple-service.service. machine # [ 107.459126] systemd[1]: Stopping simple-service.service... machine # [ 107.459903] systemd[1]: Starting simple-service.service... machine # [ 107.499532] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 107.513384] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 107.527826] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 107.546358] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 107.567515] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 107.582371] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 107.591247] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 107.597313] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 107.605350] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 107.607360] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 107.609065] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 107.612246] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 107.613456] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 107.614645] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 107.615697] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 107.623872] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 107.625296] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 107.626292] systemd[1]: Finished simple-restart-service.service. machine # [ 107.627180] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 107.628484] systemd[1]: Finished simple-service.service. machine # [ 107.629262] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 107.630465] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 107.631705] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 107.646450] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 107.647660] systemd[1]: Reached target Remote File Systems. machine # [ 107.656994] systemd[1]: Starting linger-users.service... machine # [ 107.657863] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 107.659185] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 107.667798] systemd[1]: Reached target Local File Systems. machine # [ 107.671886] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 107.676835] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 107.680832] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 107.686047] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 107.694146] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 107.696001] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 107.701458] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 107.737189] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 107.739219] systemd[1]: Finished linger-users.service. machine # [ 107.870100] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 107.873784] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 108.128608] nixos[7193]: finished switching to system configuration /nix/store/yka2qjwgp43ggxd0a70cpd2a2c88v6ha-nixos-system-machine-test machine: (finished: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.32 seconds) machine: must succeed: /nix/store/56z5g30mv65bfjql28aa1f5ricvmm22j-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/56z5g30mv65bfjql28aa1f5ricvmm22j-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.35 seconds) (finished: subtest: restart and reload by activation script, in 9.12 seconds) (finished: run the VM test script, in 109.57 seconds) test script finished in 109.67s cleanup kill QemuMachine (pid 45) machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lq2fsnmg0q3y0vlxn91w8s8wvj1m6fld-python3-3.14.8/bin/python3.14) machine # [2026-10-24T03:03:49Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-24T03:03:49Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-24T03:03:49Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.18 seconds) additionally exposed symbols: machine, other, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh