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.I8CO0IfISN', 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: 2f4c355d-c499-4507-bb34-03136a09c552 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-14T03:13:54Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-14T03:13:54Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-14T03:13:54Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-14T03:13:54Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-14T03:13:54Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-14T03:13:54Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-14T03:13:54Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-14T03:13:54Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-14T03:13:54Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-14T03:13:54Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-14T03:13:54Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-14T03:13:54Z INFO virtiofsd] Client connected, servicing requests machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.55 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Sat Oct 3 10:39:03 UTC 2026 machine # [ 0.000000] KASLR enabled machine # [ 0.000000] random: crng init done machine # [ 0.000000] Machine model: linux,dummy-virt machine # [ 0.000000] efi: UEFI not found. machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f] machine # [ 0.000000] Zone ranges: machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] DMA32 empty machine # [ 0.000000] Normal empty machine # [ 0.000000] Device empty machine # [ 0.000000] Movable zone start for each node machine # [ 0.000000] Early memory node ranges machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000 machine # [ 0.000000] psci: probing for conduit method from DT. machine # [ 0.000000] psci: PSCIv1.3 detected in firmware. machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs machine # [ 0.000000] psci: Trusted OS migration not required machine # [ 0.000000] psci: SMC Calling Convention v1.1 machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186840 r8192 d116264 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/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/init regInfo=/nix/.ro-store/ici2f5s61h9mg1dgs393ipg2y284ws0n-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/ici2f5s61h9mg1dgs393ipg2y284ws0n-closure-info/registration", will be passed to user space. machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB machine # [ 0.000000] software IO TLB: area num 1. machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB) machine # [ 0.000000] Fallback order for Node 0: 0 machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 machine # [ 0.000000] Policy zone: DMA machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.000000] allocated 2097152 bytes of page_ext machine # [ 0.000000] ftrace: allocating 75039 entries in 294 pages machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups machine # [ 0.000000] rcu: Hierarchical RCU implementation. machine # [ 0.000000] rcu: RCU event tracing is enabled. machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. machine # [ 0.000000] Rude variant of Tasks RCU enabled. machine # [ 0.000000] Tracing variant of Tasks RCU enabled. machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 machine # [ 0.000000] GICv3: 256 SPIs implemented machine # [ 0.000000] GICv3: 0 Extended SPIs implemented machine # [ 0.000000] Root IRQ handler: gic_handle_irq machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1) machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1) machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000 machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns machine # [ 0.000036] arm-pv: using stolen time PV machine # [ 0.000570] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000773] Console: colour dummy device 80x25 machine # [ 0.000782] printk: legacy console [tty0] enabled machine # [ 0.000973] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000980] pid_max: default: 32768 minimum: 301 machine # [ 0.001066] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.001244] landlock: Up and running. machine # [ 0.001248] Yama: becoming mindful. machine # [ 0.001817] LSM support for eBPF active machine # [ 0.001957] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.001978] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.004138] rcu: Hierarchical SRCU implementation. machine # [ 0.004145] rcu: Max phase no-delay instances is 1000. machine # [ 0.005529] fsl-mc MSI: its@8080000 domain created machine # [ 0.005657] EFI services will not be available. machine # [ 0.005758] smp: Bringing up secondary CPUs ... machine # [ 0.005769] smp: Brought up 1 node, 1 CPU machine # [ 0.005772] SMP: Total of 1 processors activated. machine # [ 0.005775] CPU: All CPU(s) started at EL1 machine # [ 0.005790] CPU features: detected: Branch Target Identification machine # [ 0.005798] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.005801] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.005804] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.005808] CPU features: detected: Common not Private translations machine # [ 0.005812] CPU features: detected: CRC32 instructions machine # [ 0.005815] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.005818] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.005821] CPU features: detected: Data independent timing control (DIT) machine # [ 0.005825] CPU features: detected: E0PD machine # [ 0.005827] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.005830] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.005834] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.005837] CPU features: detected: Fine Grained Traps machine # [ 0.005848] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.005855] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.005858] CPU features: detected: LSE atomic instructions machine # [ 0.005861] CPU features: detected: Privileged Access Never machine # [ 0.005864] CPU features: detected: PMUv3 machine # [ 0.005866] CPU features: detected: RAS Extension Support machine # [ 0.005869] CPU features: detected: RASv1p1 Extension Support machine # [ 0.005872] CPU features: detected: Random Number Generator machine # [ 0.005874] CPU features: detected: Speculation barrier (SB) machine # [ 0.005877] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.005880] CPU features: detected: TLB range maintenance instructions machine # [ 0.005885] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.005926] alternatives: applying system-wide alternatives machine # [ 0.009173] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.009373] Memory: 892884K/1048576K available (24576K kernel code, 7094K rwdata, 26568K rodata, 4736K init, 1106K bss, 114372K reserved, 32768K cma-reserved) machine # [ 0.009838] devtmpfs: initialized machine # [ 0.011734] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.011762] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.011970] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.011979] 0 pages in range for non-PLT usage machine # [ 0.011980] 508192 pages in range for PLT usage machine # [ 0.012102] pinctrl core: initialized pinctrl subsystem machine # [ 0.013024] DMI not present or invalid. machine # [ 0.017058] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.019548] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.019711] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.019869] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.019894] audit: initializing netlink subsys (disabled) machine # [ 0.020481] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.020483] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.020486] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.020489] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.020491] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.020522] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 machine # [ 0.020532] cpuidle: using governor ladder machine # [ 0.020539] cpuidle: using governor menu machine # [ 0.020747] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.020770] ASID allocator initialised with 65536 entries machine # [ 0.022165] Serial: AMBA PL011 UART driver machine # [ 0.028220] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.028388] printk: console [ttyAMA0] enabled machine # [ 0.162204] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.162215] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.162218] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.162221] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.162224] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.162227] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.162229] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.162232] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.163514] fbcon: Taking over console machine # [ 0.163530] ACPI: Interpreter disabled. machine # [ 0.172682] iommu: Default domain type: Translated machine # [ 0.172688] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.173116] SCSI subsystem initialized machine # [ 0.173327] usbcore: registered new interface driver usbfs machine # [ 0.173358] usbcore: registered new interface driver hub machine # [ 0.173375] usbcore: registered new device driver usb machine # [ 0.173681] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.173685] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.173693] PTP clock support registered machine # [ 0.173746] EDAC MC: Ver: 3.0.0 machine # [ 0.183580] scmi_core: SCMI protocol bus registered machine # [ 0.184059] FPGA manager framework machine # [ 0.185814] vgaarb: loaded machine # [ 0.186104] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.193755] VFS: Disk quotas dquot_6.6.0 machine # [ 0.193782] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.197571] netfs: FS-Cache loaded machine # [ 0.197714] pnp: PnP ACPI: disabled machine # [ 0.202386] NET: Registered PF_INET protocol family machine # [ 0.202552] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.234001] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.234046] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.234069] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.237499] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.237575] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.237665] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.237700] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.237722] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.237806] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.237854] NET: Registered PF_XDP protocol family machine # [ 0.237873] PCI: CLS 0 bytes, default 64 machine # [ 0.238144] Trying to unpack rootfs image as initramfs... machine # [ 0.253383] kvm [1]: HYP mode not available machine # [ 0.351941] Initialise system trusted keyrings machine # [ 0.352096] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.352514] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.352561] 9p: Installing v9fs 9p2000 file system support machine # [ 0.380794] Key type asymmetric registered machine # [ 0.380812] Asymmetric key parser 'x509' registered machine # [ 0.380900] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.381043] io scheduler mq-deadline registered machine # [ 0.381048] io scheduler kyber registered machine # [ 0.394280] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.395002] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.395443] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.395460] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.395470] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.395476] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.395502] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.395526] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.395603] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.395611] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.395615] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.395618] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.395621] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.395705] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.396180] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.396376] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.396388] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.396414] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.396426] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.396904] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.397092] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.397104] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.397132] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.397610] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.397805] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.397817] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.397844] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.430466] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.430675] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.430687] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.430713] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.430725] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.431305] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.431499] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.431525] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.432000] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.432192] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.432217] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.432627] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.432811] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.433088] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.433283] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.433310] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.433780] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.433970] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.433996] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.451854] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.452046] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.452072] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.452561] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.452884] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.452896] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.452922] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.453405] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.453600] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.453611] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.453638] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.470429] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.470442] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.470446] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.470498] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.470543] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.470587] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.470633] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.470677] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.470722] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.470768] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.470813] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.470857] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.470979] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.471024] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.471042] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.471059] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.471077] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.471173] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.471197] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.471214] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.471236] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.471254] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.471277] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.471295] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.471316] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.471333] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.471351] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.471371] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned machine # [ 0.471388] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned machine # [ 0.471406] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.471424] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.471447] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.471452] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.471455] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.472329] pci 0000:00:07.0: enabling device (0000 -> 0002) machine # [ 0.525362] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.535731] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.537833] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.541467] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.551590] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002) machine # [ 0.553595] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002) machine # [ 0.557168] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.567216] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.569059] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.572430] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.582753] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.588999] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.591887] msm_serial: driver initialized machine # [ 0.592044] SuperH (H)SCI(F) driver initialized machine # [ 0.592104] STM32 USART driver initialized machine # [ 0.629043] loop: module loaded machine # [ 0.629252] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 0.630099] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.642249] megasas: 07.734.00.00-rc1 machine # [ 0.643115] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.645000] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.645016] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.650212] Using buffer write method machine # [ 0.650245] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.651619] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.651633] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.652946] Using buffer write method machine # [ 0.652962] Concatenating MTD devices: machine # [ 0.652965] (0): "0.flash" machine # [ 0.652967] (1): "0.flash" machine # [ 0.652969] into device "0.flash" machine # [ 0.966769] Freeing initrd memory: 27128K machine # [ 0.972755] tun: Universal TUN/TAP device driver, 1.6 machine # [ 0.977303] thunder_xcv, ver 1.0 machine # [ 0.977333] thunder_bgx, ver 1.0 machine # [ 0.977352] nicpf, ver 1.0 machine # [ 0.977920] e1000: Intel(R) PRO/1000 Network Driver machine # [ 0.977924] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 0.977951] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 0.977957] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 0.977982] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 0.977985] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 0.978005] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 0.978009] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 0.985236] sky2: driver version 1.30 machine # [ 0.987443] usbcore: registered new interface driver usb-storage machine # [ 0.987535] usbcore: registered new interface driver usbserial_generic machine # [ 0.987545] usbserial: USB Serial support registered for generic machine # [ 0.988177] hv_vmbus: registering driver hyperv_keyboard machine # [ 0.989488] ehci-pci 0000:00:07.0: EHCI Host Controller machine # [ 0.989507] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1 machine # [ 0.989721] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000 machine # [ 0.990046] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 0.990074] rtc-pl031 9010000.pl031: setting system clock to 2026-10-14T03:13:55 UTC (1791947635) machine # [ 0.997736] i2c_dev: i2c /dev entries driver machine # [ 0.998150] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00 machine # [ 0.998536] hub 1-0:1.0: USB hub found machine # [ 0.998554] hub 1-0:1.0: 6 ports detected machine # [ 1.004350] sdhci: Secure Digital Host Controller Interface driver machine # [ 1.004355] sdhci: Copyright(c) Pierre Ossman machine # [ 1.004636] Synopsys Designware Multimedia Card Interface Driver machine # [ 1.005014] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 1.009571] hid: raw HID events driver (C) Jiri Kosina machine # [ 1.009816] usbcore: registered new interface driver usbhid machine # [ 1.009820] usbhid: USB HID core driver machine # [ 1.012941] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 1.015790] drop_monitor: Initializing network drop monitor service machine # [ 1.016012] NET: Registered PF_INET6 protocol family machine # [ 1.016573] Segment Routing with IPv6 machine # [ 1.016598] In-situ OAM (IOAM) with IPv6 machine # [ 1.016625] NET: Registered PF_PACKET protocol family machine # [ 1.016688] 9pnet: Installing 9P2000 support machine # [ 1.016727] Key type dns_resolver registered machine # [ 1.027068] registered taskstats version 1 machine # [ 1.027228] Loading compiled-in X.509 certificates machine # [ 1.035654] Demotion targets for Node 0: null machine # [ 1.035765] Key type .fscrypt registered machine # [ 1.035769] Key type fscrypt-provisioning registered machine # [ 1.035866] ima: No TPM chip found, activating TPM-bypass! machine # [ 1.035883] ima: Allocated hash algorithm: sha1 machine # [ 1.035908] ima: No architecture policies found machine # [ 1.036559] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 1.058628] clk: Disabling unused clocks machine # [ 1.058645] PM: genpd: Disabling unused power domains machine # [ 1.061862] Freeing unused kernel memory: 4736K machine # [ 1.062068] Run /init as init process machine # [ 1.080615] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.081066] systemd[1]: systemd 263-195a17c 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.081080] systemd[1]: Detected virtualization qemu. machine # [ 1.081115] systemd[1]: Detected architecture arm64. machine # [ 1.081121] systemd[1]: Running in initrd. machine # [ 1.081402] systemd[1]: Initializing machine ID from random generator. machine # [ 1.081495] systemd[1]: Hostname set to . machine # [ 1.178416] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.231386] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.237256] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.237435] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.237461] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.237482] systemd[1]: Reached target Path Units. machine # [ 1.237495] systemd[1]: Reached target Slice Units. machine # [ 1.237511] systemd[1]: Reached target Swaps. machine # [ 1.237526] systemd[1]: Reached target Timer Units. machine # [ 1.237654] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.237802] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.237951] systemd[1]: Listening on Journal Sockets. machine # [ 1.238024] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.238039] systemd[1]: Reached target Socket Units. machine # [ 1.246811] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.248516] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.248572] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.257916] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.272322] systemd[1]: Starting Journal Service... machine # [ 1.285980] systemd[1]: Starting Load Kernel Modules... machine # [ 1.286082] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.310757] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.334575] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.334904] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.336049] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.340491] systemd-journald[71]: Collecting audit messages is disabled. machine # [ 1.342952] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.354255] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.369053] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0 machine # [ 1.369308] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.369311] [drm] features: -context_init machine # [ 1.370047] [drm] number of scanouts: 1 machine # [ 1.370058] [drm] number of cap sets: 0 machine # [ 1.386668] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic machine # [ 1.386680] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0 machine # [ 1.395796] 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.410006] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.414480] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.420594] Console: switching to colour frame buffer device 160x50 machine # [ 1.442797] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.452913] systemd[1]: Finished Load Kernel Modules. machine # [ 1.458419] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.482348] 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.490513] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.490764] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.490795] systemd[1]: Reached target Local File Systems. machine # [ 1.497014] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.521321] systemd[1]: Started Journal Service. machine # [ 1.508285] systemd-modules-load[72]: Inserted module 'dm_mod' machine # [ 1.516608] systemd-modules-load[72]: Module 'virtio_balloon' is built in machine # [ 1.517858] systemd-modules-load[72]: Module 'virtio_console' is built in machine # [ 1.518957] systemd-modules-load[72]: Inserted module 'virtio_gpu' machine # [ 1.530842] systemd-modules-load[72]: Module 'virtio_rng' is built in machine # [ 1.536330] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.539012] systemd[1]: Starting Create System Files and Directories... machine # [ 1.578733] systemd[1]: Finished Create System Files and Directories. machine # [ 1.586980] systemd-udevd[80]: Using default interface naming scheme 'v261'. machine # [ 1.602213] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.611701] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.704369] systemd[1]: Starting Virtual Console Setup... machine # [ 1.768026] 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.768277] 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.788954] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 1.800409] systemd[1]: Finished Virtual Console Setup. machine # [ 2.472443] (udev-worker)[97]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.519440] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.532256] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.535002] systemd[1]: Reached target System Initialization. machine # [ 2.536839] systemd[1]: Reached target Basic System. machine # [ 2.548496] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.552154] systemd[1]: Reached target Initrd Root Device. machine # [ 2.556731] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 2.608560] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 2.615996] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.620189] systemd[1]: Mounting /sysroot... machine # [ 2.658811] systemd[1]: Mounted /sysroot. machine # [ 2.674957] EXT4-fs (vda): mounted filesystem 2f4c355d-c499-4507-bb34-03136a09c552 r/w with ordered data mode. Quota mode: none. machine # [ 2.662445] systemd[1]: Reached target Initrd Root File System. machine # [ 2.668760] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 2.687718] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 2.692198] systemd[1]: Mounting /sysroot/run... machine # [ 2.715284] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 2.739786] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 2.755517] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.819974] fuse: init (API version 7.45) machine # [ 2.806790] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 2.828700] virtiofs virtio6: discovered new tag: nix-store machine # [ 2.829515] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 2.848831] virtiofs virtio7: discovered new tag: shared machine # [ 2.849639] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 2.842821] systemd-sysroot-fstab-check[124]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.867847] virtiofs virtio8: discovered new tag: xchg machine # [ 2.868654] virtiofs virtio8: virtio_fs_setup_dax: No cache capability machine # [ 2.856534] systemd[1]: Mounted /sysroot/run. machine # [ 2.879666] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 2.884501] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 2.885915] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 2.888659] systemd[1]: Reload requested from client PID 124 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.895162] systemd[1]: Reloading... machine # [ 3.088876] systemd[1]: Reloading finished in 196 ms. machine # [ 3.123406] systemd-sysroot-fstab-check[124]: Requesting initrd-fs.target/start/replace... machine # [ 3.130860] systemd-sysroot-fstab-check[124]: Requesting swap.target/start/replace... machine # [ 3.136946] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.139342] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.146581] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.149093] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.176397] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.178078] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.300540] systemd[1]: Mounting /sysroot/nix/store... machine # [ 3.346728] systemd[1]: Mounted /sysroot/nix/store. machine # [ 3.347870] systemd[1]: Reached target Initrd File Systems. machine # [ 3.350730] systemd[1]: Starting Find NixOS closure... machine # [ 3.362066] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 3.408123] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 3.410413] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 3.427808] systemd[1]: Finished Find NixOS closure. machine # [ 3.430815] systemd[1]: Reached target Initrd Default Target. machine # [ 3.436861] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 3.470492] systemd[1]: Stopped target Initrd Default Target. machine # [ 3.471984] systemd[1]: Stopped target Basic System. machine # [ 3.476906] systemd[1]: Stopped target Initrd Root Device. machine # [ 3.478917] systemd[1]: Stopped target Path Units. machine # [ 3.480109] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 3.483227] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 3.488763] systemd[1]: Stopped target Slice Units. machine # [ 3.490263] systemd[1]: Stopped target Socket Units. machine # [ 3.492054] systemd[1]: Stopped target System Initialization. machine # [ 3.497814] systemd[1]: Stopped target Swaps. machine # [ 3.499577] systemd[1]: Stopped target Timer Units. machine # [ 3.501268] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 3.504521] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 3.508180] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 3.510653] systemd[1]: Stopped Find NixOS closure. machine # [ 3.516223] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.519120] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 3.522713] systemd[1]: Stopped Apply Kernel Variables. machine # [ 3.527290] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 3.533120] systemd[1]: Stopped Load Kernel Modules. machine # [ 3.533920] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 3.535183] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 3.544389] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 3.545566] systemd[1]: Stopped Create System Files and Directories. machine # [ 3.548905] systemd[1]: Stopped target Local File Systems. machine # [ 3.550517] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 3.553155] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 3.555789] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 3.557719] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 3.560349] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 3.564429] systemd[1]: Stopped Virtual Console Setup. machine # [ 3.565361] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 3.566624] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 3.567672] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.568863] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.569743] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 3.570691] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 3.571723] systemd[1]: Starting Cleanup udev Database... machine # [ 3.576255] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 3.578379] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 3.584377] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 3.585658] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 3.586842] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 3.587855] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 3.609344] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 3.611956] systemd[1]: Finished Cleanup udev Database. machine # [ 3.613394] systemd[1]: Reached target Switch Root. machine # [ 3.614719] systemd[1]: Starting NixOS Activation... machine # [ 3.696877] initrd-nixos-activation-start[170]: booting system configuration /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test machine # [ 3.729216] initrd-nixos-activation-start[170]: running activation script... machine # [ 3.946447] initrd-nixos-activation-start[193]: setting up /etc... machine # [ 4.065963] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 4.069221] systemd[1]: Finished NixOS Activation. machine # [ 4.070621] systemd[1]: Starting Switch Root... machine # [ 4.092951] systemd[1]: Switching root. machine # [ 4.275725] systemd-journald[71]: Received SIGTERM from PID 1 (systemd). machine # [ 4.410404] systemd[1]: systemd 263-195a17c 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 # [ 4.411386] systemd[1]: Detected virtualization qemu. machine # [ 4.411809] systemd[1]: Detected architecture arm64. machine # [ 4.412177] systemd[1]: Detected first boot. machine # [ 4.413616] systemd[1]: Initializing machine ID from random generator. machine # [ 4.538763] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 4.704868] systemd[1]: Applying preset policy. machine # [ 4.942929] systemd[1]: Populated /etc with preset unit settings. machine # [ 5.145519] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 5.148643] systemd[1]: Stopped initrd-switch-root.service. machine # [ 5.153080] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 5.157275] systemd[1]: Created slice Slice /system/getty. machine # [ 5.160351] systemd[1]: Created slice User and Session Slice. machine # [ 5.161026] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 5.161826] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 5.166227] systemd[1]: Expecting device /dev/hvc0... machine # [ 5.166708] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 5.167765] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 5.168523] systemd[1]: Stopped target initrd-fs.target. machine # [ 5.169212] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 5.169896] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 5.174998] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 5.175897] systemd[1]: Reached target Path Units. machine # [ 5.176575] systemd[1]: Reached target Remote File Systems. machine # [ 5.177257] systemd[1]: Reached target Slice Units. machine # [ 5.177915] systemd[1]: Reached target Swaps. machine # [ 5.184078] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 5.187351] systemd[1]: Listening on Process Core Dump Socket. machine # [ 5.188883] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 5.192083] systemd[1]: Listening on Factory Reset Management. machine # [ 5.192684] systemd[1]: Listening on Hostname Service Socket. machine # [ 5.199365] systemd[1]: Starting Journal Log Access Socket... machine # [ 5.200696] systemd[1]: Listening on Journal Audit Socket. machine # [ 5.204730] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 5.205736] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 5.209249] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.212348] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 5.218740] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 5.219570] systemd[1]: Listening on udev Varlink Socket. machine # [ 5.224781] systemd[1]: Mounting Huge Pages File System... machine # [ 5.230381] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 5.246326] systemd[1]: Mounting Kernel Debug File System... machine # [ 5.261957] systemd[1]: Mounting Kernel Trace File System... machine # [ 5.279493] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 5.283683] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 5.303650] systemd[1]: Mounting Kernel Configuration File System... machine # [ 5.317153] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 5.317956] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 5.324346] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 5.342801] systemd[1]: Mounting FUSE Control File System... machine # [ 5.350098] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 5.382786] systemd[1]: Starting Journal Service... machine # [ 5.396337] systemd[1]: Starting Load Kernel Modules... machine # [ 5.421040] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 5.452059] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 5.452482] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.460548] systemd-journald[265]: Collecting audit messages is enabled. machine # [ 5.454180] systemd[1]: Queued start job for default target Multi-User System. machine # [ 5.474961] systemd[1]: Starting Coldplug All udev Devices... machine # [ 5.477894] systemd[1]: Started Journal Service. machine # [ 5.463149] systemd[1]: Unnecessary job was removed for /sys/devices/platform/9000000.pl011/9000000.pl011:0/9000000.pl011:0.0/tty/ttyAMA0. machine # [ 5.466250] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0. machine # [ 5.467562] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 5.496709] systemd[1]: Listening on Journal Log Access Socket. machine # [ 5.501369] systemd[1]: Mounted Huge Pages File System. machine # [ 5.502366] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 5.503289] systemd[1]: Mounted Kernel Debug File System. machine # [ 5.510117] systemd[1]: Mounted Kernel Trace File System. machine # [ 5.519045] systemd-modules-load[266]: Module 'atkbd' is built in machine # [ 5.528187] systemd-modules-load[266]: Module 'loop' is built in machine # [ 5.529289] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 5.548896] systemd[1]: Finished Load Kernel Modules. machine # [ 5.576343] systemd[1]: Starting Firewall... machine # [ 5.591725] systemd[1]: Starting Apply Kernel Variables... machine # [ 5.618538] EXT4-fs (vda): re-mounted 2f4c355d-c499-4507-bb34-03136a09c552. machine # [ 5.611120] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 5.616313] systemd[1]: Mounted Kernel Configuration File System. machine # [ 5.632490] systemd-oomd[267]: No swap; memory pressure usage will be degraded machine # [ 5.641162] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 5.642291] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 5.663754] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 5.676734] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 5.698672] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 5.699694] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.713161] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 5.714174] systemd[1]: Mounted FUSE Control File System. machine # [ 5.831503] systemd-journald[265]: Received client request to flush runtime journal. machine # [ 5.899098] systemd[1]: Finished Apply Kernel Variables. machine # [ 5.908258] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 5.918169] systemd[1]: Reached target First Boot Complete. machine # [ 5.919158] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 5.924285] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 5.925856] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 6.068922] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 6.076105] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 6.078907] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 6.137210] systemd[1]: Mounting /run/wrappers... machine # [ 6.215404] systemd[1]: Mounted /run/wrappers. machine # [ 6.216993] systemd[1]: Reached target Local File Systems. machine # [ 6.234040] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 6.246617] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 6.247630] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 6.259137] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 6.266524] systemd[1]: Starting Create System Files and Directories... machine # [ 6.309073] systemd-udevd[304]: Using default interface naming scheme 'v261'. machine # [ 6.414663] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 6.430408] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 6.473304] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 6.512807] systemd[1]: Finished Create System Files and Directories. machine # [ 6.532153] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 6.540299] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 6.676850] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 6.763614] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 6.776097] systemd[1]: Starting Update is Completed... machine # [ 6.869844] systemd[1]: Finished Update is Completed. machine # [ 7.261581] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 7.269361] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 7.580116] systemd[1]: Finished Coldplug All udev Devices. machine # [ 7.583554] systemd[1]: Reached target System Initialization. machine # [ 7.588630] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 7.589835] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 7.590864] systemd[1]: Reached target Timer Units. machine # [ 7.591663] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 7.599871] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 7.607014] systemd[1]: Reached target Socket Units. machine # [ 7.607823] systemd[1]: Reached target Basic System. machine # [ 7.612329] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 7.613549] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 7.614499] systemd[1]: Starting Post-Boot Actions... machine # [ 7.625982] systemd[1]: Started Reset console on configuration changes. machine # [ 7.657843] systemd[1]: Starting resolvconf update... machine # [ 7.731578] systemd[1]: Starting D-Bus System Message Bus... machine # [ 7.795601] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 7.803191] nsncd[427]: Oct 14 03:14:02.326 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 7.829519] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 7.830660] systemd[1]: Reached target User and Group Name Lookups. machine # [ 7.831610] systemd[1]: Starting User Login Management... machine # [ 7.897680] systemd[1]: Finished Post-Boot Actions. machine # [ 8.031766] dbus-broker-launch[436]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 8.046596] dbus-broker-launch[436]: NSS returned no entry for 'systemd-timesync' machine # [ 8.047724] dbus-broker-launch[436]: Invalid user-name in /nix/store/by20c8m1gj11fw6fnmvl9y8k6lwif7mq-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 8.081926] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3 machine # [ 8.067328] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 8.093844] systemd[1]: Started D-Bus System Message Bus. machine # [ 8.114513] systemd-logind[446]: New seat seat0. machine # [ 8.128757] systemd[1]: Started User Login Management. machine # [ 8.142519] systemd[1]: Starting linger-users.service... machine # [ 8.151244] dbus-broker-launch[436]: Ready machine # [ 8.250108] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 8.253733] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 8.261980] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 8.263124] systemd[1]: Stopping User and Group Name Lookups... machine # [ 8.269981] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 8.271021] systemd[1]: nscd.service: Deactivated successfully. machine # [ 8.271906] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 8.314807] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 8.436897] systemd[1]: Created slice Slice /user/1001. machine # [ 8.438062] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 8.487229] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 8.513321] systemd[1]: Finished linger-users.service. machine # [ 8.563727] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 8.589806] systemd[1]: Starting User Manager for UID 1001... machine # [ 8.616858] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 8.618115] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 8.665178] systemd[1]: Reached target User and Group Name Lookups. machine # [ 8.679476] nsncd[518]: Oct 14 03:14:03.155 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 8.731415] (systemd)[538]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 8.793748] systemd-logind[446]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 8.795797] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 9.119278] systemd[1]: Starting Virtual Console Setup... machine # [ 9.153422] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 9.155195] systemd[538]: Queued start job for default target Main User Target. machine # [ 9.202952] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 9.249438] systemd[538]: Created slice User Application Slice. machine # [ 9.278860] systemd[538]: Started Daily Cleanup of User's Temporary Directories. machine # [ 9.300722] systemd[538]: Reached target Paths. machine # [ 9.307333] systemd[538]: Reached target Timers. machine # [ 9.315299] systemd[538]: Starting D-Bus User Message Bus Socket... machine # [ 9.331730] systemd[538]: Starting Create User Files and Directories... machine # [ 9.335844] systemd[1]: Finished resolvconf update. machine # [ 9.342775] systemd[1]: Starting DHCP Client... machine # [ 9.348649] systemd[538]: Finished Create User Files and Directories. machine # [ 9.359570] systemd[538]: Listening on D-Bus User Message Bus Socket. machine # [ 9.367303] systemd[538]: Reached target Sockets. machine # [ 9.373488] systemd[538]: Reached target Basic System. machine # [ 9.379998] systemd[1]: Started User Manager for UID 1001. machine # [ 9.389823] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 9.400292] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 9.406999] systemd[1]: Stopped Virtual Console Setup. machine # [ 9.415203] systemd[1]: Starting Virtual Console Setup... machine # [ 9.421116] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 9.429335] systemd[538]: Reached target Main User Target. machine # [ 9.433584] systemd[538]: Startup finished in 432ms. machine # [ 9.439839] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 9.441951] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 9.443027] systemd[1]: Started backdoor.service. machine # connecting to host... machine # [ 9.557587] systemd[1]: Finished Firewall. machine # [ 9.558372] systemd[1]: Reached target Preparation for Network. machine # [ 9.581103] systemd[1]: Starting Extra networking commands.... machine # [ 9.642659] (udev-worker)[599]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 9.99 seconds) machine: (finished: waiting for the VM to finish booting, in 10.38 seconds) machine # [ 9.687526] (udev-worker)[599]: Network interface NamePolicy= disabled on kernel command line. machine # [ 9.899897] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 9.931570] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 9.952775] systemd[1]: Starting Address configuration of eth1... machine # [ 9.954056] systemd-logind[446]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # [ 10.072531] mousedev: PS/2 mouse device common for all mice machine # [ 10.093232] dhcpcd[588]: dhcpcd-10.3.2 starting machine # [ 10.120765] dhcpcd[621]: dev: loaded udev machine # [ 10.163049] 8021q: 802.1Q VLAN Support v1.8 machine # [ 10.257552] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 10.296226] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 10.296742] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 10.298025] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 10.298385] cfg80211: failed to load regulatory.db machine # [ 10.366468] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 10.358149] systemd-vconsole-setup[571]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 10.401608] systemd[1]: Finished Virtual Console Setup. machine # [ 10.402539] systemd-logind[446]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 10.473128] network-addresses-eth1-start[618]: adding address 192.168.1.1/24... done machine # [ 10.536885] network-addresses-eth1-start[618]: adding address 2001:db8:1::1/64... done machine # [ 10.605145] systemd[1]: Finished Address configuration of eth1. machine # [ 10.617542] dhcpcd[660]: /nix/store/92w4pf1lqszlcwfq9ma2y2vaad5dssks-openresolv-3.17.4/sbin/.resolvconf-wrapped: line 1250: kill: (619) - Operation not permitted machine # [ 10.619573] dhcpcd[660]: .resolvconf-wrapped: clearing stale lock pid 619 machine # [ 10.842446] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 10.832134] dhcpcd[621]: eth0: waiting for carrier machine # [ 10.833029] dhcpcd[621]: eth0: carrier acquired machine # [ 10.910813] dhcpcd[621]: DUID 00:01:00:01:32:61:af:fd:52:54:00:12:34:56 machine # [ 10.911934] dhcpcd[621]: eth0: IAID 00:12:34:56 machine # [ 10.931694] dhcpcd[621]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 10.966601] systemd[1]: Finished Extra networking commands.. machine # [ 10.967587] systemd[1]: Reached target Network. machine # [ 10.994130] systemd[1]: Starting Permit User Sessions... machine # [ 11.196141] systemd[1]: Finished Permit User Sessions. machine # [ 11.220402] systemd[1]: Started Getty on tty1. machine # [ 11.221283] systemd[1]: Reached target Login Prompts. machine # [ 11.614599] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 11.615806] systemd[1]: Stopped Virtual Console Setup. machine # [ 11.633117] systemd[1]: Stopping Virtual Console Setup... machine # [ 11.634014] systemd[1]: Starting Virtual Console Setup... machine # [ 11.652573] systemd-logind[446]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 11.662472] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 11.671107] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 11.684659] systemd[1]: Stopped Virtual Console Setup. machine # [ 11.685505] systemd[1]: Starting Virtual Console Setup... machine # [ 11.701600] dhcpcd[621]: eth0: soliciting a DHCP lease machine # [ 11.702461] dhcpcd[621]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 11.708290] dhcpcd[621]: eth0: probing address 10.0.2.15/24 machine # [ 11.813620] systemd-vconsole-setup[712]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 11.819028] systemd[1]: Finished Virtual Console Setup. machine # [ 12.757555] dhcpcd[621]: eth0: soliciting an IPv6 router machine # [ 12.760958] dhcpcd[621]: eth0: Router Advertisement from fe80::2 machine # [ 12.762449] dhcpcd[621]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 12.763932] dhcpcd[621]: eth0: adding route to fec0::/64 machine # [ 12.766430] dhcpcd[621]: eth0: adding default route via fe80::2 machine # [ 16.774189] dhcpcd[621]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 16.776451] dhcpcd[621]: eth0: adding route to 10.0.2.0/24 machine # [ 16.777906] dhcpcd[621]: eth0: adding default route via 10.0.2.2 machine # [ 16.962133] systemd[1]: Started DHCP Client. machine # [ 16.964521] systemd[1]: Reached target Multi-User System. machine # [ 16.965604] systemd[1]: Startup finished in 1.049s (kernel) + 3.262s (initrd) + 12.651s (userspace) = 16.964s. machine: (finished: waiting for unit multi-user.target, in 17.80 seconds) machine: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 17.315013] nixos[825]: switching to system configuration /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test machine # activating the configuration... machine # [ 17.319306] systemd[1]: Stopped target Local File Systems. machine # [ 17.321773] systemd[1]: Stopped target Remote File Systems. machine # setting up /etc... machine # [ 17.617442] systemd[1]: Reload requested from client PID 825 ('.switch-to-conf') (unit backdoor.service)... machine # [ 17.619162] systemd[1]: Reloading... machine # [ 17.942889] systemd[1]: Reloading finished in 322 ms. machine # reloading user units for usertest... machine # [ 17.999894] systemd[538]: Created slice User Core Session Slice. machine # [ 18.003383] systemd[538]: Starting D-Bus User Message Bus... machine # [ 18.038242] dbus-broker-launch[895]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/by20c8m1gj11fw6fnmvl9y8k6lwif7mq-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 18.041776] dbus-broker-launch[895]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/by20c8m1gj11fw6fnmvl9y8k6lwif7mq-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 18.045021] dbus-broker-launch[895]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/by20c8m1gj11fw6fnmvl9y8k6lwif7mq-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 18.048102] dbus-broker-launch[895]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/by20c8m1gj11fw6fnmvl9y8k6lwif7mq-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 18.053170] dbus-broker-launch[895]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 18.055043] dbus-broker-launch[895]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 18.058366] systemd[538]: Started D-Bus User Message Bus. machine # [ 18.061408] dbus-broker-launch[895]: Ready machine # [ 18.104988] systemd[538]: Reexecution requested from client PID 894 ('switch-to-confi')... machine # [ 18.109617] systemd[538]: Reexecuting. machine # [ 18.164125] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 18.285855] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 18.294079] systemd[538]: Reload requested from client PID 894 ('switch-to-confi')... machine # [ 18.296624] systemd[538]: Reloading... machine # [ 18.409620] systemd[538]: Reloading finished in 111 ms. machine # [ 18.425794] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 18.437494] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 18.439989] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 18.442362] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 18.483787] systemd[538]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 18.499073] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 18.592332] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 18.596978] systemd[1]: Reached target Reactivate sysinit units. machine # [ 18.600709] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.605431] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 18.606866] systemd[1]: Reached target Remote File Systems. machine # [ 18.608895] systemd[1]: Reached target Local File Systems. machine # [ 18.617275] systemd[1]: Starting linger-users.service... machine # [ 18.624758] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 18.632563] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 18.633628] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 18.634906] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 18.644558] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 18.646491] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.647809] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.718394] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 18.722789] systemd[1]: Finished linger-users.service. machine # [ 18.856943] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 18.859926] systemd[1]: Finished Create SUID/SGID Wrappers. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 19.118110] nixos[825]: finished switching to system configuration /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/bin/switch-to-configuration test, in 2.02 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.03 seconds) machine: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/wrjfvlxivrnrjka36srkwlchw449wmci-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/wrjfvlxivrnrjka36srkwlchw449wmci-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 19.393067] nixos[972]: switching to system configuration /nix/store/wrjfvlxivrnrjka36srkwlchw449wmci-nixos-system-other-test machine # activating the configuration... machine # [ 19.397607] systemd[1]: Stopped target Remote File Systems. machine # [ 19.399392] systemd[1]: Stopped target Local File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 19.690997] systemd[1]: Reload requested from client PID 972 ('.switch-to-conf') (unit backdoor.service)... machine # [ 19.693535] systemd[1]: Reloading... machine # [ 20.029041] systemd[1]: Reloading finished in 334 ms. machine # reloading user units for usertest... machine # [ 20.119771] systemd[538]: Reexecution requested from client PID 1043 ('switch-to-confi')... machine # [ 20.123069] systemd[538]: Reexecuting. machine # [ 20.180173] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.341415] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.348445] systemd[538]: Reload requested from client PID 1043 ('switch-to-confi')... machine # [ 20.352124] systemd[538]: Reloading... machine # [ 20.461149] systemd[538]: Reloading finished in 109 ms. machine # [ 20.477875] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 20.487935] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 20.490606] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 20.492758] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 20.526058] systemd[538]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 20.530798] systemd[1]: Stopped target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service machine # [ 20.535260] systemd[1]: Stopping Reactivate sysinit units... machine # [ 20.537189] systemd[1]: Reached target Reactivate sysinit units. machine # [ 20.539116] dbus-broker-launch[436]: Caught SIGHUP, trigger reload. machine # [ 20.540764] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 20.544891] dbus-broker-launch[436]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 20.547121] dbus-broker-launch[436]: NSS returned no entry for 'systemd-timesync' machine # [ 20.548485] dbus-broker-launch[436]: Invalid user-name in /nix/store/jv0hcwnmszawk334lp8i6ifxll77f8fw-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 20.566266] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 20.574168] systemd[1]: Stopping Address configuration of eth1... machine # [ 20.607895] network-addresses-eth1-pre-stop[1056]: deleting address 192.168.1.1/24... done machine # [ 20.616781] network-addresses-eth1-pre-stop[1056]: deleting address 2001:db8:1::1/64... done machine # [ 20.624352] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 20.627413] systemd[1]: Stopped Address configuration of eth1. machine # [ 20.631953] systemd[1]: Starting Address configuration of eth1... machine # [ 20.677194] network-addresses-eth1-start[1061]: adding address 192.168.1.2/24... done machine # [ 20.685203] network-addresses-eth1-start[1061]: adding address 2001:db8:1::2/64... done machine # [ 20.695852] systemd[1]: Finished Address configuration of eth1. machine # [ 20.700504] systemd[1]: Reached target Remote File Systems. machine # [ 20.703887] systemd[1]: Reached target Local File Systems. machine # [ 20.709379] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.710843] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 20.717177] systemd[1]: Starting linger-users.service... machine # [ 20.728159] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 20.737780] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 20.738741] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 20.740000] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 20.748958] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 20.750669] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.752001] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.780400] linger-users-start[1075]: id: ‘usertest’: no such user machine # [ 20.784503] linger-users-start[1072]: Removing linger for missing user usertest machine # [ 20.794364] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 20.798914] systemd[1]: Finished linger-users.service. machine # [ 20.970494] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 20.974216] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 21.227379] nixos[972]: finished switching to system configuration /nix/store/wrjfvlxivrnrjka36srkwlchw449wmci-nixos-system-other-test machine: (finished: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/wrjfvlxivrnrjka36srkwlchw449wmci-nixos-system-other-test/bin/switch-to-configuration test, in 2.08 seconds) subtest: services machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 21.453957] nixos[1139]: switching to system configuration /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test machine # [ 21.456542] systemd[1]: Stopped target Local File Systems. machine # [ 21.459825] systemd[1]: Stopped target Remote File Systems. machine # [ 21.749844] systemd[1]: Reload requested from client PID 1139 ('.switch-to-conf') (unit backdoor.service)... machine # [ 21.751852] systemd[1]: Reloading... machine # [ 22.086486] systemd[1]: Reloading finished in 332 ms. machine # [ 22.178362] systemd[538]: Reexecution requested from client PID 1208 ('switch-to-confi')... machine # [ 22.179851] systemd[538]: Reexecuting. machine # [ 22.235796] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.350213] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.357271] systemd[538]: Reload requested from client PID 1208 ('switch-to-confi')... machine # [ 22.359614] systemd[538]: Reloading... machine # [ 22.467848] systemd[538]: Reloading finished in 107 ms. machine # [ 22.484170] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.494693] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 22.497290] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 22.499537] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 22.533052] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 22.537274] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 22.542213] systemd[1]: Stopping Reactivate sysinit units... machine # [ 22.543165] systemd[1]: Reached target Reactivate sysinit units. machine # [ 22.544376] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 22.547979] dbus-broker-launch[436]: Caught SIGHUP, trigger reload. machine # [ 22.550435] dbus-broker-launch[436]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 22.552647] dbus-broker-launch[436]: NSS returned no entry for 'systemd-timesync' machine # [ 22.553854] dbus-broker-launch[436]: Invalid user-name in /nix/store/by20c8m1gj11fw6fnmvl9y8k6lwif7mq-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 22.580092] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 22.586217] systemd[1]: Stopping Address configuration of eth1... machine # [ 22.620295] network-addresses-eth1-pre-stop[1220]: deleting address 192.168.1.2/24... done machine # [ 22.628703] network-addresses-eth1-pre-stop[1220]: deleting address 2001:db8:1::2/64... done machine # [ 22.639645] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 22.642162] systemd[1]: Stopped Address configuration of eth1. machine # [ 22.648549] systemd[1]: Starting Address configuration of eth1... machine # [ 22.705606] network-addresses-eth1-start[1225]: adding address 192.168.1.1/24... done machine # [ 22.714361] network-addresses-eth1-start[1225]: adding address 2001:db8:1::1/64... done machine # [ 22.725912] systemd[1]: Finished Address configuration of eth1. machine # [ 22.733557] systemd[1]: Reached target Local File Systems. machine # [ 22.738062] systemd[1]: Reached target Remote File Systems. machine # [ 22.739086] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 22.744560] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 22.745598] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 22.746928] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 22.763321] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 22.767318] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.768935] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.770225] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.771662] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 22.937378] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 22.942117] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 22.944756] systemd[1]: Starting linger-users.service... machine # [ 22.982254] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 22.985051] systemd[1]: Finished linger-users.service. machine # [ 23.242027] nixos[1139]: finished switching to system configuration /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.01 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 23.462764] nixos[1294]: switching to system configuration /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test machine # [ 23.465577] systemd[1]: Stopped target Local File Systems. machine # [ 23.467760] systemd[1]: Stopped target Remote File Systems. machine # [ 23.808520] systemd[1]: Reload requested from client PID 1294 ('.switch-to-conf') (unit backdoor.service)... machine # [ 23.810201] systemd[1]: Reloading... machine # [ 24.144520] systemd[1]: Reloading finished in 332 ms. machine # [ 24.230141] systemd[538]: Reexecution requested from client PID 1364 ('switch-to-confi')... machine # [ 24.234139] systemd[538]: Reexecuting. machine # [ 24.291475] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.407943] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.414971] systemd[538]: Reload requested from client PID 1364 ('switch-to-confi')... machine # [ 24.417709] systemd[538]: Reloading... machine # [ 24.527866] systemd[538]: Reloading finished in 109 ms. machine # [ 24.545804] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.553877] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 24.556075] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 24.558607] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 24.592769] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 24.597533] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 24.598897] systemd[1]: Stopping Reactivate sysinit units... machine # [ 24.599814] systemd[1]: Reached target Reactivate sysinit units. machine # [ 24.603104] systemd[1]: Reached target Local File Systems. machine # [ 24.607185] systemd[1]: Reached target Remote File Systems. machine # [ 24.611817] systemd[1]: Starting linger-users.service... machine # [ 24.623629] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.629172] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 24.630589] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 24.641587] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 24.642569] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 24.643883] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 24.659013] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 24.663270] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.667532] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.709833] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 24.713275] systemd[1]: Finished linger-users.service. machine # [ 24.867826] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 24.871992] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 25.126145] nixos[1294]: finished switching to system configuration /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.88 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 25.362081] nixos[1435]: switching to system configuration /nix/store/hd97j3kl1k224s79yab3svhh9qcs6cvq-nixos-system-machine-test machine # [ 25.366130] systemd[1]: Stopped target Remote File Systems. machine # [ 25.367209] systemd[1]: Stopped target Local File Systems. machine # [ 25.662402] systemd[1]: Reload requested from client PID 1435 ('.switch-to-conf') (unit backdoor.service)... machine # [ 25.664666] systemd[1]: Reloading... machine # [ 26.006720] systemd[1]: Reloading finished in 340 ms. machine # [ 26.087999] systemd[538]: Reexecution requested from client PID 1504 ('switch-to-confi')... machine # [ 26.090850] systemd[538]: Reexecuting. machine # [ 26.147325] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.259404] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.267102] systemd[538]: Reload requested from client PID 1504 ('switch-to-confi')... machine # [ 26.270121] systemd[538]: Reloading... machine # [ 26.377977] systemd[538]: Reloading finished in 108 ms. machine # [ 26.392186] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.403772] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 26.405216] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 26.408090] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 26.436120] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 26.440110] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 26.443778] systemd[1]: Stopping Reactivate sysinit units... machine # [ 26.445812] systemd[1]: Reached target Reactivate sysinit units. machine # [ 26.446809] systemd[1]: Reached target Remote File Systems. machine # [ 26.449517] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.455581] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 26.459604] systemd[1]: Starting linger-users.service... machine # [ 26.463102] systemd[1]: Starting test.service... machine # [ 26.472232] systemd[1]: Reached target Local File Systems. machine # [ 26.478603] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 26.488470] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 26.489406] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 26.490692] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 26.498089] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 26.499812] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.501507] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.546470] systemd[1]: Finished test.service. machine # [ 26.575426] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 26.577689] systemd[1]: Finished linger-users.service. machine # [ 26.712221] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 26.715655] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 26.972447] nixos[1435]: finished switching to system configuration /nix/store/hd97j3kl1k224s79yab3svhh9qcs6cvq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.85 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 27.192427] nixos[1578]: switching to system configuration /nix/store/hd97j3kl1k224s79yab3svhh9qcs6cvq-nixos-system-machine-test machine # [ 27.195329] systemd[1]: Stopped target Remote File Systems. machine # [ 27.198929] systemd[1]: Stopped target Local File Systems. machine # [ 27.491350] systemd[1]: Reload requested from client PID 1578 ('.switch-to-conf') (unit backdoor.service)... machine # [ 27.493708] systemd[1]: Reloading... machine # [ 27.829543] systemd[1]: Reloading finished in 333 ms. machine # [ 27.914842] systemd[538]: Reexecution requested from client PID 1647 ('switch-to-confi')... machine # [ 27.917794] systemd[538]: Reexecuting. machine # [ 27.984385] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.102370] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.109568] systemd[538]: Reload requested from client PID 1647 ('switch-to-confi')... machine # [ 28.112228] systemd[538]: Reloading... machine # [ 28.224183] systemd[538]: Reloading finished in 110 ms. machine # [ 28.240225] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.251398] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 28.252627] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 28.255404] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 28.291371] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 28.297079] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 28.300513] systemd[1]: Stopping Reactivate sysinit units... machine # [ 28.301604] systemd[1]: Reached target Reactivate sysinit units. machine # [ 28.302593] systemd[1]: Reached target Remote File Systems. machine # [ 28.307755] systemd[1]: Starting linger-users.service... machine # [ 28.318690] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.326214] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 28.327745] systemd[1]: Reached target Local File Systems. machine # [ 28.341232] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 28.343000] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 28.355169] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 28.358139] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 28.361520] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 28.363242] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.370258] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.423237] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 28.427696] systemd[1]: Finished linger-users.service. machine # [ 28.623545] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 28.626501] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 28.883348] nixos[1578]: finished switching to system configuration /nix/store/hd97j3kl1k224s79yab3svhh9qcs6cvq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.91 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 29.143583] nixos[1718]: switching to system configuration /nix/store/n34zr7h310mf8iginim3fkrklnji67rm-nixos-system-machine-test machine # [ 29.146692] systemd[1]: Stopped target Remote File Systems. machine # [ 29.149345] systemd[1]: Stopped target Local File Systems. machine # [ 29.451805] systemd[1]: Reload requested from client PID 1718 ('.switch-to-conf') (unit backdoor.service)... machine # [ 29.454146] systemd[1]: Reloading... machine # [ 29.830135] systemd[1]: Reloading finished in 373 ms. machine # [ 29.922327] systemd[538]: Reexecution requested from client PID 1787 ('switch-to-confi')... machine # [ 29.923861] systemd[538]: Reexecuting. machine # [ 29.984786] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.103184] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.110629] systemd[538]: Reload requested from client PID 1787 ('switch-to-confi')... machine # [ 30.113397] systemd[538]: Reloading... machine # [ 30.283358] systemd[538]: Reloading finished in 168 ms. machine # [ 30.300224] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.311188] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 30.313907] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 30.316198] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 30.358207] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 30.363216] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 30.365600] systemd[1]: Stopping Reactivate sysinit units... machine # [ 30.366544] systemd[1]: Reached target Reactivate sysinit units. machine # [ 30.370684] systemd[1]: Reached target Remote File Systems. machine # [ 30.376165] systemd[1]: Starting linger-users.service... machine # [ 30.385165] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.392861] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 30.394374] systemd[1]: Reached target Local File Systems. machine # [ 30.395201] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 30.413403] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 30.414406] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 30.415823] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 30.429687] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 30.431422] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.434951] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.478311] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 30.482373] systemd[1]: Finished linger-users.service. machine # [ 30.646231] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 30.649632] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 30.905920] nixos[1718]: finished switching to system configuration /nix/store/n34zr7h310mf8iginim3fkrklnji67rm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 2.02 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 31.152906] nixos[1859]: switching to system configuration /nix/store/f9j1g17kp1cycddhw7flsj254qs35lcw-nixos-system-machine-test machine # [ 31.155659] systemd[1]: Stopped target Remote File Systems. machine # [ 31.158430] systemd[1]: test.service: Deactivated successfully. machine # [ 31.159368] systemd[1]: Stopped Test unit. machine # [ 31.160636] systemd[1]: Stopped target Local File Systems. machine # [ 31.462235] systemd[1]: Reload requested from client PID 1859 ('.switch-to-conf') (unit backdoor.service)... machine # [ 31.464353] systemd[1]: Reloading... machine # [ 31.793894] systemd[1]: Reloading finished in 327 ms. machine # [ 31.880853] systemd[538]: Reexecution requested from client PID 1928 ('switch-to-confi')... machine # [ 31.885205] systemd[538]: Reexecuting. machine # [ 31.931194] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.045203] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.051812] systemd[538]: Reload requested from client PID 1928 ('switch-to-confi')... machine # [ 32.054407] systemd[538]: Reloading... machine # [ 32.163531] systemd[538]: Reloading finished in 107 ms. machine # [ 32.180203] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.191026] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 32.193571] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 32.195858] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 32.230844] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 32.235346] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 32.239532] systemd[1]: Stopping Reactivate sysinit units... machine # [ 32.241306] systemd[1]: Reached target Reactivate sysinit units. machine # [ 32.242216] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.243553] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 32.245884] systemd[1]: Reached target Remote File Systems. machine # [ 32.251741] systemd[1]: Starting linger-users.service... machine # [ 32.256700] systemd[1]: Starting test.service... machine # [ 32.272626] systemd[1]: Reached target Local File Systems. machine # [ 32.273581] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 32.287959] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 32.289602] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 32.291060] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 32.309120] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 32.310905] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.317902] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.343791] systemd[1]: Finished test.service. machine # [ 32.376926] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 32.381663] systemd[1]: Finished linger-users.service. machine # [ 32.566808] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 32.570469] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 32.827005] nixos[1859]: finished switching to system configuration /nix/store/f9j1g17kp1cycddhw7flsj254qs35lcw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.92 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 33.047175] nixos[2001]: switching to system configuration /nix/store/g6wmn9xvnyx781gjs5d3s2fflnlm93dl-nixos-system-machine-test machine # [ 33.050179] systemd[1]: Stopped target Local File Systems. machine # [ 33.052614] systemd[1]: Stopped target Remote File Systems. machine # [ 33.360928] systemd[1]: Reload requested from client PID 2001 ('.switch-to-conf') (unit backdoor.service)... machine # [ 33.363165] systemd[1]: Reloading... machine # [ 33.711290] systemd[1]: Reloading finished in 346 ms. machine # [ 33.841650] systemd[538]: Reexecution requested from client PID 2070 ('switch-to-confi')... machine # [ 33.846390] systemd[538]: Reexecuting. machine # [ 33.899260] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.014623] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.022342] systemd[538]: Reload requested from client PID 2070 ('switch-to-confi')... machine # [ 34.025120] systemd[538]: Reloading... machine # [ 34.142886] systemd[538]: Reloading finished in 116 ms. machine # [ 34.160236] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.172147] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 34.173374] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 34.176404] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 34.211166] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 34.217080] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 34.220352] systemd[1]: Stopping Reactivate sysinit units... machine # [ 34.221439] systemd[1]: Reached target Reactivate sysinit units. machine # [ 34.225215] systemd[1]: test.service: Deactivated successfully. machine # [ 34.226223] systemd[1]: Stopped test.service. machine # [ 34.226892] systemd[1]: Stopping test.service... machine # [ 34.229802] systemd[1]: Starting test.service... machine # [ 34.260140] systemd[1]: Finished test.service. machine # [ 34.265788] systemd[1]: Reached target Remote File Systems. machine # [ 34.271641] systemd[1]: Reached target Local File Systems. machine # [ 34.278812] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 34.289203] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 34.290211] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 34.291491] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 34.299400] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 34.301442] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.302758] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.303990] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.306341] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 34.504866] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 34.508494] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 34.514126] systemd[1]: Starting linger-users.service... machine # [ 34.569281] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 34.571309] systemd[1]: Finished linger-users.service. machine # [ 34.828958] nixos[2001]: finished switching to system configuration /nix/store/g6wmn9xvnyx781gjs5d3s2fflnlm93dl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.00 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 35.094829] nixos[2144]: switching to system configuration /nix/store/xwa75mqpvr51s1s09ix97dh727qdb0yr-nixos-system-machine-test machine # [ 35.097579] systemd[1]: Stopped target Remote File Systems. machine # [ 35.100476] systemd[1]: Stopped target Local File Systems. machine # [ 35.453532] systemd[1]: Reload requested from client PID 2144 ('.switch-to-conf') (unit backdoor.service)... machine # [ 35.455655] systemd[1]: Reloading... machine # [ 35.990910] systemd[1]: Reloading finished in 532 ms. machine # [ 36.082049] systemd[538]: Reexecution requested from client PID 2213 ('switch-to-confi')... machine # [ 36.085905] systemd[538]: Reexecuting. machine # [ 36.149377] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.275416] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.282008] systemd[538]: Reload requested from client PID 2213 ('switch-to-confi')... machine # [ 36.283419] systemd[538]: Reloading... machine # [ 36.397359] systemd[538]: Reloading finished in 112 ms. machine # [ 36.412253] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.423188] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 36.425931] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 36.429297] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 36.462093] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 36.467086] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 36.471990] systemd[1]: Stopping Reactivate sysinit units... machine # [ 36.473226] systemd[1]: Reached target Reactivate sysinit units. machine # [ 36.475423] systemd[1]: Reloading test.service... machine # [ 36.503204] systemd[1]: Reloaded test.service. machine # [ 36.507032] systemd[1]: Reached target Local File Systems. machine # [ 36.511214] systemd[1]: Reached target Remote File Systems. machine # [ 36.516137] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.519050] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 36.524174] systemd[1]: Starting linger-users.service... machine # [ 36.536941] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 36.544342] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 36.545387] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 36.546651] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 36.558416] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 36.563786] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.573289] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.618035] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 36.622024] systemd[1]: Finished linger-users.service. machine # [ 36.769034] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 36.771924] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 37.028511] nixos[2144]: finished switching to system configuration /nix/store/xwa75mqpvr51s1s09ix97dh727qdb0yr-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 2.20 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 37.307994] nixos[2287]: switching to system configuration /nix/store/3r6q2s9gw2fnc44qjn2ar03bacpqbg0a-nixos-system-machine-test machine # [ 37.311538] systemd[1]: Stopped target Remote File Systems. machine # [ 37.314802] systemd[1]: Stopped target Local File Systems. machine # [ 37.683683] systemd[1]: Reload requested from client PID 2287 ('.switch-to-conf') (unit backdoor.service)... machine # [ 37.686256] systemd[1]: Reloading... machine # [ 38.140521] systemd[1]: Reloading finished in 452 ms. machine # [ 38.236994] systemd[538]: Reexecution requested from client PID 2356 ('switch-to-confi')... machine # [ 38.240567] systemd[538]: Reexecuting. machine # [ 38.292080] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.421526] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.429217] systemd[538]: Reload requested from client PID 2356 ('switch-to-confi')... machine # [ 38.433364] systemd[538]: Reloading... machine # [ 38.548584] systemd[538]: Reloading finished in 116 ms. machine # [ 38.564187] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.576325] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 38.578926] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 38.581263] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 38.614008] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 38.620466] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 38.622194] systemd[1]: Stopping Reactivate sysinit units... machine # [ 38.623082] systemd[1]: Reached target Reactivate sysinit units. machine # [ 38.626553] systemd[1]: Reached target Local File Systems. machine # [ 38.628999] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.636307] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 38.637897] systemd[1]: Reached target Remote File Systems. machine # [ 38.638745] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 38.642859] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 38.643882] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 38.652399] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 38.654900] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 38.664562] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.666058] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.867360] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 38.873735] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.880130] systemd[1]: Starting linger-users.service... machine # [ 38.931538] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 38.934823] systemd[1]: Finished linger-users.service. machine # [ 39.194336] nixos[2287]: finished switching to system configuration /nix/store/3r6q2s9gw2fnc44qjn2ar03bacpqbg0a-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 2.17 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.43 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 39.847521] nixos[2437]: switching to system configuration /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test machine # [ 39.854520] systemd[1]: Stopped target Local File Systems. machine # [ 39.855553] systemd[1]: Stopped target Remote File Systems. machine # [ 39.859433] systemd[1]: test.service: Deactivated successfully. machine # [ 39.861444] systemd[1]: Stopped test.service. machine # [ 40.659287] systemd[1]: Reload requested from client PID 2437 ('.switch-to-conf') (unit backdoor.service)... machine # [ 40.659798] systemd[1]: Reloading... machine # [ 41.650036] systemd[1]: Reloading finished in 982 ms. machine # [ 41.793884] systemd[538]: Reexecution requested from client PID 2507 ('switch-to-confi')... machine # [ 41.808803] systemd[538]: Reexecuting. machine # [ 41.915289] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.111745] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.122079] systemd[538]: Reload requested from client PID 2507 ('switch-to-confi')... machine # [ 42.124836] systemd[538]: Reloading... machine # [ 42.455653] systemd[538]: Reloading finished in 329 ms. machine # [ 42.476316] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.524616] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 42.545132] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 42.550807] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 42.640360] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 42.674859] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 42.683365] systemd[1]: Stopping Reactivate sysinit units... machine # [ 42.688487] systemd[1]: Reached target Reactivate sysinit units. machine # [ 42.690323] systemd[1]: Reached target Remote File Systems. machine # [ 42.691734] systemd[1]: Reached target Local File Systems. machine # [ 42.705842] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 42.719768] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 42.780332] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 42.802683] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 42.850262] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 42.873356] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.875648] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.877992] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.885219] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 44.236593] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 44.239044] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 44.254103] systemd[1]: Starting linger-users.service... machine # [ 44.333682] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 44.337345] systemd[1]: Finished linger-users.service. machine # [ 44.594558] nixos[2437]: finished switching to system configuration /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 4.97 seconds) machine: must succeed: /nix/store/h4m331qrvvbwlvnwfd9mrlyhvhr8jg3s-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 44.840518] nixos[2579]: switching to system configuration /nix/store/kkvklpqfw3za8642gviw3hji4alpqdqc-nixos-system-machine-test machine # [ 44.843558] systemd[1]: Stopped target Local File Systems. machine # [ 44.846390] systemd[1]: Stopped target Remote File Systems. machine # [ 45.346726] systemd[1]: Reload requested from client PID 2579 ('.switch-to-conf') (unit backdoor.service)... machine # [ 45.349666] systemd[1]: Reloading... machine # [ 45.845671] systemd[1]: Reloading finished in 492 ms. machine # [ 45.959609] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 45.964849] systemd[538]: Reexecution requested from client PID 2648 ('switch-to-confi')... machine # [ 45.966455] systemd[538]: Reexecuting. machine # [ 46.032742] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.233845] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.244237] systemd[538]: Reload requested from client PID 2648 ('switch-to-confi')... machine # [ 46.246338] systemd[538]: Reloading... machine # [ 46.363643] systemd[538]: Reloading finished in 124 ms. machine # [ 46.380193] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.397291] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 46.398425] systemd[1]: Stopping Reactivate sysinit units... machine # [ 46.399307] systemd[1]: Reached target Reactivate sysinit units. machine # [ 46.412891] systemd[1]: Reached target Local File Systems. machine # [ 46.413952] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 46.415584] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 46.428320] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 46.429917] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 46.443698] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 46.451265] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.453754] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.455203] systemd[1]: Reached target Remote File Systems. machine # [ 46.457302] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.459652] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 46.665192] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 46.667682] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 46.674991] systemd[1]: Starting linger-users.service... machine # [ 46.680501] systemd[1]: Starting test.service... machine # [ 46.738883] systemd[1]: Finished test.service. machine # [ 46.767030] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 46.769477] systemd[1]: Finished linger-users.service. machine # [ 47.035444] nixos[2579]: finished switching to system configuration /nix/store/kkvklpqfw3za8642gviw3hji4alpqdqc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h4m331qrvvbwlvnwfd9mrlyhvhr8jg3s-separate-activation-script/bin/switch-to-configuration test 2>&1, in 2.44 seconds) machine: must succeed: ! test -e /run/current-system/activate machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.03 seconds) machine: must succeed: ! test -e /run/current-system/dry-activate machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.03 seconds) machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.04 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 47.413031] nixos[2727]: switching to system configuration /nix/store/2g6ccvbqhiwyk6xn2nv67lm80zj3nz6c-nixos-system-machine-test machine # [ 47.416461] systemd[1]: Stopped target Local File Systems. machine # [ 47.420450] systemd[1]: test.service: Deactivated successfully. machine # [ 47.422235] systemd[1]: Stopped test.service. machine # [ 47.422980] systemd[1]: Stopped target Remote File Systems. machine # [ 47.915956] systemd[1]: Reload requested from client PID 2727 ('.switch-to-conf') (unit backdoor.service)... machine # [ 47.919020] systemd[1]: Reloading... machine # [ 48.335401] systemd[1]: Reloading finished in 414 ms. machine # [ 48.437602] systemd[538]: Reexecution requested from client PID 2796 ('switch-to-confi')... machine # [ 48.442619] systemd[538]: Reexecuting. machine # [ 48.495593] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.613192] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.621164] systemd[538]: Reload requested from client PID 2796 ('switch-to-confi')... machine # [ 48.623642] systemd[538]: Reloading... machine # [ 48.749024] systemd[538]: Reloading finished in 124 ms. machine # [ 48.766170] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.777507] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 48.813687] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 48.817214] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 48.820798] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 48.822914] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 48.833970] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 48.835088] systemd[1]: Stopping Reactivate sysinit units... machine # [ 48.839211] systemd[1]: Reached target Reactivate sysinit units. machine # [ 48.842639] systemd[1]: Reached target Remote File Systems. machine # [ 48.845189] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.851367] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 48.855706] systemd[1]: Reached target Local File Systems. machine # [ 48.865791] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 48.876897] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 48.877994] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 48.879359] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 48.897883] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 48.899647] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.913833] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.931342] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 49.123075] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 49.125477] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 49.131816] systemd[1]: Starting linger-users.service... machine # [ 49.137429] systemd[1]: Started test.service. machine # [ 49.183582] systemd[1]: test.service: Deactivated successfully. machine # [ 49.214234] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 49.216371] systemd[1]: Finished linger-users.service. machine # [ 49.475673] nixos[2727]: finished switching to system configuration /nix/store/2g6ccvbqhiwyk6xn2nv67lm80zj3nz6c-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 2.34 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 49.811587] nixos[2872]: switching to system configuration /nix/store/7grn7zs6rxf5nh9mr6psc21rifaqcfb4-nixos-system-machine-test machine # [ 49.815380] systemd[1]: Stopped target Local File Systems. machine # [ 49.817861] systemd[1]: Stopped target Remote File Systems. machine # [ 50.248770] systemd[1]: Reload requested from client PID 2872 ('.switch-to-conf') (unit backdoor.service)... machine # [ 50.250517] systemd[1]: Reloading... machine # [ 50.810289] systemd[1]: Reloading finished in 558 ms. machine # [ 50.906937] systemd[538]: Reexecution requested from client PID 2941 ('switch-to-confi')... machine # [ 50.911388] systemd[538]: Reexecuting. machine # [ 50.976266] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.103084] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.110840] systemd[538]: Reload requested from client PID 2941 ('switch-to-confi')... machine # [ 51.115041] systemd[538]: Reloading... machine # [ 51.231578] systemd[538]: Reloading finished in 117 ms. machine # [ 51.248185] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.258536] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 51.261333] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 51.263625] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 51.298702] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 51.303974] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 51.305934] systemd[1]: Stopping Reactivate sysinit units... machine # [ 51.306821] systemd[1]: Reached target Reactivate sysinit units. machine # [ 51.309805] systemd[1]: Reached target Remote File Systems. machine # [ 51.318296] systemd[1]: Reached target Local File Systems. machine # [ 51.319284] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 51.331424] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 51.334930] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 51.340249] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 51.342822] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 51.344688] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.346008] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.347257] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.349793] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 51.534458] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 51.538317] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 51.543161] systemd[1]: Starting escaped\x2ddash.service... machine # [ 51.549511] systemd[1]: Starting linger-users.service... machine # [ 51.598256] systemd[1]: Finished escaped\x2ddash.service. machine # [ 51.620536] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 51.623004] systemd[1]: Finished linger-users.service. machine # [ 51.881104] nixos[2872]: finished switching to system configuration /nix/store/7grn7zs6rxf5nh9mr6psc21rifaqcfb4-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 2.40 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 52.117317] nixos[3014]: switching to system configuration /nix/store/jrmd4bjf5asmwmqzrx8ydwgin9zv6asb-nixos-system-machine-test machine # [ 52.120624] systemd[1]: Stopped target Local File Systems. machine # [ 52.122453] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 52.126014] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 52.127472] systemd[1]: Stopped target Remote File Systems. machine # [ 52.443002] systemd[1]: Reload requested from client PID 3014 ('.switch-to-conf') (unit backdoor.service)... machine # [ 52.445392] systemd[1]: Reloading... machine # [ 52.802533] systemd[1]: Reloading finished in 355 ms. machine # [ 52.933497] systemd[538]: Reexecution requested from client PID 3083 ('switch-to-confi')... machine # [ 52.936406] systemd[538]: Reexecuting. machine # [ 53.053111] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.199787] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.207068] systemd[538]: Reload requested from client PID 3083 ('switch-to-confi')... machine # [ 53.210947] systemd[538]: Reloading... machine # [ 53.338801] systemd[538]: Reloading finished in 129 ms. machine # [ 53.356259] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.371733] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 53.373132] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 53.375789] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 53.412573] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 53.417438] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 53.418529] systemd[1]: Stopping Reactivate sysinit units... machine # [ 53.419363] systemd[1]: Reached target Reactivate sysinit units. machine # [ 53.422938] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.426846] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 53.432680] systemd[1]: Reached target Remote File Systems. machine # [ 53.439031] systemd[1]: Starting escaped\x2ddash.service... machine # [ 53.449204] systemd[1]: Starting linger-users.service... machine # [ 53.459807] systemd[1]: Reached target Local File Systems. machine # [ 53.465412] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 53.467062] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 53.467950] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 53.479810] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 53.490676] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 53.497974] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.506133] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.530607] systemd[1]: Finished escaped\x2ddash.service. machine # [ 53.568938] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 53.572513] systemd[1]: Finished linger-users.service. machine # [ 53.728220] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 53.732184] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 53.986520] nixos[3014]: finished switching to system configuration /nix/store/jrmd4bjf5asmwmqzrx8ydwgin9zv6asb-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 2.11 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 54.320773] nixos[3156]: switching to system configuration /nix/store/j5wi19qaalmvsps62qfcc5w0i5qkvsf9-nixos-system-machine-test machine # [ 54.323715] systemd[1]: Stopped target Remote File Systems. machine # [ 54.327822] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 54.329373] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 54.331646] systemd[1]: Stopped target Local File Systems. machine # [ 54.666264] systemd[1]: Reload requested from client PID 3156 ('.switch-to-conf') (unit backdoor.service)... machine # [ 54.668495] systemd[1]: Reloading... machine # [ 55.045534] systemd[1]: Reloading finished in 374 ms. machine # [ 55.132435] systemd[538]: Reexecution requested from client PID 3225 ('switch-to-confi')... machine # [ 55.136776] systemd[538]: Reexecuting. machine # [ 55.195396] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.310331] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.317515] systemd[538]: Reload requested from client PID 3225 ('switch-to-confi')... machine # [ 55.321527] systemd[538]: Reloading... machine # [ 55.429319] systemd[538]: Reloading finished in 108 ms. machine # [ 55.444212] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.454664] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 55.457248] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 55.459461] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 55.494261] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 55.498487] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 55.501594] systemd[1]: Stopping Reactivate sysinit units... machine # [ 55.502506] systemd[1]: Reached target Reactivate sysinit units. machine # [ 55.505106] systemd[1]: Reached target Local File Systems. machine # [ 55.507392] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.510985] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 55.515466] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 55.524770] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 55.525689] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 55.526927] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 55.537491] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 55.539181] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.541582] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.542899] systemd[1]: Reached target Remote File Systems. machine # [ 55.710078] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 55.714664] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 55.718556] systemd[1]: Starting -.service... machine # [ 55.721714] systemd[1]: Starting linger-users.service... machine # [ 55.763077] systemd[1]: Finished -.service. machine # [ 55.784785] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 55.788172] systemd[1]: Finished linger-users.service. machine # [ 56.043123] nixos[3156]: finished switching to system configuration /nix/store/j5wi19qaalmvsps62qfcc5w0i5qkvsf9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 2.05 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 56.286672] nixos[3298]: switching to system configuration /nix/store/9fllxkd6vzl08hipbcd7nbwl2hqbd209-nixos-system-machine-test machine # [ 56.289287] systemd[1]: Stopped target Remote File Systems. machine # [ 56.291981] systemd[1]: Stopped target Local File Systems. machine # [ 56.602688] systemd[1]: Reload requested from client PID 3298 ('.switch-to-conf') (unit backdoor.service)... machine # [ 56.605020] systemd[1]: Reloading... machine # [ 56.971360] systemd[1]: Reloading finished in 364 ms. machine # [ 57.063005] systemd[538]: Reexecution requested from client PID 3367 ('switch-to-confi')... machine # [ 57.067337] systemd[538]: Reexecuting. machine # [ 57.123534] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.243930] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.252136] systemd[538]: Reload requested from client PID 3367 ('switch-to-confi')... machine # [ 57.254688] systemd[538]: Reloading... machine # [ 57.370717] systemd[538]: Reloading finished in 115 ms. machine # [ 57.388218] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.399504] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 57.402230] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 57.404812] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 57.438869] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 57.443812] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 57.448627] systemd[1]: Stopping Reactivate sysinit units... machine # [ 57.449642] systemd[1]: Reached target Reactivate sysinit units. machine # [ 57.452418] systemd[1]: Reloading -.service... machine # [ 57.479757] systemd[1]: Reloaded -.service. machine # [ 57.485878] systemd[1]: Reached target Remote File Systems. machine # [ 57.490508] systemd[1]: Starting linger-users.service... machine # [ 57.494313] systemd[1]: Reached target Local File Systems. machine # [ 57.504138] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 57.514360] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 57.515375] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 57.528186] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 57.530588] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 57.541848] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.543283] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.549244] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.550704] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 57.598087] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 57.601093] systemd[1]: Finished linger-users.service. machine # [ 57.768238] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 57.770655] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 58.028383] nixos[3298]: finished switching to system configuration /nix/store/9fllxkd6vzl08hipbcd7nbwl2hqbd209-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.99 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 58.803295] nixos[3440]: switching to system configuration /nix/store/6548afcw4v6j8f07xj6pjz8hcv0j4x4b-nixos-system-machine-test machine # [ 58.807570] systemd[1]: Stopped target Local File Systems. machine # [ 58.809340] systemd[1]: Stopped target Remote File Systems. machine # [ 58.810190] systemd[1]: -.service: Deactivated successfully. machine # [ 58.811000] systemd[1]: Stopped -.service. machine # [ 59.111670] systemd[1]: Reload requested from client PID 3440 ('.switch-to-conf') (unit backdoor.service)... machine # [ 59.114032] systemd[1]: Reloading... machine # [ 59.478704] systemd[1]: Reloading finished in 363 ms. machine # [ 59.568369] systemd[538]: Reexecution requested from client PID 3509 ('switch-to-confi')... machine # [ 59.573154] systemd[538]: Reexecuting. machine # [ 59.627380] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.744988] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.752535] systemd[538]: Reload requested from client PID 3509 ('switch-to-confi')... machine # [ 59.753912] systemd[538]: Reloading... machine # [ 59.863361] systemd[538]: Reloading finished in 108 ms. machine # [ 59.880238] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.891832] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 59.894534] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 59.896666] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 59.929056] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 59.933732] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 59.935753] systemd[1]: Stopping Reactivate sysinit units... machine # [ 59.939191] systemd[1]: Reached target Reactivate sysinit units. machine # [ 59.942128] systemd[1]: Reached target Local File Systems. machine # [ 59.944448] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.945860] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 59.950147] systemd[1]: Reached target Remote File Systems. machine # [ 59.955688] systemd[1]: Starting linger-users.service... machine # [ 59.959453] systemd[1]: Starting required-service.service... machine # [ 59.965148] systemd[1]: Starting test-service.service... machine # [ 59.986691] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 59.996239] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 59.997337] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 59.998614] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 60.013715] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 60.015484] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.027813] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.061980] systemd[1]: Finished test-service.service. machine # [ 60.074769] systemd[1]: Finished required-service.service. machine # [ 60.100994] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 60.102843] systemd[1]: Finished linger-users.service. machine # [ 60.258713] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 60.260796] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 60.518828] nixos[3440]: finished switching to system configuration /nix/store/6548afcw4v6j8f07xj6pjz8hcv0j4x4b-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 2.49 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 60.757287] nixos[3584]: switching to system configuration /nix/store/cjwxxfvj33dzdswjjvjdlinkfmbw6vgh-nixos-system-machine-test machine # [ 60.760573] systemd[1]: Stopped target Remote File Systems. machine # [ 60.762304] systemd[1]: required-service.service: Deactivated successfully. machine # [ 60.765295] systemd[1]: Stopped required-service.service. machine # [ 60.766187] systemd[1]: test-service.service: Deactivated successfully. machine # [ 60.767129] systemd[1]: Stopped test-service.service. machine # [ 60.768505] systemd[1]: Stopped target Local File Systems. machine # [ 61.087132] systemd[1]: Reload requested from client PID 3584 ('.switch-to-conf') (unit backdoor.service)... machine # [ 61.089375] systemd[1]: Reloading... machine # [ 61.449823] systemd[1]: Reloading finished in 359 ms. machine # [ 61.541823] systemd[538]: Reexecution requested from client PID 3653 ('switch-to-confi')... machine # [ 61.543290] systemd[538]: Reexecuting. machine # [ 61.603637] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.727213] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.732642] systemd[538]: Reload requested from client PID 3653 ('switch-to-confi')... machine # [ 61.733989] systemd[538]: Reloading... machine # [ 61.841152] systemd[538]: Reloading finished in 105 ms. machine # [ 61.856180] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.867854] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 61.870448] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 61.872516] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 61.903754] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 61.907862] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 61.910482] systemd[1]: Stopping Reactivate sysinit units... machine # [ 61.911345] systemd[1]: Reached target Reactivate sysinit units. machine # [ 61.915851] systemd[1]: Reached target Local File Systems. machine # [ 61.919846] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 61.924691] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 61.925576] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 61.926828] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 61.938217] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 61.939920] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.951960] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.954433] systemd[1]: Reached target Remote File Systems. machine # [ 61.956411] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.957783] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 62.117540] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 62.121388] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 62.127738] systemd[1]: Starting linger-users.service... machine # [ 62.131961] systemd[1]: Starting required-service.service... machine # [ 62.135938] systemd[1]: Starting test-service.service... machine # [ 62.194485] systemd[1]: Finished required-service.service. machine # [ 62.197807] systemd[1]: Finished test-service.service. machine # [ 62.219126] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 62.221347] systemd[1]: Finished linger-users.service. machine # [ 62.478604] nixos[3584]: finished switching to system configuration /nix/store/cjwxxfvj33dzdswjjvjdlinkfmbw6vgh-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.96 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 62.719715] nixos[3728]: switching to system configuration /nix/store/h63bhwyjr0cm2hv1rjx9rabi8a7v7abl-nixos-system-machine-test machine # [ 62.723008] systemd[1]: Stopped target Local File Systems. machine # [ 62.725867] systemd[1]: required-service.service: Deactivated successfully. machine # [ 62.726958] systemd[1]: Stopped required-service.service. machine # [ 62.727771] systemd[1]: test-service.service: Deactivated successfully. machine # [ 62.732505] systemd[1]: Stopped test-service.service. machine # [ 62.733632] systemd[1]: Stopped target Remote File Systems. machine # [ 63.043186] systemd[1]: Reload requested from client PID 3728 ('.switch-to-conf') (unit backdoor.service)... machine # [ 63.045358] systemd[1]: Reloading... machine # [ 63.390440] systemd[1]: Reloading finished in 343 ms. machine # [ 63.476436] systemd[538]: Reexecution requested from client PID 3797 ('switch-to-confi')... machine # [ 63.479722] systemd[538]: Reexecuting. machine # [ 63.535262] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.649563] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.657198] systemd[538]: Reload requested from client PID 3797 ('switch-to-confi')... machine # [ 63.658571] systemd[538]: Reloading... machine # [ 63.767652] systemd[538]: Reloading finished in 107 ms. machine # [ 63.784202] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.797598] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 63.798714] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 63.800937] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 63.834427] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 63.839122] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 63.841717] systemd[1]: Stopping Reactivate sysinit units... machine # [ 63.842650] systemd[1]: Reached target Reactivate sysinit units. machine # [ 63.847910] systemd[1]: Starting required-service.service... machine # [ 63.853164] systemd[1]: Reached target Remote File Systems. machine # [ 63.857524] systemd[1]: Starting linger-users.service... machine # [ 63.868635] systemd[1]: Starting test-service.service... machine # [ 63.886023] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.887513] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 63.900944] systemd[1]: Reached target Local File Systems. machine # [ 63.901900] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 63.903608] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 63.926649] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 63.933335] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 63.935696] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 63.947310] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.958111] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.967497] systemd[1]: Finished required-service.service. machine # [ 63.971208] systemd[1]: Finished test-service.service. machine # [ 64.001878] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 64.003740] systemd[1]: Finished linger-users.service. machine # [ 64.143361] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 64.146512] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 64.402590] nixos[3728]: finished switching to system configuration /nix/store/h63bhwyjr0cm2hv1rjx9rabi8a7v7abl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.92 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 64.634637] nixos[3872]: switching to system configuration /nix/store/1fyqb8rjaqqysqs6wfjwxzd9hginbk76-nixos-system-machine-test machine # [ 64.637893] systemd[1]: required-service.service: Deactivated successfully. machine # [ 64.641567] systemd[1]: Stopped required-service.service. machine # [ 64.642481] systemd[1]: test-service.service: Deactivated successfully. machine # [ 64.643425] systemd[1]: Stopped test-service.service. machine # [ 64.646278] systemd[1]: Stopped target Remote File Systems. machine # [ 64.647138] systemd[1]: Stopped target Local File Systems. machine # [ 64.941417] systemd[1]: Reload requested from client PID 3872 ('.switch-to-conf') (unit backdoor.service)... machine # [ 64.943417] systemd[1]: Reloading... machine # [ 65.283060] systemd[1]: Reloading finished in 338 ms. machine # [ 65.371738] systemd[538]: Reexecution requested from client PID 3941 ('switch-to-confi')... machine # [ 65.374298] systemd[538]: Reexecuting. machine # [ 65.431465] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.545532] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.552370] systemd[538]: Reload requested from client PID 3941 ('switch-to-confi')... machine # [ 65.554941] systemd[538]: Reloading... machine # [ 65.661297] systemd[538]: Reloading finished in 105 ms. machine # [ 65.677746] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.686432] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 65.688885] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 65.691074] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 65.725000] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 65.729615] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 65.731119] systemd[1]: Stopping Reactivate sysinit units... machine # [ 65.731990] systemd[1]: Reached target Reactivate sysinit units. machine # [ 65.735160] systemd[1]: Reached target Local File Systems. machine # [ 65.741614] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 65.743215] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 65.751940] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 65.758859] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 65.762309] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 65.763933] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.771053] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.774915] systemd[1]: Reached target Remote File Systems. machine # [ 65.776484] systemd[1]: Created slice Slice /system/instantiated. machine # [ 65.778435] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.780134] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 65.931792] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 65.936598] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 65.940365] systemd[1]: Starting instantiated@one.service... machine # [ 65.948343] systemd[1]: Starting instantiated@two.service... machine # [ 65.949471] systemd[1]: Starting linger-users.service... machine # [ 66.006474] systemd[1]: Finished instantiated@one.service. machine # [ 66.009949] systemd[1]: Finished instantiated@two.service. machine # [ 66.029610] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 66.031336] systemd[1]: Finished linger-users.service. machine # [ 66.288133] nixos[3872]: finished switching to system configuration /nix/store/1fyqb8rjaqqysqs6wfjwxzd9hginbk76-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.89 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 66.540324] nixos[4016]: switching to system configuration /nix/store/wxajqfka5jiwzb223fblgxbql1n83ih3-nixos-system-machine-test machine # [ 66.543066] systemd[1]: Stopped target Remote File Systems. machine # [ 66.546729] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 66.547862] systemd[1]: Stopped instantiated@one.service. machine # [ 66.549314] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 66.550351] systemd[1]: Stopped instantiated@two.service. machine # [ 66.551153] systemd[1]: Stopped target Local File Systems. machine # [ 66.855115] systemd[1]: Reload requested from client PID 4016 ('.switch-to-conf') (unit backdoor.service)... machine # [ 66.857265] systemd[1]: Reloading... machine # [ 67.186320] systemd[1]: Reloading finished in 327 ms. machine # [ 67.277487] systemd[538]: Reexecution requested from client PID 4085 ('switch-to-confi')... machine # [ 67.282097] systemd[538]: Reexecuting. machine # [ 67.343931] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.461462] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.468254] systemd[538]: Reload requested from client PID 4085 ('switch-to-confi')... machine # [ 67.470979] systemd[538]: Reloading... machine # [ 67.578469] systemd[538]: Reloading finished in 106 ms. machine # [ 67.597837] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.606126] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 67.608792] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 67.611054] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 67.644762] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 67.649167] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 67.652213] systemd[1]: Stopping Reactivate sysinit units... machine # [ 67.653161] systemd[1]: Reached target Reactivate sysinit units. machine # [ 67.654027] systemd[1]: Reached target Remote File Systems. machine # [ 67.656446] systemd[1]: Reached target Local File Systems. machine # [ 67.662202] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 67.663851] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 67.672700] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 67.674084] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 67.685340] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 67.687098] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.691156] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.693621] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.694987] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 67.855402] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 67.860679] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 67.864233] systemd[1]: Starting instantiated@one.service... machine # [ 67.868552] systemd[1]: Starting instantiated@two.service... machine # [ 67.871655] systemd[1]: Starting linger-users.service... machine # [ 67.929610] systemd[1]: Finished instantiated@one.service. machine # [ 67.933818] systemd[1]: Finished instantiated@two.service. machine # [ 67.953635] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 67.956582] systemd[1]: Finished linger-users.service. machine # [ 68.212687] nixos[4016]: finished switching to system configuration /nix/store/wxajqfka5jiwzb223fblgxbql1n83ih3-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.93 seconds) (finished: subtest: services, in 46.99 seconds) subtest: failing units machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 68.439924] nixos[4160]: switching to system configuration /nix/store/f9j1g17kp1cycddhw7flsj254qs35lcw-nixos-system-machine-test machine # [ 68.443458] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 68.446523] systemd[1]: Stopped instantiated@two.service. machine # [ 68.447465] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 68.450958] systemd[1]: Stopped instantiated@one.service. machine # [ 68.451859] systemd[1]: Stopped target Remote File Systems. machine # [ 68.453236] systemd[1]: Stopped target Local File Systems. machine # [ 68.738932] systemd[1]: Reload requested from client PID 4160 ('.switch-to-conf') (unit backdoor.service)... machine # [ 68.741211] systemd[1]: Reloading... machine # [ 69.067257] systemd[1]: Reloading finished in 324 ms. machine # [ 69.155094] systemd[538]: Reexecution requested from client PID 4229 ('switch-to-confi')... machine # [ 69.159621] systemd[538]: Reexecuting. machine # [ 69.219531] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.334565] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.341683] systemd[538]: Reload requested from client PID 4229 ('switch-to-confi')... machine # [ 69.344367] systemd[538]: Reloading... machine # [ 69.453125] systemd[538]: Reloading finished in 107 ms. machine # [ 69.469781] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.477824] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 69.480083] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 69.482419] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 69.511802] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 69.516127] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 69.519958] systemd[1]: Stopping Reactivate sysinit units... machine # [ 69.524778] systemd[1]: Reached target Reactivate sysinit units. machine # [ 69.525743] systemd[1]: Reached target Remote File Systems. machine # [ 69.534302] systemd[1]: Starting linger-users.service... machine # [ 69.535269] systemd[1]: Starting test.service... machine # [ 69.535976] systemd[1]: Reached target Local File Systems. machine # [ 69.546282] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.547722] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 69.566929] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 69.574732] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 69.581285] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 69.585787] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 69.594661] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 69.605719] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.609861] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.611239] systemd[1]: Finished test.service. machine # [ 69.644766] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 69.649304] systemd[1]: Finished linger-users.service. machine # [ 69.789037] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 69.792315] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.049444] nixos[4160]: finished switching to system configuration /nix/store/f9j1g17kp1cycddhw7flsj254qs35lcw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.84 seconds) machine: must fail: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 70.283111] nixos[4302]: switching to system configuration /nix/store/i6g526s5ayz1zc4597fvilb68m2kr5xd-nixos-system-machine-test machine # [ 70.286552] systemd[1]: Stopped target Remote File Systems. machine # [ 70.288863] systemd[1]: test.service: Deactivated successfully. machine # [ 70.289864] systemd[1]: Stopped test.service. machine # [ 70.291467] systemd[1]: Stopped target Local File Systems. machine # [ 70.611843] systemd[1]: Reload requested from client PID 4302 ('.switch-to-conf') (unit backdoor.service)... machine # [ 70.614707] systemd[1]: Reloading... machine # [ 70.942572] systemd[1]: Reloading finished in 325 ms. machine # [ 71.032054] systemd[538]: Reexecution requested from client PID 4371 ('switch-to-confi')... machine # [ 71.033489] systemd[538]: Reexecuting. machine # [ 71.092149] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.205707] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.213455] systemd[538]: Reload requested from client PID 4371 ('switch-to-confi')... machine # [ 71.217634] systemd[538]: Reloading... machine # [ 71.325411] systemd[538]: Reloading finished in 108 ms. machine # [ 71.341949] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.351217] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 71.353837] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 71.356188] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 71.389752] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 71.393874] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 71.396870] systemd[1]: Stopping Reactivate sysinit units... machine # [ 71.397843] systemd[1]: Reached target Reactivate sysinit units. machine # [ 71.402930] systemd[1]: Reached target Local File Systems. machine # [ 71.403895] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 71.413979] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 71.414978] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 71.423095] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 71.434140] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 71.435950] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.437721] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.438969] systemd[1]: Reached target Remote File Systems. machine # [ 71.439778] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.441253] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 71.604364] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 71.607365] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 71.612189] systemd[1]: Starting linger-users.service... machine # [ 71.616589] systemd[1]: Starting test.service... machine # [ 71.656350] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 71.661008] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 71.662406] systemd[1]: Failed to start test.service. machine # [ 71.682521] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 71.684556] systemd[1]: Finished linger-users.service. machine # [ 71.963599] nixos[4302]: switching to system configuration /nix/store/i6g526s5ayz1zc4597fvilb68m2kr5xd-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.91 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 72.191194] nixos[4445]: switching to system configuration /nix/store/1sf2rc83rm3b48ng52sg62s0xah540ra-nixos-system-machine-test machine # [ 72.193864] systemd[1]: Stopped target Local File Systems. machine # [ 72.196183] systemd[1]: Stopped target Remote File Systems. machine # [ 72.486550] systemd[1]: Reload requested from client PID 4445 ('.switch-to-conf') (unit backdoor.service)... machine # [ 72.488694] systemd[1]: Reloading... machine # [ 72.843176] systemd[1]: Reloading finished in 353 ms. machine # [ 72.952558] systemd[538]: Reexecution requested from client PID 4514 ('switch-to-confi')... machine # [ 72.954149] systemd[538]: Reexecuting. machine # [ 73.011750] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.145844] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.153426] systemd[538]: Reload requested from client PID 4514 ('switch-to-confi')... machine # [ 73.157690] systemd[538]: Reloading... machine # [ 73.272723] systemd[538]: Reloading finished in 116 ms. machine # [ 73.288190] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.302051] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 73.303188] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 73.307032] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 73.342859] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 73.348859] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 73.349969] systemd[1]: Stopping Reactivate sysinit units... machine # [ 73.350813] systemd[1]: Reached target Reactivate sysinit units. machine # [ 73.355979] systemd[1]: Reached target Local File Systems. machine # [ 73.359027] systemd[1]: Reached target Remote File Systems. machine # [ 73.363373] systemd[1]: Started autorestart.service. machine # [ 73.366974] systemd[1]: Starting linger-users.service... machine # [ 73.377042] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 73.378697] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 73.379581] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 73.396624] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 73.399027] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 73.409315] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.410710] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.411978] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.420638] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 73.462193] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 73.509754] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 73.514064] systemd[1]: Finished linger-users.service. machine # [ 73.665580] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 73.669915] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 73.934372] nixos[4445]: finished switching to system configuration /nix/store/1sf2rc83rm3b48ng52sg62s0xah540ra-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.97 seconds) machine # [ 73.986978] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 74.248481] nixos[4592]: switching to system configuration /nix/store/1sf2rc83rm3b48ng52sg62s0xah540ra-nixos-system-machine-test machine # [ 74.250996] systemd[1]: Stopped target Local File Systems. machine # [ 74.253456] systemd[1]: Stopped target Remote File Systems. machine # [ 74.529570] systemd[1]: Reload requested from client PID 4592 ('.switch-to-conf') (unit backdoor.service)... machine # [ 74.531533] systemd[1]: Reloading... machine # [ 74.849333] systemd[1]: Reloading finished in 316 ms. machine # [ 74.932200] systemd[538]: Reexecution requested from client PID 4661 ('switch-to-confi')... machine # [ 74.937135] systemd[538]: Reexecuting. machine # [ 74.995634] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.121498] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.128288] systemd[538]: Reload requested from client PID 4661 ('switch-to-confi')... machine # [ 75.132142] systemd[538]: Reloading... machine # [ 75.240049] systemd[538]: Reloading finished in 108 ms. machine # [ 75.256193] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.267046] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 75.269525] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 75.271719] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 75.305093] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 75.309539] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 75.311561] systemd[1]: Stopping Reactivate sysinit units... machine # [ 75.313970] systemd[1]: Reached target Reactivate sysinit units. machine # [ 75.319553] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.322245] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 75.325158] systemd[1]: Reached target Local File Systems. machine # [ 75.328884] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 75.332558] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 75.333456] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 75.334745] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 75.345892] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 75.347580] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.351451] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.352970] systemd[1]: Reached target Remote File Systems. machine # [ 75.509758] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 75.512979] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 75.517118] systemd[1]: Started autorestart.service. machine # [ 75.522960] systemd[1]: Starting linger-users.service... machine # [ 75.560279] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 75.580216] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 75.583290] systemd[1]: Finished linger-users.service. machine # [ 75.839965] nixos[4592]: finished switching to system configuration /nix/store/1sf2rc83rm3b48ng52sg62s0xah540ra-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.85 seconds) machine # [ 75.881528] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 76.115718] nixos[4739]: switching to system configuration /nix/store/fl4mv0i2x8hmdrqf5xsxymhb9nyfmlp2-nixos-system-machine-test machine # [ 76.118378] systemd[1]: Stopped target Local File Systems. machine # [ 76.121063] systemd[1]: Stopped target Remote File Systems. machine # [ 76.431791] systemd[1]: Reload requested from client PID 4739 ('.switch-to-conf') (unit backdoor.service)... machine # [ 76.434259] systemd[1]: Reloading... machine # [ 76.805646] systemd[1]: Reloading finished in 369 ms. machine # [ 76.896656] systemd[538]: Reexecution requested from client PID 4808 ('switch-to-confi')... machine # [ 76.899372] systemd[538]: Reexecuting. machine # [ 76.959439] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.073175] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.080845] systemd[538]: Reload requested from client PID 4808 ('switch-to-confi')... machine # [ 77.082266] systemd[538]: Reloading... machine # [ 77.193543] systemd[538]: Reloading finished in 110 ms. machine # [ 77.208202] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.219566] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 77.222182] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 77.224698] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 77.256734] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 77.260999] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 77.263656] systemd[1]: Stopping Reactivate sysinit units... machine # [ 77.265806] systemd[1]: Reached target Reactivate sysinit units. machine # [ 77.268310] systemd[1]: Reached target Local File Systems. machine # [ 77.273794] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 77.281982] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 77.282924] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 77.291925] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 77.297528] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 77.299526] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.301404] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.302804] systemd[1]: Reached target Remote File Systems. machine # [ 77.305610] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.308220] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 77.457701] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 77.462695] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 77.466616] systemd[1]: Started autorestart.service. machine # [ 77.469596] systemd[1]: Starting linger-users.service... machine # [ 77.507563] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 77.511122] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 77.528616] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 77.531584] systemd[1]: Finished linger-users.service. machine # [ 77.806885] nixos[4739]: switching to system configuration /nix/store/fl4mv0i2x8hmdrqf5xsxymhb9nyfmlp2-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.92 seconds) (finished: subtest: failing units, in 9.59 seconds) subtest: unit file parser machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 78.030432] nixos[4882]: switching to system configuration /nix/store/g6wmn9xvnyx781gjs5d3s2fflnlm93dl-nixos-system-machine-test machine # [ 78.033337] systemd[1]: Stopped target Local File Systems. machine # [ 78.037384] systemd[1]: Stopped target Remote File Systems. machine # [ 78.038319] systemd[1]: Stopped autorestart.service. machine # [ 78.326682] systemd[1]: Reload requested from client PID 4882 ('.switch-to-conf') (unit backdoor.service)... machine # [ 78.328767] systemd[1]: Reloading... machine # [ 78.662833] systemd[1]: Reloading finished in 332 ms. machine # [ 78.762246] systemd[538]: Reexecution requested from client PID 4951 ('switch-to-confi')... machine # [ 78.763740] systemd[538]: Reexecuting. machine # [ 78.829128] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.939471] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.947009] systemd[538]: Reload requested from client PID 4951 ('switch-to-confi')... machine # [ 78.950769] systemd[538]: Reloading... machine # [ 79.060744] systemd[538]: Reloading finished in 111 ms. machine # [ 79.076163] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.086429] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 79.088932] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 79.091366] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 79.125460] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 79.129988] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 79.133638] systemd[1]: Stopping Reactivate sysinit units... machine # [ 79.134483] systemd[1]: Reached target Reactivate sysinit units. machine # [ 79.139036] systemd[1]: Reached target Local File Systems. machine # [ 79.142717] systemd[1]: Reached target Remote File Systems. machine # [ 79.143588] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 79.147831] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 79.153463] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 79.154729] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 79.166486] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 79.168339] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.169658] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.170859] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.173695] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 79.341958] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 79.345123] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 79.350957] systemd[1]: Starting linger-users.service... machine # [ 79.354195] systemd[1]: Starting test.service... machine # [ 79.390223] systemd[1]: Finished test.service. machine # [ 79.411250] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 79.413147] systemd[1]: Finished linger-users.service. machine # [ 79.673583] nixos[4882]: finished switching to system configuration /nix/store/g6wmn9xvnyx781gjs5d3s2fflnlm93dl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.87 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 79.951339] nixos[5024]: switching to system configuration /nix/store/g9niarpr60iavc7sbhklplx61aag6y61-nixos-system-machine-test machine # [ 79.954422] systemd[1]: Stopped target Local File Systems. machine # [ 79.957212] systemd[1]: Stopped target Remote File Systems. machine # [ 80.278018] systemd[1]: Reload requested from client PID 5024 ('.switch-to-conf') (unit backdoor.service)... machine # [ 80.280168] systemd[1]: Reloading... machine # [ 80.639668] systemd[1]: Reloading finished in 357 ms. machine # [ 80.730614] systemd[538]: Reexecution requested from client PID 5093 ('switch-to-confi')... machine # [ 80.733633] systemd[538]: Reexecuting. machine # [ 80.792249] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.910127] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.917257] systemd[538]: Reload requested from client PID 5093 ('switch-to-confi')... machine # [ 80.920091] systemd[538]: Reloading... machine # [ 81.033540] systemd[538]: Reloading finished in 113 ms. machine # [ 81.048181] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.058415] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 81.060934] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 81.063126] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 81.096747] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 81.101261] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 81.103510] systemd[1]: Stopping Reactivate sysinit units... machine # [ 81.107877] systemd[1]: Reached target Reactivate sysinit units. machine # [ 81.110873] systemd[1]: test.service: Deactivated successfully. machine # [ 81.111805] systemd[1]: Stopped test.service. machine # [ 81.116480] systemd[1]: Stopping test.service... machine # [ 81.117367] systemd[1]: Starting test.service... machine # [ 81.139959] systemd[1]: Finished test.service. machine # [ 81.145829] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.150098] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 81.152127] systemd[1]: Reached target Local File Systems. machine # [ 81.156474] systemd[1]: Reached target Remote File Systems. machine # [ 81.159135] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 81.168525] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 81.169524] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 81.170860] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 81.182278] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 81.184232] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.185591] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.386141] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 81.391036] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 81.393372] systemd[1]: Starting linger-users.service... machine # [ 81.437847] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 81.441090] systemd[1]: Finished linger-users.service. machine # [ 81.698063] nixos[5024]: finished switching to system configuration /nix/store/g9niarpr60iavc7sbhklplx61aag6y61-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 2.02 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 81.948576] nixos[5166]: switching to system configuration /nix/store/vcxgkm239dn7022kz288y4b9d6jd7zlj-nixos-system-machine-test machine # [ 81.951228] systemd[1]: Stopped target Remote File Systems. machine # [ 81.953790] systemd[1]: Stopped target Local File Systems. machine # [ 82.289075] systemd[1]: Reload requested from client PID 5166 ('.switch-to-conf') (unit backdoor.service)... machine # [ 82.291153] systemd[1]: Reloading... machine # [ 82.659757] systemd[1]: Reloading finished in 365 ms. machine # [ 82.758018] systemd[538]: Reexecution requested from client PID 5235 ('switch-to-confi')... machine # [ 82.762016] systemd[538]: Reexecuting. machine # [ 82.819523] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.934930] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.942251] systemd[538]: Reload requested from client PID 5235 ('switch-to-confi')... machine # [ 82.946263] systemd[538]: Reloading... machine # [ 83.053891] systemd[538]: Reloading finished in 108 ms. machine # [ 83.068212] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.079726] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 83.082153] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 83.084481] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 83.118788] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 83.123054] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 83.125257] systemd[1]: Stopping Reactivate sysinit units... machine # [ 83.126088] systemd[1]: Reached target Reactivate sysinit units. machine # [ 83.128472] systemd[1]: test.service: Deactivated successfully. machine # [ 83.129347] systemd[1]: Stopped test.service. machine # [ 83.129946] systemd[1]: Stopping test.service... machine # [ 83.133911] systemd[1]: Starting test.service... machine # [ 83.157928] systemd[1]: Finished test.service. machine # [ 83.165077] systemd[1]: Reached target Remote File Systems. machine # [ 83.169998] systemd[1]: Starting linger-users.service... machine # [ 83.173390] systemd[1]: Reached target Local File Systems. machine # [ 83.176245] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 83.194729] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 83.195787] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 83.202410] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 83.205544] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 83.207203] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.211400] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.215873] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.222995] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 83.277198] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 83.279182] systemd[1]: Finished linger-users.service. machine # [ 83.470275] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 83.472395] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 83.729893] nixos[5166]: finished switching to system configuration /nix/store/vcxgkm239dn7022kz288y4b9d6jd7zlj-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 2.03 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 84.015047] nixos[5308]: switching to system configuration /nix/store/g6wmn9xvnyx781gjs5d3s2fflnlm93dl-nixos-system-machine-test machine # [ 84.018629] systemd[1]: Stopped target Local File Systems. machine # [ 84.022139] systemd[1]: Stopped target Remote File Systems. machine # [ 84.344372] systemd[1]: Reload requested from client PID 5308 ('.switch-to-conf') (unit backdoor.service)... machine # [ 84.346516] systemd[1]: Reloading... machine # [ 84.726442] systemd[1]: Reloading finished in 378 ms. machine # [ 84.836907] systemd[538]: Reexecution requested from client PID 5377 ('switch-to-confi')... machine # [ 84.841074] systemd[538]: Reexecuting. machine # [ 84.899954] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.063274] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.072215] systemd[538]: Reload requested from client PID 5377 ('switch-to-confi')... machine # [ 85.074418] systemd[538]: Reloading... machine # [ 85.210856] systemd[538]: Reloading finished in 129 ms. machine # [ 85.228585] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.243220] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 85.246183] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 85.248541] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 85.286553] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 85.291786] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 85.297065] systemd[1]: Stopping Reactivate sysinit units... machine # [ 85.297982] systemd[1]: Reached target Reactivate sysinit units. machine # [ 85.298910] systemd[1]: test.service: Deactivated successfully. machine # [ 85.299761] systemd[1]: Stopped test.service. machine # [ 85.302996] systemd[1]: Stopping test.service... machine # [ 85.306636] systemd[1]: Starting test.service... machine # [ 85.338085] systemd[1]: Finished test.service. machine # [ 85.342289] systemd[1]: Reached target Local File Systems. machine # [ 85.347960] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.350345] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 85.356851] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 85.361853] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 85.362806] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 85.372475] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 85.374775] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 85.379487] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.381415] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.382673] systemd[1]: Reached target Remote File Systems. machine # [ 85.580701] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 85.586305] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 85.589390] systemd[1]: Starting linger-users.service... machine # [ 85.650184] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 85.652170] systemd[1]: Finished linger-users.service. machine # [ 85.908524] nixos[5308]: finished switching to system configuration /nix/store/g6wmn9xvnyx781gjs5d3s2fflnlm93dl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.18 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 86.169657] nixos[5450]: switching to system configuration /nix/store/0zan7idyqln5pz4sjgrwb29kikwz6xck-nixos-system-machine-test machine # [ 86.172074] systemd[1]: Stopped target Local File Systems. machine # [ 86.174728] systemd[1]: Stopped target Remote File Systems. machine # [ 86.533680] systemd[1]: Reload requested from client PID 5450 ('.switch-to-conf') (unit backdoor.service)... machine # [ 86.535783] systemd[1]: Reloading... machine # [ 86.965498] systemd[1]: Reloading finished in 427 ms. machine # [ 87.054745] systemd[538]: Reexecution requested from client PID 5519 ('switch-to-confi')... machine # [ 87.059025] systemd[538]: Reexecuting. machine # [ 87.120955] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.267706] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.275697] systemd[538]: Reload requested from client PID 5519 ('switch-to-confi')... machine # [ 87.278414] systemd[538]: Reloading... machine # [ 87.408909] systemd[538]: Reloading finished in 128 ms. machine # [ 87.428221] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.440818] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 87.443863] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 87.446555] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 87.482791] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 87.487830] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 87.491672] systemd[1]: Stopping Reactivate sysinit units... machine # [ 87.495268] systemd[1]: Reached target Reactivate sysinit units. machine # [ 87.497354] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.498637] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 87.501097] systemd[1]: Reached target Local File Systems. machine # [ 87.507190] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 87.509984] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 87.510889] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 87.512336] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 87.518128] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 87.527393] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.533611] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.535511] systemd[1]: Reached target Remote File Systems. machine # [ 87.744154] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 87.748828] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 87.752379] systemd[1]: Starting linger-users.service... machine # [ 87.798038] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 87.800982] systemd[1]: Finished linger-users.service. machine # [ 88.057837] nixos[5450]: finished switching to system configuration /nix/store/0zan7idyqln5pz4sjgrwb29kikwz6xck-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 2.15 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 88.287478] nixos[5590]: switching to system configuration /nix/store/xky3cybs6bjvxx55j13jklvdnzd1kr3g-nixos-system-machine-test machine # [ 88.292569] systemd[1]: Stopped target Local File Systems. machine # [ 88.294018] systemd[1]: Stopped target Remote File Systems. machine # [ 88.667123] systemd[1]: Reload requested from client PID 5590 ('.switch-to-conf') (unit backdoor.service)... machine # [ 88.670341] systemd[1]: Reloading... machine # [ 89.086569] systemd[1]: Reloading finished in 413 ms. machine # [ 89.188435] systemd[538]: Reexecution requested from client PID 5659 ('switch-to-confi')... machine # [ 89.189752] systemd[538]: Reexecuting. machine # [ 89.247526] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.384821] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.393644] systemd[538]: Reload requested from client PID 5659 ('switch-to-confi')... machine # [ 89.396661] systemd[538]: Reloading... machine # [ 89.533809] systemd[538]: Reloading finished in 135 ms. machine # [ 89.552337] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.563516] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 89.566889] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 89.570171] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 89.609105] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 89.613992] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 89.619945] systemd[1]: Stopping Reactivate sysinit units... machine # [ 89.621634] systemd[1]: Reached target Reactivate sysinit units. machine # [ 89.622818] systemd[1]: test.service: Deactivated successfully. machine # [ 89.623936] systemd[1]: Stopped test.service. machine # [ 89.625128] systemd[1]: Stopping test.service... machine # [ 89.628274] systemd[1]: Starting test.service... machine # [ 89.656634] systemd[1]: Finished test.service. machine # [ 89.663003] systemd[1]: Reached target Local File Systems. machine # [ 89.668486] systemd[1]: Reached target Remote File Systems. machine # [ 89.676538] systemd[1]: Starting linger-users.service... machine # [ 89.684447] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 89.695995] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 89.697552] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 89.699313] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 89.714987] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 89.723887] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.730165] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.731475] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.739638] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 89.782936] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 89.786599] systemd[1]: Finished linger-users.service. machine # [ 89.949561] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 89.953364] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 90.206446] nixos[5590]: finished switching to system configuration /nix/store/xky3cybs6bjvxx55j13jklvdnzd1kr3g-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 2.15 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 90.525261] nixos[5732]: switching to system configuration /nix/store/kjzql89367myi2b8k0yckn1zcapzp1ip-nixos-system-machine-test machine # [ 90.528619] systemd[1]: Stopped target Local File Systems. machine # [ 90.531341] systemd[1]: Stopped target Remote File Systems. machine # [ 90.888665] systemd[1]: Reload requested from client PID 5732 ('.switch-to-conf') (unit backdoor.service)... machine # [ 90.891392] systemd[1]: Reloading... machine # [ 91.316652] systemd[1]: Reloading finished in 422 ms. machine # [ 91.420845] systemd[538]: Reexecution requested from client PID 5801 ('switch-to-confi')... machine # [ 91.424195] systemd[538]: Reexecuting. machine # [ 91.495447] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.635707] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.643813] systemd[538]: Reload requested from client PID 5801 ('switch-to-confi')... machine # [ 91.646229] systemd[538]: Reloading... machine # [ 91.786071] systemd[538]: Reloading finished in 138 ms. machine # [ 91.804335] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.818559] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 91.821630] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 91.824412] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 91.864650] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 91.869326] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 91.872627] systemd[1]: Stopping Reactivate sysinit units... machine # [ 91.873536] systemd[1]: Reached target Reactivate sysinit units. machine # [ 91.874367] systemd[1]: test.service: Deactivated successfully. machine # [ 91.875217] systemd[1]: Stopped test.service. machine # [ 91.877810] systemd[1]: Stopping test.service... machine # [ 91.879590] systemd[1]: Starting test.service... machine # [ 91.941477] systemd[1]: Finished test.service. machine # [ 91.947395] systemd[1]: Reached target Remote File Systems. machine # [ 91.953499] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.954806] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 91.961421] systemd[1]: Starting linger-users.service... machine # [ 91.962872] systemd[1]: Reached target Local File Systems. machine # [ 91.970926] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 91.982398] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 91.983894] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 91.999153] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 92.006925] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 92.014156] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 92.017213] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 92.093532] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 92.098775] systemd[1]: Finished linger-users.service. machine # [ 92.300170] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 92.303786] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 92.557289] nixos[5732]: finished switching to system configuration /nix/store/kjzql89367myi2b8k0yckn1zcapzp1ip-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 2.35 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 92.966989] nixos[5874]: switching to system configuration /nix/store/d1dyrsjvnail0kjw2kj4pwbpcj65k09a-nixos-system-machine-test machine # [ 92.969953] systemd[1]: Stopped target Local File Systems. machine # [ 92.973231] systemd[1]: Stopped target Remote File Systems. machine # [ 93.360956] systemd[1]: Reload requested from client PID 5874 ('.switch-to-conf') (unit backdoor.service)... machine # [ 93.363614] systemd[1]: Reloading... machine # [ 93.809480] systemd[1]: Reloading finished in 443 ms. machine # [ 93.946163] systemd[538]: Reexecution requested from client PID 5943 ('switch-to-confi')... machine # [ 93.951033] systemd[538]: Reexecuting. machine # [ 93.995817] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.134081] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.139379] systemd[538]: Reload requested from client PID 5943 ('switch-to-confi')... machine # [ 94.142877] systemd[538]: Reloading... machine # [ 94.283500] systemd[538]: Reloading finished in 141 ms. machine # [ 94.300256] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.311638] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 94.314286] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 94.316941] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 94.354268] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 94.359058] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 94.360879] systemd[1]: Stopping Reactivate sysinit units... machine # [ 94.361805] systemd[1]: Reached target Reactivate sysinit units. machine # [ 94.366068] systemd[1]: test.service: Deactivated successfully. machine # [ 94.366946] systemd[1]: Stopped test.service. machine # [ 94.367646] systemd[1]: Stopping test.service... machine # [ 94.372334] systemd[1]: Starting test.service... machine # [ 94.403699] systemd[1]: Finished test.service. machine # [ 94.415355] systemd[1]: Reached target Remote File Systems. machine # [ 94.419265] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.421064] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 94.424973] systemd[1]: Starting linger-users.service... machine # [ 94.429708] systemd[1]: Reached target Local File Systems. machine # [ 94.436499] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 94.448439] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 94.449492] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 94.450777] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 94.458994] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 94.462500] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.465818] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.537756] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 94.542437] systemd[1]: Finished linger-users.service. machine # [ 94.781603] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 94.783497] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 95.039647] nixos[5874]: finished switching to system configuration /nix/store/d1dyrsjvnail0kjw2kj4pwbpcj65k09a-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 2.48 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 95.327343] nixos[6016]: switching to system configuration /nix/store/g6wmn9xvnyx781gjs5d3s2fflnlm93dl-nixos-system-machine-test machine # [ 95.330000] systemd[1]: Stopped target Remote File Systems. machine # [ 95.332493] systemd[1]: Stopped target Local File Systems. machine # [ 95.657547] systemd[1]: Reload requested from client PID 6016 ('.switch-to-conf') (unit backdoor.service)... machine # [ 95.659595] systemd[1]: Reloading... machine # [ 96.057491] systemd[1]: Reloading finished in 395 ms. machine # [ 96.147566] systemd[538]: Reexecution requested from client PID 6085 ('switch-to-confi')... machine # [ 96.149842] systemd[538]: Reexecuting. machine # [ 96.212606] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.355785] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.362643] systemd[538]: Reload requested from client PID 6085 ('switch-to-confi')... machine # [ 96.364921] systemd[538]: Reloading... machine # [ 96.498086] systemd[538]: Reloading finished in 131 ms. machine # [ 96.520703] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.530342] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 96.532763] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 96.534992] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 96.576090] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 96.580890] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 96.581866] systemd[1]: Stopping Reactivate sysinit units... machine # [ 96.582710] systemd[1]: Reached target Reactivate sysinit units. machine # [ 96.585908] systemd[1]: test.service: Deactivated successfully. machine # [ 96.589391] systemd[1]: Stopped test.service. machine # [ 96.590437] systemd[1]: Stopping test.service... machine # [ 96.593639] systemd[1]: Starting test.service... machine # [ 96.621344] systemd[1]: Finished test.service. machine # [ 96.624844] systemd[1]: Reached target Local File Systems. machine # [ 96.629294] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 96.636145] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 96.637614] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 96.639312] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 96.650641] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 96.661825] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.666903] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.671318] systemd[1]: Reached target Remote File Systems. machine # [ 96.673551] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.675320] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 96.884270] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 96.889073] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 96.892367] systemd[1]: Starting linger-users.service... machine # [ 96.942078] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 96.945145] systemd[1]: Finished linger-users.service. machine # [ 97.198769] nixos[6016]: finished switching to system configuration /nix/store/g6wmn9xvnyx781gjs5d3s2fflnlm93dl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.17 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 97.516572] nixos[6158]: switching to system configuration /nix/store/6l42yhssrgcwn5pnqfv7j9yadswfairr-nixos-system-machine-test machine # [ 97.520876] systemd[1]: Stopped target Local File Systems. machine # [ 97.522259] systemd[1]: Stopped target Remote File Systems. machine # [ 97.860868] systemd[1]: Reload requested from client PID 6158 ('.switch-to-conf') (unit backdoor.service)... machine # [ 97.863434] systemd[1]: Reloading... machine # [ 98.234645] systemd[1]: Reloading finished in 369 ms. machine # [ 98.334819] systemd[538]: Reexecution requested from client PID 6227 ('switch-to-confi')... machine # [ 98.339303] systemd[538]: Reexecuting. machine # [ 98.396569] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.531730] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.538790] systemd[538]: Reload requested from client PID 6227 ('switch-to-confi')... machine # [ 98.542225] systemd[538]: Reloading... machine # [ 98.670728] systemd[538]: Reloading finished in 129 ms. machine # [ 98.684189] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.695745] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 98.698827] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 98.701513] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 98.739679] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 98.744668] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 98.749841] systemd[1]: Stopping Reactivate sysinit units... machine # [ 98.750790] systemd[1]: Reached target Reactivate sysinit units. machine # [ 98.753324] systemd[1]: Reloading test.service... machine # [ 98.780582] systemd[1]: Reloaded test.service. machine # [ 98.783040] systemd[1]: Reached target Remote File Systems. machine # [ 98.791180] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.794386] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 98.797277] systemd[1]: Reached target Local File Systems. machine # [ 98.803732] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 98.809813] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 98.816845] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 98.818185] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 98.820858] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 98.822410] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.823609] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.046049] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 99.049246] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 99.054641] systemd[1]: Starting linger-users.service... machine # [ 99.098403] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 99.101786] systemd[1]: Finished linger-users.service. machine # [ 99.358351] nixos[6158]: finished switching to system configuration /nix/store/6l42yhssrgcwn5pnqfv7j9yadswfairr-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 2.15 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 99.730958] nixos[6300]: switching to system configuration /nix/store/8h9ykb59bwqqyxr1q7186w5fiv0g6r4g-nixos-system-machine-test machine # [ 99.733896] systemd[1]: Stopped target Local File Systems. machine # [ 99.736645] systemd[1]: Stopped target Remote File Systems. machine # [ 100.094525] systemd[1]: Reload requested from client PID 6300 ('.switch-to-conf') (unit backdoor.service)... machine # [ 100.097302] systemd[1]: Reloading... machine # [ 100.485526] systemd[1]: Reloading finished in 385 ms. machine # [ 100.579021] systemd[538]: Reexecution requested from client PID 6369 ('switch-to-confi')... machine # [ 100.583247] systemd[538]: Reexecuting. machine # [ 100.635474] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 100.767756] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 100.776055] systemd[538]: Reload requested from client PID 6369 ('switch-to-confi')... machine # [ 100.778528] systemd[538]: Reloading... machine # [ 100.908862] systemd[538]: Reloading finished in 128 ms. machine # [ 100.924204] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 100.936617] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 100.939603] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 100.942533] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 100.976339] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 100.980807] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 100.985606] systemd[1]: Stopping Reactivate sysinit units... machine # [ 100.986938] systemd[1]: Reached target Reactivate sysinit units. machine # [ 100.989880] systemd[1]: Reloading test.service... machine # [ 101.014137] systemd[1]: Reloaded test.service. machine # [ 101.016996] systemd[1]: Reached target Local File Systems. machine # [ 101.020792] systemd[1]: Reached target Remote File Systems. machine # [ 101.023956] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.026163] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 101.032072] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 101.040646] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 101.041921] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 101.043585] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 101.052478] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 101.054767] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.058212] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.224611] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 101.229780] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 101.232386] systemd[1]: Starting linger-users.service... machine # [ 101.270811] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 101.274285] systemd[1]: Finished linger-users.service. machine # [ 101.528358] nixos[6300]: finished switching to system configuration /nix/store/8h9ykb59bwqqyxr1q7186w5fiv0g6r4g-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 2.17 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 101.817309] nixos[6442]: switching to system configuration /nix/store/5xylndr9irzs9msi9f8dzdy7q2praayb-nixos-system-machine-test machine # [ 101.820594] systemd[1]: Stopped target Local File Systems. machine # [ 101.823145] systemd[1]: Stopped target Remote File Systems. machine # [ 102.145454] systemd[1]: Reload requested from client PID 6442 ('.switch-to-conf') (unit backdoor.service)... machine # [ 102.148280] systemd[1]: Reloading... machine # [ 102.502043] systemd[1]: Reloading finished in 350 ms. machine # [ 102.585418] systemd[538]: Reexecution requested from client PID 6511 ('switch-to-confi')... machine # [ 102.589328] systemd[538]: Reexecuting. machine # [ 102.646533] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 102.779628] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 102.787335] systemd[538]: Reload requested from client PID 6511 ('switch-to-confi')... machine # [ 102.790378] systemd[538]: Reloading... machine # [ 102.912184] systemd[538]: Reloading finished in 119 ms. machine # [ 102.928157] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 102.938975] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 102.941699] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 102.944250] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 102.977389] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 102.981614] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 102.986616] systemd[1]: Stopping Reactivate sysinit units... machine # [ 102.987910] systemd[1]: Reached target Reactivate sysinit units. machine # [ 102.989537] systemd[1]: test.service: Deactivated successfully. machine # [ 102.990696] systemd[1]: Stopped test.service. machine # [ 102.991559] systemd[1]: Stopping test.service... machine # [ 102.996608] systemd[1]: Starting test.service... machine # [ 103.017116] systemd[1]: Finished test.service. machine # [ 103.023799] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.027455] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 103.032592] systemd[1]: Reached target Remote File Systems. machine # [ 103.034959] systemd[1]: Starting linger-users.service... machine # [ 103.043046] systemd[1]: Reached target Local File Systems. machine # [ 103.045608] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 103.050879] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 103.060729] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 103.062534] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 103.066180] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 103.074482] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.080404] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.132866] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 103.137356] systemd[1]: Finished linger-users.service. machine # [ 103.281558] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 103.285104] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 103.539442] nixos[6442]: finished switching to system configuration /nix/store/5xylndr9irzs9msi9f8dzdy7q2praayb-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 2.01 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 103.841094] nixos[6584]: switching to system configuration /nix/store/xky3cybs6bjvxx55j13jklvdnzd1kr3g-nixos-system-machine-test machine # [ 103.843791] systemd[1]: Stopped target Local File Systems. machine # [ 103.846884] systemd[1]: Stopped target Remote File Systems. machine # [ 104.153688] systemd[1]: Reload requested from client PID 6584 ('.switch-to-conf') (unit backdoor.service)... machine # [ 104.155835] systemd[1]: Reloading... machine # [ 104.597346] systemd[1]: Reloading finished in 439 ms. machine # [ 104.764648] systemd[538]: Reexecution requested from client PID 6653 ('switch-to-confi')... machine # [ 104.767757] systemd[538]: Reexecuting. machine # [ 104.816584] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 104.939029] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 104.946606] systemd[538]: Reload requested from client PID 6653 ('switch-to-confi')... machine # [ 104.949136] systemd[538]: Reloading... machine # [ 105.081499] systemd[538]: Reloading finished in 130 ms. machine # [ 105.096238] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.106922] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 105.109645] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 105.112123] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 105.145580] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 105.150865] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 105.153254] systemd[1]: Stopping Reactivate sysinit units... machine # [ 105.154182] systemd[1]: Reached target Reactivate sysinit units. machine # [ 105.156792] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 105.158169] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 105.163413] systemd[1]: Reached target Local File Systems. machine # [ 105.167021] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 105.176750] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 105.177655] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 105.178870] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 105.189855] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 105.191495] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 105.196276] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 105.197618] systemd[1]: Reached target Remote File Systems. machine # [ 105.389658] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 105.393121] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 105.398635] systemd[1]: Starting linger-users.service... machine # [ 105.446961] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 105.450434] systemd[1]: Finished linger-users.service. machine # [ 105.705762] nixos[6584]: finished switching to system configuration /nix/store/xky3cybs6bjvxx55j13jklvdnzd1kr3g-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 2.16 seconds) (finished: subtest: unit file parser, in 27.90 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 105.932449] nixos[6724]: switching to system configuration /nix/store/3r6q2s9gw2fnc44qjn2ar03bacpqbg0a-nixos-system-machine-test machine # [ 105.935082] systemd[1]: Stopped target Local File Systems. machine # [ 105.937464] systemd[1]: Stopped target Remote File Systems. machine # [ 106.252644] systemd[1]: Reload requested from client PID 6724 ('.switch-to-conf') (unit backdoor.service)... machine # [ 106.254147] systemd[1]: Reloading... machine # [ 106.611076] systemd[1]: Reloading finished in 355 ms. machine # [ 106.711364] systemd[538]: Reexecution requested from client PID 6793 ('switch-to-confi')... machine # [ 106.715980] systemd[538]: Reexecuting. machine # [ 106.766948] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 106.899673] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 106.908457] systemd[538]: Reload requested from client PID 6793 ('switch-to-confi')... machine # [ 106.911555] systemd[538]: Reloading... machine # [ 107.050846] systemd[538]: Reloading finished in 138 ms. machine # [ 107.068228] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.084452] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 107.085589] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 107.089139] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 107.123346] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 107.128826] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 107.131071] systemd[1]: Stopping Reactivate sysinit units... machine # [ 107.136734] systemd[1]: Reached target Reactivate sysinit units. machine # [ 107.137701] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 107.138961] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 107.142535] systemd[1]: Reached target Local File Systems. machine # [ 107.147355] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 107.152978] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 107.154285] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 107.162518] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 107.174939] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 107.178903] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 107.182093] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 107.183974] systemd[1]: Reached target Remote File Systems. machine # [ 107.360974] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 107.366228] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 107.369837] systemd[1]: Starting linger-users.service... machine # [ 107.417964] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 107.421703] systemd[1]: Finished linger-users.service. machine # [ 107.678781] nixos[6724]: finished switching to system configuration /nix/store/3r6q2s9gw2fnc44qjn2ar03bacpqbg0a-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.98 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 107.990670] nixos[6864]: switching to system configuration /nix/store/f5r6gkrcskq0zradxdjys8q3fy2178wm-nixos-system-machine-test machine # [ 107.994132] systemd[1]: Stopped target Remote File Systems. machine # [ 107.997348] systemd[1]: test.service: Deactivated successfully. machine # [ 107.998730] systemd[1]: Stopped test.service. machine # [ 108.001615] systemd[1]: Stopped target Local File Systems. machine # [ 108.380857] systemd[1]: Reload requested from client PID 6864 ('.switch-to-conf') (unit backdoor.service)... machine # [ 108.383617] systemd[1]: Reloading... machine # [ 108.789404] systemd[1]: Reloading finished in 404 ms. machine # [ 108.888620] systemd[538]: Reexecution requested from client PID 6935 ('switch-to-confi')... machine # [ 108.893318] systemd[538]: Reexecuting. machine # [ 108.943313] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 109.067985] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 109.076470] systemd[538]: Reload requested from client PID 6935 ('switch-to-confi')... machine # [ 109.079447] systemd[538]: Reloading... machine # [ 109.210109] systemd[538]: Reloading finished in 129 ms. machine # [ 109.228172] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 109.244217] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 109.245852] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 109.249536] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 109.283137] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 109.288128] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 109.291026] systemd[1]: Stopping Reactivate sysinit units... machine # [ 109.292926] systemd[1]: Reached target Reactivate sysinit units. machine # [ 109.300584] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 109.305503] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 109.323644] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 109.332946] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 109.344415] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 109.358287] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 109.367662] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 109.378318] systemd[1]: Starting simple-service.service... machine # [ 109.390257] systemd[1]: Starting no-restart-service.service... machine # [ 109.414572] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 109.415867] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 109.438183] systemd[1]: Reached target Remote File Systems. machine # [ 109.439133] systemd[1]: Starting linger-users.service... machine # [ 109.463311] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 109.492818] systemd[1]: Starting reload-triggers.service... machine # [ 109.494323] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 109.495905] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 109.547897] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 109.592661] systemd[1]: Starting simple-reload-service.service... machine # [ 109.593845] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 109.594990] systemd[1]: Starting simple-restart-service.service... machine # [ 109.660797] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 109.687180] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 109.707300] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 109.735763] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 109.761084] systemd[1]: Reached target Local File Systems. machine # [ 109.777408] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 109.780967] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 109.792679] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 109.793940] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 109.798935] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 109.803550] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 109.813793] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 109.816475] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 109.817490] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 109.818464] systemd[1]: Finished simple-service.service. machine # [ 109.819167] systemd[1]: Finished no-restart-service.service. machine # [ 109.821930] systemd[1]: Finished reload-triggers.service. machine # [ 109.824188] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 109.834230] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 109.848520] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 109.849607] systemd[1]: Finished simple-restart-service.service. machine # [ 109.850454] systemd[1]: Finished simple-reload-service.service. machine # [ 109.851282] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 109.860310] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 109.874408] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 109.876243] systemd[1]: Finished linger-users.service. machine # [ 110.047520] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 110.050860] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 110.055661] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 110.082058] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 110.342258] nixos[6864]: finished switching to system configuration /nix/store/f5r6gkrcskq0zradxdjys8q3fy2178wm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.66 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 110.629081] nixos[7035]: switching to system configuration /nix/store/f5r6gkrcskq0zradxdjys8q3fy2178wm-nixos-system-machine-test machine # [ 110.631866] systemd[1]: Stopped target Local File Systems. machine # [ 110.634954] systemd[1]: Stopped target Remote File Systems. machine # [ 110.964252] systemd[1]: Reload requested from client PID 7035 ('.switch-to-conf') (unit backdoor.service)... machine # [ 110.966527] systemd[1]: Reloading... machine # [ 111.299440] systemd[1]: Reloading finished in 331 ms. machine # [ 111.388452] systemd[538]: Reexecution requested from client PID 7106 ('switch-to-confi')... machine # [ 111.389884] systemd[538]: Reexecuting. machine # [ 111.446658] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 111.552737] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 111.559316] systemd[538]: Reload requested from client PID 7106 ('switch-to-confi')... machine # [ 111.562647] systemd[538]: Reloading... machine # [ 111.663957] systemd[538]: Reloading finished in 102 ms. machine # [ 111.680153] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 111.691509] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 111.693959] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 111.696183] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 111.726083] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 111.730423] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 111.735835] systemd[1]: Stopping Reactivate sysinit units... machine # [ 111.737136] systemd[1]: Reached target Reactivate sysinit units. machine # [ 111.739030] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 111.744269] systemd[1]: Reloading reload-triggers.service... machine # [ 111.757812] systemd[1]: Reloading simple-reload-service.service... machine # [ 111.767007] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 111.774326] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 111.785212] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 111.837001] systemd[1]: Reloaded reload-triggers.service. machine # [ 111.843200] systemd[1]: Reloaded simple-reload-service.service. machine # [ 111.852813] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 111.857781] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 111.861169] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 111.865553] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 111.868746] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 111.876578] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 111.877626] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 111.878643] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 111.879633] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 111.881223] systemd[1]: Stopped simple-restart-service.service. machine # [ 111.882076] systemd[1]: Stopping simple-restart-service.service... machine # [ 111.892761] systemd[1]: Starting simple-restart-service.service... machine # [ 111.893695] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 111.894646] systemd[1]: Stopped simple-service.service. machine # [ 111.895371] systemd[1]: Stopping simple-service.service... machine # [ 111.920246] systemd[1]: Starting simple-service.service... machine # [ 111.921150] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 111.922627] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 111.923862] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 111.955487] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 111.966676] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 111.981689] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 111.988445] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 111.989722] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 111.990865] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 111.991992] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 112.003127] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 112.009762] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 112.010785] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 112.011727] systemd[1]: Finished simple-restart-service.service. machine # [ 112.017279] systemd[1]: Finished simple-service.service. machine # [ 112.018077] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 112.019203] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 112.028534] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 112.029612] systemd[1]: Reached target Remote File Systems. machine # [ 112.030418] systemd[1]: Reached target Local File Systems. machine # [ 112.031198] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 112.042531] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 112.043880] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 112.047714] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 112.048732] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 112.049959] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 112.052781] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 112.054416] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 112.056239] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 112.199799] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 112.202684] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 112.206768] systemd[1]: Starting linger-users.service... machine # [ 112.243987] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 112.246966] systemd[1]: Finished linger-users.service. machine # [ 112.503821] nixos[7035]: finished switching to system configuration /nix/store/f5r6gkrcskq0zradxdjys8q3fy2178wm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.16 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 112.854267] nixos[7201]: switching to system configuration /nix/store/axqc0npgr8ajayvfyp8aripip42ia40n-nixos-system-machine-test machine # [ 112.858849] systemd[1]: Stopped target Remote File Systems. machine # [ 112.861529] systemd[1]: Stopped target Local File Systems. machine # [ 113.211510] systemd[1]: Reload requested from client PID 7201 ('.switch-to-conf') (unit backdoor.service)... machine # [ 113.213890] systemd[1]: Reloading... machine # [ 113.666823] systemd[1]: Reloading finished in 452 ms. machine # [ 113.785632] systemd[538]: Reexecution requested from client PID 7272 ('switch-to-confi')... machine # [ 113.789512] systemd[538]: Reexecuting. machine # [ 113.848545] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 114.011125] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 114.019468] systemd[538]: Reload requested from client PID 7272 ('switch-to-confi')... machine # [ 114.022863] systemd[538]: Reloading... machine # [ 114.122432] systemd[538]: Reloading finished in 100 ms. machine # [ 114.140210] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 114.151627] systemd[538]: Stopped Run user-specific NixOS activation. machine # [ 114.154057] systemd[538]: Stopping Run user-specific NixOS activation... machine # [ 114.155954] systemd[538]: Starting Run user-specific NixOS activation... machine # [ 114.186742] systemd[538]: Finished Run user-specific NixOS activation. machine # [ 114.190907] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 114.196228] systemd[1]: Stopping Reactivate sysinit units... machine # [ 114.197121] systemd[1]: Reached target Reactivate sysinit units. machine # [ 114.199395] systemd[1]: Reloading reload-triggers.service... machine # [ 114.204468] systemd[1]: Reloading simple-reload-service.service... machine # [ 114.215854] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 114.224389] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 114.276962] systemd[1]: Reloaded simple-reload-service.service. machine # [ 114.279891] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 114.282781] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 114.286949] systemd[1]: Reloaded reload-triggers.service. machine # [ 114.292261] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 114.293494] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 114.294437] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 114.299746] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 114.308924] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 114.310066] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 114.310941] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 114.311848] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 114.328293] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 114.329411] systemd[1]: Stopped simple-restart-service.service. machine # [ 114.330259] systemd[1]: Stopping simple-restart-service.service... machine # [ 114.331138] systemd[1]: Starting simple-restart-service.service... machine # [ 114.361749] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 114.362821] systemd[1]: Stopped simple-service.service. machine # [ 114.363717] systemd[1]: Stopping simple-service.service... machine # [ 114.384749] systemd[1]: Starting simple-service.service... machine # [ 114.396915] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 114.413578] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 114.432401] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 114.443868] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 114.453963] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 114.466485] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 114.468409] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 114.469976] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 114.471110] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 114.474340] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 114.475520] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 114.480483] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 114.481608] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 114.482744] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 114.483684] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 114.485147] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 114.486187] systemd[1]: Finished simple-restart-service.service. machine # [ 114.487023] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 114.487914] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 114.490266] systemd[1]: Finished simple-service.service. machine # [ 114.491060] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 114.505209] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 114.506376] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 114.507418] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 114.510007] systemd[1]: Reached target Local File Systems. machine # [ 114.510854] systemd[1]: Reached target Remote File Systems. machine # [ 114.511682] systemd[1]: Starting linger-users.service... machine # [ 114.515827] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 114.522933] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 114.528827] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 114.530948] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 114.535624] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 114.538559] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 114.542367] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 114.546404] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 114.547772] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 114.582592] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 114.586206] systemd[1]: Finished linger-users.service. machine # [ 114.713884] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 114.716857] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 114.972718] nixos[7201]: finished switching to system configuration /nix/store/axqc0npgr8ajayvfyp8aripip42ia40n-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.47 seconds) machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-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/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.34 seconds) (finished: subtest: restart and reload by activation script, in 9.61 seconds) (finished: run the VM test script, in 116.02 seconds) test script finished in 116.07s cleanup kill QemuMachine (pid 45) machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14) machine # [2026-10-14T03:15:50Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-14T03:15:50Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-14T03:15:50Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.17 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