tribuchet: building on eliza Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.01 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script machine: waiting for unit multi-user.target machine: waiting for the VM to finish booting machine: starting vm machine # Disk image does not exist, creating the virtualisation disk image... machine # Formatting '/build/vm-state-machine/tmp.beXYIWtn9n', fmt=raw size=1073741824 machine: QEMU running (pid 45) 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: b644028f-71ef-46ee-b947-a511097ff933 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-20T03:08:06Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-20T03:08:06Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-20T03:08:06Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-20T03:08:06Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-20T03:08:06Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-20T03:08:06Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-20T03:08:06Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-20T03:08:06Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-20T03:08:06Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-20T03:08:06Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-20T03:08:06Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-20T03:08:06Z INFO virtiofsd] Client connected, servicing requests machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.57 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT @1792058300 machine # [ 0.000000] KASLR enabled machine # [ 0.000000] random: crng init done machine # [ 0.000000] Machine model: linux,dummy-virt machine # [ 0.000000] efi: UEFI not found. machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f] machine # [ 0.000000] Zone ranges: machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] DMA32 empty machine # [ 0.000000] Normal empty machine # [ 0.000000] Device empty machine # [ 0.000000] Movable zone start for each node machine # [ 0.000000] Early memory node ranges machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000 machine # [ 0.000000] psci: probing for conduit method from DT. machine # [ 0.000000] psci: PSCIv1.3 detected in firmware. machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs machine # [ 0.000000] psci: Trusted OS migration not required machine # [ 0.000000] psci: SMC Calling Convention v1.1 machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) machine # [ 0.000000] percpu: Embedded 76 pages/cpu s187672 r8192 d115432 u311296 machine # [ 0.000000] Detected PIPT I-cache on CPU0 machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) machine # [ 0.000000] CPU features: detected: GICv3 CPU interface machine # [ 0.000000] CPU features: detected: Spectre-v4 machine # [ 0.000000] CPU features: detected: Spectre-BHB machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 machine # [ 0.000000] alternatives: applying boot alternatives machine # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/init regInfo=/nix/.ro-store/j6qg2hx9r4q1pdyjf1crsmhk9v9q6bd7-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/j6qg2hx9r4q1pdyjf1crsmhk9v9q6bd7-closure-info/registration", will be passed to user space. machine # [ 0.000000] printk: log buffer data + meta data: 1048576 + 3670016 = 4718592 bytes machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB machine # [ 0.000000] software IO TLB: area num 1. machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB) machine # [ 0.000000] Fallback order for Node 0: 0 machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 machine # [ 0.000000] Policy zone: DMA machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.000000] allocated 2097152 bytes of page_ext machine # [ 0.000000] ftrace: allocating 75301 entries in 296 pages machine # [ 0.000000] ftrace: allocated 296 pages with 3 groups machine # [ 0.000000] rcu: Hierarchical RCU implementation. machine # [ 0.000000] rcu: RCU event tracing is enabled. machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1. machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. machine # [ 0.000000] Rude variant of Tasks RCU enabled. machine # [ 0.000000] Tracing variant of Tasks RCU enabled. machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 machine # [ 0.000000] GICv3: 256 SPIs implemented machine # [ 0.000000] GICv3: 0 Extended SPIs implemented machine # [ 0.000000] Root IRQ handler: gic_handle_irq machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @450e0000 (indirect, esz 8, psz 64K, shr 1) machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @450f0000 (flat, esz 8, psz 64K, shr 1) machine # [ 0.000000] GICv3: using LPI property table @0x0000000045110000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000045120000 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.000033] arm-pv: using stolen time PV machine # [ 0.000398] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000555] Console: colour dummy device 80x25 machine # [ 0.000564] printk: legacy console [tty0] enabled machine # [ 0.000750] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000757] pid_max: default: 32768 minimum: 301 machine # [ 0.000845] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima machine # [ 0.000977] landlock: Up and running. machine # [ 0.000981] Yama: becoming mindful. machine # [ 0.001423] LSM support for eBPF active machine # [ 0.001549] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.001569] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.003593] rcu: Hierarchical SRCU implementation. machine # [ 0.003600] rcu: Max phase no-delay instances is 1000. machine # [ 0.004921] fsl-mc MSI: its@8080000 domain created machine # [ 0.005045] EFI services will not be available. machine # [ 0.005140] smp: Bringing up secondary CPUs ... machine # [ 0.005150] smp: Brought up 1 node, 1 CPU machine # [ 0.005153] SMP: Total of 1 processors activated. machine # [ 0.005156] CPU: All CPU(s) started at EL1 machine # [ 0.005167] CPU features: detected: Branch Target Identification machine # [ 0.005171] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.005174] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.005178] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.005186] CPU features: detected: Common not Private translations machine # [ 0.005189] CPU features: detected: CRC32 instructions machine # [ 0.005192] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.005195] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.005198] CPU features: detected: Data independent timing control (DIT) machine # [ 0.005201] CPU features: detected: E0PD machine # [ 0.005204] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.005207] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.005211] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.005214] CPU features: detected: Fine Grained Traps machine # [ 0.005217] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.005223] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.005225] CPU features: detected: LSE atomic instructions machine # [ 0.005228] CPU features: detected: Privileged Access Never machine # [ 0.005231] CPU features: detected: PMUv3 machine # [ 0.005234] CPU features: detected: RAS Extension Support machine # [ 0.005237] CPU features: detected: RASv1p1 Extension Support machine # [ 0.005240] CPU features: detected: Random Number Generator machine # [ 0.005245] CPU features: detected: Speculation barrier (SB) machine # [ 0.005248] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.005250] CPU features: detected: TLB range maintenance instructions machine # [ 0.005255] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.005294] alternatives: applying system-wide alternatives machine # [ 0.008513] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.008729] Memory: 886712K/1048576K available (24640K kernel code, 10246K rwdata, 26664K rodata, 7808K init, 2086K bss, 120600K reserved, 32768K cma-reserved) machine # [ 0.009176] devtmpfs: initialized machine # [ 0.011050] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.011076] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.011301] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.011306] 0 pages in range for non-PLT usage machine # [ 0.011307] 506368 pages in range for PLT usage machine # [ 0.011410] pinctrl core: initialized pinctrl subsystem machine # [ 0.012314] DMI not present or invalid. machine # [ 0.015664] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.018252] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.018409] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.018569] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.018593] audit: initializing netlink subsys (disabled) machine # [ 0.019272] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.019274] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.019278] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.019281] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.019284] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.019313] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 machine # [ 0.019322] cpuidle: using governor ladder machine # [ 0.019328] cpuidle: using governor menu machine # [ 0.019555] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.019576] ASID allocator initialised with 65536 entries machine # [ 0.020906] Serial: AMBA PL011 UART driver machine # [ 0.026784] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.026943] printk: console [ttyAMA0] enabled machine # [ 0.158035] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.158046] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.158049] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.158051] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.158054] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.158057] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.158060] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.158062] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.159307] fbcon: Taking over console machine # [ 0.159318] ACPI: Interpreter disabled. machine # [ 0.169488] iommu: Default domain type: Translated machine # [ 0.169495] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.169928] SCSI subsystem initialized machine # [ 0.172096] usbcore: registered new interface driver usbfs machine # [ 0.172128] usbcore: registered new interface driver hub machine # [ 0.172143] usbcore: registered new device driver usb machine # [ 0.172432] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.172436] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.172444] PTP clock support registered machine # [ 0.172485] EDAC MC: Ver: 3.0.0 machine # [ 0.179059] scmi_core: SCMI protocol bus registered machine # [ 0.179470] FPGA manager framework machine # [ 0.182601] vgaarb: loaded machine # [ 0.184465] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.191795] VFS: Disk quotas dquot_6.6.0 machine # [ 0.191830] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.195609] netfs: FS-Cache loaded machine # [ 0.195761] pnp: PnP ACPI: disabled machine # [ 0.200199] NET: Registered PF_INET protocol family machine # [ 0.200370] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.233188] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.233235] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.233259] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.233304] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.233376] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.233473] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.233507] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.233575] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.233669] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.233695] NET: Registered PF_XDP protocol family machine # [ 0.233712] PCI: CLS 0 bytes, default 64 machine # [ 0.234125] Trying to unpack rootfs image as initramfs... machine # [ 0.247061] kvm [1]: HYP mode not available machine # [ 0.385100] Initialise system trusted keyrings machine # [ 0.385139] Key type blacklist registered machine # [ 0.385305] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.385691] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.385751] 9p: Installing v9fs 9p2000 file system support machine # [ 0.385849] integrity: Platform Keyring initialized machine # [ 0.385866] integrity: Machine keyring initialized machine # [ 0.410665] Key type asymmetric registered machine # [ 0.410685] Asymmetric key parser 'x509' registered machine # [ 0.410774] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.412535] io scheduler mq-deadline registered machine # [ 0.412543] io scheduler kyber registered machine # [ 0.424669] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.429343] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.429841] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.429859] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.429874] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.429881] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.429901] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.429927] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.430031] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.430039] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.430044] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.430047] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.430050] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.430123] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.430653] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.430890] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.430904] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.430934] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.430948] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.431490] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.431785] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.431797] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.431823] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.432316] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.460595] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.460619] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.460645] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.461213] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.461413] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.461425] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.461451] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.461463] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.461956] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.462155] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.462181] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.462664] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.462862] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.462888] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.463298] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.463500] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.463905] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.464102] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.464128] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.481285] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.481491] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.481518] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.482002] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.482199] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.482226] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.482720] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.483045] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.483062] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.483088] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.483609] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.483808] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.483820] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.483846] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.504601] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.504617] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.504621] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.504709] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.504756] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.504803] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.504850] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.504902] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.504949] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.505001] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.505047] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.505093] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.505221] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.505268] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.505286] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.505304] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.505322] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.505340] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.505359] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.505376] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.505397] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.505416] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.505434] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.505453] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.505472] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.505489] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.505507] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.505524] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned machine # [ 0.505542] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned machine # [ 0.505559] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.505577] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.505601] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.505606] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.505610] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.506517] pci 0000:00:07.0: enabling device (0000 -> 0002) machine # [ 0.560733] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.562927] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.572850] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.575115] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.585839] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002) machine # [ 0.588272] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002) machine # [ 0.598568] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.608753] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.611400] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.615406] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.618965] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.637633] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.639774] msm_serial: driver initialized machine # [ 0.639934] SuperH (H)SCI(F) driver initialized machine # [ 0.639995] STM32 USART driver initialized machine # [ 0.678843] loop: module loaded machine # [ 0.679046] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 0.680112] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.693314] megasas: 07.734.00.00-rc1 machine # [ 0.694118] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.696447] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.696468] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.701881] Using buffer write method machine # [ 0.701924] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.703458] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.703632] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.718360] Using buffer write method machine # [ 0.718386] Concatenating MTD devices: machine # [ 0.718388] (0): "0.flash" machine # [ 0.718391] (1): "0.flash" machine # [ 0.718393] into device "0.flash" machine # [ 1.009681] Freeing initrd memory: 26060K machine # [ 1.018344] tun: Universal TUN/TAP device driver, 1.6 machine # [ 1.022578] thunder_xcv, ver 1.0 machine # [ 1.022617] thunder_bgx, ver 1.0 machine # [ 1.022636] nicpf, ver 1.0 machine # [ 1.023253] e1000: Intel(R) PRO/1000 Network Driver machine # [ 1.023257] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 1.023280] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 1.023290] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 1.023327] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 1.023331] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 1.023351] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 1.023355] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 1.023493] sky2: driver version 1.30 machine # [ 1.033463] usbcore: registered new interface driver usb-storage machine # [ 1.033551] usbcore: registered new interface driver usbserial_generic machine # [ 1.033562] usbserial: USB Serial support registered for generic machine # [ 1.034209] hv_vmbus: registering driver hyperv_keyboard machine # [ 1.035615] ehci-pci 0000:00:07.0: EHCI Host Controller machine # [ 1.035643] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1 machine # [ 1.035855] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000 machine # [ 1.036172] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 1.036194] rtc-pl031 9010000.pl031: setting system clock to 2026-10-20T03:08:08 UTC (1792465688) machine # [ 1.044074] i2c_dev: i2c /dev entries driver machine # [ 1.044982] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00 machine # [ 1.045276] hub 1-0:1.0: USB hub found machine # [ 1.045294] hub 1-0:1.0: 6 ports detected machine # [ 1.050713] sdhci: Secure Digital Host Controller Interface driver machine # [ 1.050719] sdhci: Copyright(c) Pierre Ossman machine # [ 1.051017] Synopsys Designware Multimedia Card Interface Driver machine # [ 1.051420] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 1.056135] hid: raw HID events driver (C) Jiri Kosina machine # [ 1.056417] usbcore: registered new interface driver usbhid machine # [ 1.056421] usbhid: USB HID core driver machine # [ 1.059589] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 1.062463] drop_monitor: Initializing network drop monitor service machine # [ 1.062620] NET: Registered PF_INET6 protocol family machine # [ 1.063177] Segment Routing with IPv6 machine # [ 1.063189] In-situ OAM (IOAM) with IPv6 machine # [ 1.063218] NET: Registered PF_PACKET protocol family machine # [ 1.063277] 9pnet: Installing 9P2000 support machine # [ 1.063318] Key type dns_resolver registered machine # [ 1.074098] registered taskstats version 1 machine # [ 1.074234] Loading compiled-in X.509 certificates machine # [ 1.083274] Demotion targets for Node 0: null machine # [ 1.083407] Key type .fscrypt registered machine # [ 1.083410] Key type fscrypt-provisioning registered machine # [ 1.083505] ima: No TPM chip found, activating TPM-bypass! machine # [ 1.083548] ima: Allocated hash algorithm: sha1 machine # [ 1.083571] ima: No architecture policies found machine # [ 1.084277] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 1.108364] clk: Disabling unused clocks machine # [ 1.108382] PM: genpd: Disabling unused power domains machine # [ 1.114439] Freeing unused kernel memory: 7808K machine # [ 1.114658] Run /init as init process machine # [ 1.132420] fuse: module verification failed: signature and/or required key missing - tainting kernel machine # [ 1.136598] fuse: init (API version 7.45) machine # [ 1.139576] virtiofs virtio6: discovered new tag: nix-store machine # [ 1.140403] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 1.154097] virtiofs virtio7: discovered new tag: shared machine # [ 1.154903] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 1.156400] virtiofs virtio8: discovered new tag: xchg machine # [ 1.159426] virtiofs virtio8: virtio_fs_setup_dax: No cache capability machine # [ 1.173917] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.174477] systemd[1]: systemd 263-cf8ebfc 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.174492] systemd[1]: Detected virtualization qemu. machine # [ 1.174515] systemd[1]: Detected architecture arm64. machine # [ 1.174521] systemd[1]: Running in initrd. machine # [ 1.174831] systemd[1]: Initializing machine ID from random generator. machine # [ 1.174930] systemd[1]: Hostname set to . machine # [ 1.278812] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.296653] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.338586] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.343803] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.344002] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.344032] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.344054] systemd[1]: Reached target Path Units. machine # [ 1.344067] systemd[1]: Reached target Slice Units. machine # [ 1.344081] systemd[1]: Reached target Swaps. machine # [ 1.344094] systemd[1]: Reached target Timer Units. machine # [ 1.344230] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.344383] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.351315] systemd[1]: Listening on Journal Sockets. machine # [ 1.351415] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.351683] systemd[1]: Listening on udev Varlink Socket. machine # [ 1.351702] systemd[1]: Reached target Socket Units. machine # [ 1.356030] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.356090] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.361972] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.376095] systemd[1]: Starting Journal Service... machine # [ 1.381961] systemd[1]: Starting Load Kernel Modules... machine # [ 1.382063] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.395294] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.404636] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.424750] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.455634] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.455976] systemd-journald[71]: Collecting audit messages is disabled. machine # [ 1.481039] 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.491308] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.494286] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.507180] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.512548] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.523236] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0 machine # [ 1.523531] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.523538] [drm] features: -context_init machine # [ 1.524382] [drm] number of scanouts: 1 machine # [ 1.524403] [drm] number of cap sets: 0 machine # [ 1.551335] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic machine # [ 1.551360] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0 machine # [ 1.573250] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.573464] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.573488] systemd[1]: Reached target Local File Systems. machine # [ 1.576768] 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.581483] Console: switching to colour frame buffer device 160x50 machine # [ 1.588990] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.602386] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.617264] systemd[1]: Finished Load Kernel Modules. machine # [ 1.625137] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.642203] systemd-modules-load[72]: Inserted module 'dm_mod' machine # [ 1.643441] systemd-modules-load[72]: Module 'virtio_balloon' is built in machine # [ 1.664894] systemd[1]: Started Journal Service. machine # [ 1.653128] systemd-modules-load[72]: Module 'virtio_console' is built in machine # [ 1.660367] systemd-modules-load[72]: Inserted module 'virtio_gpu' machine # [ 1.670094] systemd-modules-load[72]: Module 'virtio_rng' is built in machine # [ 1.676399] systemd[1]: Starting Create System Files and Directories... machine # [ 1.678579] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.696613] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.704817] systemd-udevd[79]: Using default interface naming scheme 'v261'. machine # [ 1.737001] systemd[1]: Finished Create System Files and Directories. machine # [ 1.754744] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.839298] systemd[1]: Starting Virtual Console Setup... machine # [ 1.860832] 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.861137] 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.934300] systemd-vconsole-setup[97]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 1.940307] systemd[1]: Finished Virtual Console Setup. machine # [ 2.619866] (udev-worker)[100]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.685223] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.688224] systemd[1]: Reached target System Initialization. machine # [ 2.691190] systemd[1]: Reached target Basic System. machine # [ 2.695840] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.700174] systemd[1]: Reached target Initrd Root Device. machine # [ 2.703659] (udev-worker)[105]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.712412] (udev-worker)[105]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.716309] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 2.769035] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 2.776199] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.780780] systemd[1]: Mounting /sysroot... machine # [ 2.834253] EXT4-fs (vda): mounted filesystem b644028f-71ef-46ee-b947-a511097ff933 r/w with ordered data mode. Quota mode: none. machine # [ 2.823009] systemd[1]: Mounted /sysroot. machine # [ 2.825527] systemd[1]: Reached target Initrd Root File System. machine # [ 2.831337] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.859794] systemd-sysroot-fstab-check[119]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.867781] systemd[1]: Reload requested from client PID 119 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.870907] systemd[1]: Reloading... machine # [ 3.070848] systemd[1]: Reloading finished in 204 ms. machine # [ 3.105223] systemd-sysroot-fstab-check[119]: Requesting initrd-fs.target/start/replace... machine # [ 3.112213] systemd-sysroot-fstab-check[119]: Requesting swap.target/start/replace... machine # [ 3.117813] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.122326] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.123981] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.391287] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.403348] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.420216] systemd[1]: Mounting /sysroot/run... machine # [ 3.426537] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.454674] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.527330] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.534238] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.538058] systemd[1]: Mounted /sysroot/run. machine # [ 3.542098] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.545439] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.555963] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.587355] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.589147] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.994116] (udev-worker)[104]: mtd0ro: Failed to find and pin callout binary "/nix/store/rqml5nvpjfjxxijlgvjhvvpy2iwg7axc-systemd-263-cf8ebfc/lib/udev/mtd_probe": No such file or directory machine # [ 3.999782] (udev-worker)[104]: mtd0ro: /etc/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory machine # [ 4.038661] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.040553] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.044271] systemd[1]: Stopping Virtual Console Setup... machine # [ 4.045232] systemd[1]: Starting Virtual Console Setup... machine # [ 4.072995] systemd-vconsole-setup[150]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 4.077345] systemd[1]: Finished Virtual Console Setup. machine # [ 4.390473] systemd[1]: Mounting /sysroot/nix/store... machine # [ 4.437342] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.440146] systemd[1]: Reached target Initrd File Systems. machine # [ 4.444624] systemd[1]: Starting Find NixOS closure... machine # [ 4.456480] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.498775] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.504431] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 4.517213] systemd[1]: Finished Find NixOS closure. machine # [ 4.520293] systemd[1]: Reached target Initrd Default Target. machine # [ 4.521821] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.551159] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.556577] systemd[1]: Stopped target Basic System. machine # [ 4.557470] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.558356] systemd[1]: Stopped target Path Units. machine # [ 4.559259] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.562047] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.565203] systemd[1]: Stopped target Slice Units. machine # [ 4.570418] systemd[1]: Stopped target Socket Units. machine # [ 4.571944] systemd[1]: Stopped target System Initialization. machine # [ 4.577430] systemd[1]: Stopped target Swaps. machine # [ 4.579075] systemd[1]: Stopped target Timer Units. machine # [ 4.585204] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.587215] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.589832] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.591194] systemd[1]: Stopped Find NixOS closure. machine # [ 4.593362] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.595601] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.597916] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.599393] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.603872] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.608505] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.613555] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.616439] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.620292] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.622191] systemd[1]: Stopped target Local File Systems. machine # [ 4.624219] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.627711] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.630725] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.631730] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.632965] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.634074] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.634840] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.635808] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.640314] systemd[1]: systemd-udevd.service: Consumed 1.357s CPU time over 3.020s wall clock time, 26M memory peak. machine # [ 4.643564] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.648537] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.649762] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully. machine # [ 4.652216] systemd[1]: Closed udev Varlink Socket. machine # [ 4.653049] systemd[1]: Starting Cleanup udev Database... machine # [ 4.656161] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.657326] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.660154] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.661392] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.664433] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.668234] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.669207] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.670268] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.695651] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.699720] systemd[1]: Finished Cleanup udev Database. machine # [ 4.700921] systemd[1]: Reached target Switch Root. machine # [ 4.704342] systemd[1]: Starting NixOS Activation... machine # [ 4.786179] initrd-nixos-activation-start[173]: booting system configuration /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test machine # [ 4.819405] initrd-nixos-activation-start[173]: running activation script... machine # [ 5.068620] initrd-nixos-activation-start[196]: setting up /etc... machine # [ 5.191557] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 5.194818] systemd[1]: Finished NixOS Activation. machine # [ 5.200275] systemd[1]: Starting Switch Root... machine # [ 5.222223] systemd[1]: Switching root. machine # [ 5.410650] systemd-journald[71]: Received SIGTERM from PID 1 (systemd). machine # [ 5.509957] NET: Registered PF_VSOCK protocol family machine # [ 5.581794] systemd[1]: systemd 263-cf8ebfc running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR) machine # [ 5.582710] systemd[1]: Detected virtualization qemu. machine # [ 5.582754] systemd[1]: Detected architecture arm64. machine # [ 5.582819] systemd[1]: Detected first boot. machine # [ 5.584279] systemd[1]: Initializing machine ID from random generator. machine # [ 5.718942] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 5.872887] systemd[1]: Applying preset policy. machine # [ 6.072522] systemd[1]: Populated /etc with preset unit settings. machine # [ 6.279287] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 6.279804] systemd[1]: Stopped initrd-switch-root.service. machine # [ 6.284009] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 6.288227] systemd[1]: Created slice Slice /system/getty. machine # [ 6.291228] systemd[1]: Created slice User and Session Slice. machine # [ 6.291884] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 6.295101] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 6.295676] systemd[1]: Expecting device /dev/hvc0... machine # [ 6.296328] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 6.299943] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 6.300387] systemd[1]: Stopped target initrd-fs.target. machine # [ 6.303120] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 6.303614] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 6.304288] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 6.308131] systemd[1]: Reached target Path Units. machine # [ 6.309884] systemd[1]: Reached target Remote File Systems. machine # [ 6.310286] systemd[1]: Reached target Slice Units. machine # [ 6.310958] systemd[1]: Reached target Swaps. machine # [ 6.315075] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 6.318204] systemd[1]: Listening on Process Core Dump Socket. machine # [ 6.319718] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 6.323259] systemd[1]: Listening on Factory Reset Management. machine # [ 6.323821] systemd[1]: Listening on Hostname Service Socket. machine # [ 6.329374] systemd[1]: Starting Journal Log Access Socket... machine # [ 6.331124] systemd[1]: Listening on Journal Audit Socket. machine # [ 6.335269] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 6.336225] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 6.338648] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.339903] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 6.348715] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 6.349386] systemd[1]: Listening on udev Varlink Socket. machine # [ 6.354272] systemd[1]: Mounting Huge Pages File System... machine # [ 6.361499] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 6.372679] systemd[1]: Mounting Kernel Debug File System... machine # [ 6.384715] systemd[1]: Mounting Kernel Trace File System... machine # [ 6.398179] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 6.399702] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 6.418283] systemd[1]: Mounting Kernel Configuration File System... machine # [ 6.419554] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 6.426059] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.430331] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 6.469793] systemd[1]: Mounting FUSE Control File System... machine # [ 6.470231] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.508898] systemd[1]: Starting Journal Service... machine # [ 6.526688] systemd[1]: Starting Load Kernel Modules... machine # [ 6.542454] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 6.572703] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 6.573140] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.584385] systemd[1]: Starting Coldplug All udev Devices... machine # [ 6.588203] systemd[1]: Listening on Journal Log Access Socket. machine # [ 6.595421] systemd[1]: Mounted Huge Pages File System. machine # [ 6.596000] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 6.596412] systemd[1]: Mounted Kernel Debug File System. machine # [ 6.605374] systemd[1]: Mounted Kernel Trace File System. machine # [ 6.621683] systemd-journald[267]: Collecting audit messages is enabled. machine # [ 6.628321] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 6.630021] systemd[1]: Mounted Kernel Configuration File System. machine # [ 6.621612] systemd[1]: Queued start job for default target Multi-User System. machine # [ 6.627111] systemd[1]: Unnecessary job was removed for /sys/devices/platform/9000000.pl011/9000000.pl011:0/9000000.pl011:0.0/tty/ttyAMA0. machine # [ 6.637410] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0. machine # [ 6.638850] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 6.660994] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 6.661688] systemd[1]: Started Journal Service. machine # [ 6.650785] systemd-modules-load[268]: Module 'atkbd' is built in machine # [ 6.660285] systemd-modules-load[268]: Module 'loop' is built in machine # [ 6.689565] systemd[1]: Finished Load Kernel Modules. machine # [ 6.712773] systemd[1]: Mounted FUSE Control File System. machine # [ 6.732796] systemd-oomd[269]: No swap; memory pressure usage will be degraded machine # [ 6.760554] EXT4-fs (vda): re-mounted b644028f-71ef-46ee-b947-a511097ff933. machine # [ 6.750868] systemd[1]: Starting Firewall... machine # [ 6.759400] systemd[1]: Starting Apply Kernel Variables... machine # [ 6.765261] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 6.767498] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 6.782372] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 6.792145] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 6.793294] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 6.804173] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 6.805209] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.940752] systemd-journald[267]: Received client request to flush runtime journal. machine # [ 7.012570] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 7.013970] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 7.019481] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 7.024476] systemd[1]: Reached target First Boot Complete. machine # [ 7.025384] systemd[1]: Finished Apply Kernel Variables. machine # [ 7.026219] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 7.150339] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 7.156150] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 7.161834] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 7.276691] systemd[1]: Mounting /run/wrappers... machine # [ 7.313910] systemd-udevd[303]: Using default interface naming scheme 'v261'. machine # [ 7.360637] systemd[1]: Mounted /run/wrappers. machine # [ 7.361565] systemd[1]: Reached target Local File Systems. machine # [ 7.374138] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 7.380302] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 7.381396] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 7.390832] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 7.404408] systemd[1]: Starting Create System Files and Directories... machine # [ 7.569930] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 7.633213] systemd[1]: Finished Create System Files and Directories. machine # [ 7.634462] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 7.655333] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 7.669879] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 7.676177] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 7.809574] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 7.824199] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 7.829659] systemd[1]: Starting Update is Completed... machine # [ 7.906577] systemd[1]: Finished Update is Completed. machine # [ 8.194300] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 8.255919] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 8.381079] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 8.390533] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 8.583151] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 8.594045] systemd[1]: Finished Coldplug All udev Devices. machine # [ 8.597663] systemd[1]: Reached target System Initialization. machine # [ 8.598718] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 8.599938] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 8.608538] systemd[1]: Reached target Timer Units. machine # [ 8.609437] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 8.610410] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 8.611696] systemd[1]: Reached target Socket Units. machine # [ 8.623223] systemd[1]: Reached target Basic System. machine # [ 8.629376] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 8.630627] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 8.639669] systemd[1]: Starting Post-Boot Actions... machine # [ 8.666174] systemd[1]: Started Reset console on configuration changes. machine # [ 8.696260] systemd[1]: Starting resolvconf update... machine # [ 8.700936] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 8.767635] systemd[1]: Started backdoor.service. machine # [ 8.813430] systemd[1]: Starting D-Bus System Message Bus... machine # [ 8.817938] nsncd[427]: Oct 20 03:08:16.291 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 8.832685] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 8.874068] (udev-worker)[331]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 8.895401] systemd[1]: Finished Post-Boot Actions. machine # [ 8.901015] (udev-worker)[402]: Network interface NamePolicy= disabled on kernel command line. machine # [ 8.916590] (udev-worker)[331]: Network interface NamePolicy= disabled on kernel command line. machine # [ 8.970298] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 8.978227] systemd[1]: Reached target User and Group Name Lookups. machine # [ 9.010130] systemd[1]: Starting User Login Management... machine # connecting to host... machine # [ 9.043639] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 9.101905] dbus-broker-launch[437]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 9.117401] dbus-broker-launch[437]: NSS returned no entry for 'systemd-timesync' machine # [ 9.118638] dbus-broker-launch[437]: Invalid user-name in /nix/store/lwvd8zypc7d831h4k85sqslcsqwvyagn-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 9.44 seconds) machine: (finished: waiting for the VM to finish booting, in 9.86 seconds) machine # [ 9.171753] systemd[1]: Started D-Bus System Message Bus. machine # [ 9.237286] dbus-broker-launch[437]: Ready machine # [ 9.328446] systemd-logind[461]: New seat seat0. machine # [ 9.415512] systemd[1]: Started User Login Management. machine # [ 9.460131] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 9.466579] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 9.467888] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 9.483538] systemd[1]: Stopping User and Group Name Lookups... machine # [ 9.488864] systemd[1]: Starting linger-users.service... machine # [ 9.489879] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 9.501868] systemd[1]: nscd.service: Deactivated successfully. machine # [ 9.510954] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 9.578251] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 9.597721] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 9.599214] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 9.664682] systemd[1]: Finished resolvconf update. machine # [ 9.675477] systemd[1]: Starting DHCP Client... machine # [ 9.717694] nsncd[552]: Oct 20 03:08:17.196 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 9.732345] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 9.763661] systemd[1]: Created slice Slice /user/1001. machine # [ 9.784492] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 9.785680] systemd[1]: Reached target User and Group Name Lookups. machine # [ 9.786651] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 9.858474] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 9.859625] systemd[1]: Finished linger-users.service. machine # [ 9.885637] systemd-logind[461]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # [ 9.931078] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 9.953422] systemd[1]: Starting User Manager for UID 1001... machine # [ 10.020021] mousedev: PS/2 mouse device common for all mice machine # [ 10.051726] systemd[1]: Finished Firewall. machine # [ 10.065315] systemd[1]: Reached target Preparation for Network. machine # [ 10.066338] systemd[1]: Starting Address configuration of eth1... machine # [ 10.067264] systemd[1]: Starting Extra networking commands.... machine # [ 10.140670] systemd-logind[461]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 10.166845] (systemd)[587]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 10.207983] systemd-logind[461]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 10.268746] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 10.493909] systemd[587]: Queued start job for default target Main User Target. machine # [ 10.514279] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 10.520400] systemd[587]: Created slice User Application Slice. machine # [ 10.521473] systemd[587]: Started Daily Cleanup of User's Temporary Directories. machine # [ 10.522621] systemd[587]: Reached target Paths. machine # [ 10.523337] systemd[587]: Reached target Timers. machine # [ 10.562805] systemd[587]: Starting D-Bus User Message Bus Socket... machine # [ 10.568655] systemd[587]: Starting Create User Files and Directories... machine # [ 10.574908] systemd[587]: Finished Create User Files and Directories. machine # [ 10.584158] systemd[587]: Listening on D-Bus User Message Bus Socket. machine # [ 10.585271] systemd[587]: Reached target Sockets. machine # [ 10.597394] systemd[587]: Reached target Basic System. machine # [ 10.598282] systemd[1]: Started User Manager for UID 1001. machine # [ 10.599297] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 10.624694] dhcpcd[588]: dhcpcd-10.3.2 starting machine # [ 10.658612] network-addresses-eth1-start[592]: adding address 192.168.1.1/24... done machine # [ 10.681273] dhcpcd[620]: dev: loaded udev machine # [ 10.682138] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 10.683176] systemd[587]: Reached target Main User Target. machine # [ 10.713554] 8021q: 802.1Q VLAN Support v1.8 machine # [ 10.713972] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 10.723948] systemd[587]: Startup finished in 461ms. machine # [ 10.745650] network-addresses-eth1-start[592]: adding address 2001:db8:1::1/64... done machine # [ 10.853883] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 10.859015] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 10.859555] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 10.864071] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 10.864416] cfg80211: failed to load regulatory.db machine # [ 10.939841] systemd[1]: Finished Address configuration of eth1. machine # [ 11.229080] dhcpcd[667]: /nix/store/48w99jvsb41hnyml943xqzrklzdb5fww-openresolv-3.17.4/sbin/.resolvconf-wrapped: line 1250: kill: (601) - Operation not permitted machine # [ 11.231294] dhcpcd[667]: .resolvconf-wrapped: clearing stale lock pid 601 machine # [ 11.492849] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 11.486910] dhcpcd[620]: eth0: waiting for carrier machine # [ 11.487936] dhcpcd[620]: eth0: carrier acquired machine # [ 11.567920] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3 machine # [ 11.584872] dhcpcd[620]: DUID 00:01:00:01:32:69:97:a3:52:54:00:12:34:56 machine # [ 11.586004] dhcpcd[620]: eth0: IAID 00:12:34:56 machine # [ 11.586729] dhcpcd[620]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 11.622188] systemd[1]: Finished Extra networking commands.. machine # [ 11.623312] systemd[1]: Reached target Network. machine # [ 11.624005] systemd[1]: Starting Permit User Sessions... machine # [ 11.910231] systemd[1]: Finished Permit User Sessions. machine # [ 11.945337] systemd[1]: Started Getty on tty1. machine # [ 11.946218] systemd[1]: Reached target Login Prompts. machine # [ 11.969576] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 12.000824] systemd[1]: Starting Virtual Console Setup... machine # [ 12.018770] systemd-logind[461]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 12.035881] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 12.040387] systemd[1]: Stopped Virtual Console Setup. machine # [ 12.046678] systemd[1]: Starting Virtual Console Setup... machine # [ 12.156765] systemd-vconsole-setup[708]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 12.162894] systemd[1]: Finished Virtual Console Setup. machine # [ 13.224385] dhcpcd[620]: eth0: soliciting a DHCP lease machine # [ 13.226554] dhcpcd[620]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 13.228706] dhcpcd[620]: eth0: probing address 10.0.2.15/24 machine # [ 14.349400] dhcpcd[620]: eth0: soliciting an IPv6 router machine # [ 14.351637] dhcpcd[620]: eth0: Router Advertisement from fe80::2 machine # [ 14.353309] dhcpcd[620]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 14.354793] dhcpcd[620]: eth0: adding route to fec0::/64 machine # [ 14.356003] dhcpcd[620]: eth0: adding default route via fe80::2 machine # [ 17.961790] dhcpcd[620]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 17.961993] dhcpcd[620]: eth0: adding route to 10.0.2.0/24 machine # [ 17.962114] dhcpcd[620]: eth0: adding default route via 10.0.2.2 machine # [ 18.065087] systemd[1]: Started DHCP Client. machine # [ 18.067538] systemd[1]: Reached target Multi-User System. machine # [ 18.069117] systemd[1]: Startup finished in 1.103s (kernel) + 4.370s (initrd) + 12.594s (userspace) = 18.067s. machine: (finished: waiting for unit multi-user.target, in 19.48 seconds) machine: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 18.988344] nixos[834]: switching to system configuration /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test machine # [ 18.991194] systemd[1]: Stopped target Local File Systems. machine # [ 18.993199] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # setting up /etc... machine # [ 19.303608] systemd[1]: Reload requested from client PID 834 ('.switch-to-conf') (unit backdoor.service)... machine # [ 19.305889] systemd[1]: Reloading... machine # [ 19.659281] systemd[1]: Reloading finished in 351 ms. machine # reloading user units for usertest... machine # [ 19.718287] systemd[587]: Created slice User Core Session Slice. machine # [ 19.722264] systemd[587]: Starting D-Bus User Message Bus... machine # [ 19.756885] dbus-broker-launch[904]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/lwvd8zypc7d831h4k85sqslcsqwvyagn-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 19.760151] dbus-broker-launch[904]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/lwvd8zypc7d831h4k85sqslcsqwvyagn-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 19.763135] dbus-broker-launch[904]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/lwvd8zypc7d831h4k85sqslcsqwvyagn-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 19.766276] dbus-broker-launch[904]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/lwvd8zypc7d831h4k85sqslcsqwvyagn-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 19.772367] systemd[587]: Started D-Bus User Message Bus. machine # [ 19.773244] dbus-broker-launch[904]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 19.774964] dbus-broker-launch[904]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 19.780347] dbus-broker-launch[904]: Ready machine # [ 19.832327] systemd[587]: Reexecution requested from client PID 903 ('switch-to-confi')... machine # [ 19.835653] systemd[587]: Reexecuting. machine # [ 19.895817] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.018705] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.027574] systemd[587]: Reload requested from client PID 903 ('switch-to-confi')... machine # [ 20.032351] systemd[587]: Reloading... machine # [ 20.158063] systemd[587]: Reloading finished in 127 ms. machine # [ 20.172244] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 20.184783] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 20.187765] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 20.190426] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 20.229933] systemd[587]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 20.245155] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 20.359598] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 20.362340] systemd[1]: Reached target Reactivate sysinit units. machine # [ 20.371816] systemd[1]: Reached target Remote File Systems. machine # [ 20.376248] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.377779] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 20.381250] systemd[1]: Starting linger-users.service... machine # [ 20.385259] systemd[1]: Reached target Local File Systems. machine # [ 20.394708] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 20.406004] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 20.407122] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 20.414461] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 20.417597] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 20.419397] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.420878] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.493228] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 20.495957] systemd[1]: Finished linger-users.service. machine # [ 20.645783] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 20.649310] systemd[1]: Finished Create SUID/SGID Wrappers. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 20.907696] nixos[834]: finished switching to system configuration /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test machine: (finished: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/bin/switch-to-configuration test, in 2.16 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.03 seconds) machine: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/vyc9823rbn3dgdj17a37652ajil02dnv-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/vyc9823rbn3dgdj17a37652ajil02dnv-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 21.204820] nixos[982]: switching to system configuration /nix/store/vyc9823rbn3dgdj17a37652ajil02dnv-nixos-system-other-test machine # [ 21.207540] systemd[1]: Stopped target Local File Systems. machine # activating the configuration... machine # [ 21.210358] systemd[1]: Stopped target Remote File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 21.539149] systemd[1]: Reload requested from client PID 982 ('.switch-to-conf') (unit backdoor.service)... machine # [ 21.541436] systemd[1]: Reloading... machine # [ 21.915981] systemd[1]: Reloading finished in 373 ms. machine # reloading user units for usertest... machine # [ 22.016791] systemd[587]: Reexecution requested from client PID 1053 ('switch-to-confi')... machine # [ 22.020169] systemd[587]: Reexecuting. machine # [ 22.071990] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.192722] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.199968] systemd[587]: Reload requested from client PID 1053 ('switch-to-confi')... machine # [ 22.202423] systemd[587]: Reloading... machine # [ 22.317971] systemd[587]: Reloading finished in 114 ms. machine # [ 22.332919] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 22.349231] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 22.352110] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 22.354549] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 22.392228] systemd[587]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 22.397117] systemd[1]: Stopped target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service machine # [ 22.401740] systemd[1]: Stopping Reactivate sysinit units... machine # [ 22.402663] systemd[1]: Reached target Reactivate sysinit units. machine # [ 22.403922] dbus-broker-launch[437]: Caught SIGHUP, trigger reload. machine # [ 22.407197] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 22.412419] dbus-broker-launch[437]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 22.414764] dbus-broker-launch[437]: NSS returned no entry for 'systemd-timesync' machine # [ 22.416005] dbus-broker-launch[437]: Invalid user-name in /nix/store/dywaqxfqn4w86xba4frwwckp6r9njfan-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 22.434797] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 22.443084] systemd[1]: Stopping Address configuration of eth1... machine # [ 22.478671] network-addresses-eth1-pre-stop[1065]: deleting address 192.168.1.1/24... done machine # [ 22.486268] network-addresses-eth1-pre-stop[1065]: deleting address 2001:db8:1::1/64... done machine # [ 22.494736] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 22.497620] systemd[1]: Stopped Address configuration of eth1. machine # [ 22.503378] systemd[1]: Starting Address configuration of eth1... machine # [ 22.553703] network-addresses-eth1-start[1070]: adding address 192.168.1.2/24... done machine # [ 22.562443] network-addresses-eth1-start[1070]: adding address 2001:db8:1::2/64... done machine # [ 22.576316] systemd[1]: Finished Address configuration of eth1. machine # [ 22.586238] systemd[1]: Reached target Local File Systems. machine # [ 22.590110] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 22.599558] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 22.605302] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 22.606745] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 22.613126] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 22.615058] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.623045] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.626992] systemd[1]: Reached target Remote File Systems. machine # [ 22.627948] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.629536] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 22.858240] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 22.860649] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 22.866999] systemd[1]: Starting linger-users.service... machine # [ 22.902283] linger-users-start[1142]: id: ‘usertest’: no such user machine # [ 22.904970] linger-users-start[1140]: Removing linger for missing user usertest machine # [ 22.914253] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 22.916561] systemd[1]: Finished linger-users.service. machine # [ 23.175452] nixos[982]: finished switching to system configuration /nix/store/vyc9823rbn3dgdj17a37652ajil02dnv-nixos-system-other-test machine: (finished: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/vyc9823rbn3dgdj17a37652ajil02dnv-nixos-system-other-test/bin/switch-to-configuration test, in 2.24 seconds) subtest: services machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 23.421623] nixos[1148]: switching to system configuration /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test machine # [ 23.424574] systemd[1]: Stopped target Remote File Systems. machine # [ 23.427198] systemd[1]: Stopped target Local File Systems. machine # [ 23.748814] systemd[1]: Reload requested from client PID 1148 ('.switch-to-conf') (unit backdoor.service)... machine # [ 23.750565] systemd[1]: Reloading... machine # [ 24.141707] systemd[1]: Reloading finished in 387 ms. machine # [ 24.286453] systemd[587]: Reexecution requested from client PID 1217 ('switch-to-confi')... machine # [ 24.288981] systemd[587]: Reexecuting. machine # [ 24.343933] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.484422] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.494096] systemd[587]: Reload requested from client PID 1217 ('switch-to-confi')... machine # [ 24.496377] systemd[587]: Reloading... machine # [ 24.649608] systemd[587]: Reloading finished in 152 ms. machine # [ 24.664313] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.676306] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 24.679518] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 24.682668] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 24.721400] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 24.727661] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 24.730030] systemd[1]: Stopping Reactivate sysinit units... machine # [ 24.731067] systemd[1]: Reached target Reactivate sysinit units. machine # [ 24.736458] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 24.737948] dbus-broker-launch[437]: Caught SIGHUP, trigger reload. machine # [ 24.742576] dbus-broker-launch[437]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 24.745359] dbus-broker-launch[437]: NSS returned no entry for 'systemd-timesync' machine # [ 24.746626] dbus-broker-launch[437]: Invalid user-name in /nix/store/lwvd8zypc7d831h4k85sqslcsqwvyagn-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 24.774951] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 24.782193] systemd[1]: Stopping Address configuration of eth1... machine # [ 24.817594] network-addresses-eth1-pre-stop[1230]: deleting address 192.168.1.2/24... done machine # [ 24.824838] network-addresses-eth1-pre-stop[1230]: deleting address 2001:db8:1::2/64... done machine # [ 24.832569] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 24.834986] systemd[1]: Stopped Address configuration of eth1. machine # [ 24.839790] systemd[1]: Starting Address configuration of eth1... machine # [ 24.891725] network-addresses-eth1-start[1235]: adding address 192.168.1.1/24... done machine # [ 24.904233] network-addresses-eth1-start[1235]: adding address 2001:db8:1::1/64... done machine # [ 24.920775] systemd[1]: Finished Address configuration of eth1. machine # [ 24.926385] systemd[1]: Reached target Local File Systems. machine # [ 24.933020] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 24.940727] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 24.941742] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 24.953266] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 24.955738] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 24.965663] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.967373] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.971826] systemd[1]: Reached target Remote File Systems. machine # [ 24.972941] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.974269] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 25.192585] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 25.195750] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 25.202879] systemd[1]: Starting linger-users.service... machine # [ 25.249868] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 25.253310] systemd[1]: Finished linger-users.service. machine # [ 25.509913] nixos[1148]: finished switching to system configuration /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.33 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 25.739345] nixos[1304]: switching to system configuration /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test machine # [ 25.742057] systemd[1]: Stopped target Local File Systems. machine # [ 25.745075] systemd[1]: Stopped target Remote File Systems. machine # [ 26.052729] systemd[1]: Reload requested from client PID 1304 ('.switch-to-conf') (unit backdoor.service)... machine # [ 26.054366] systemd[1]: Reloading... machine # [ 26.406949] systemd[1]: Reloading finished in 350 ms. machine # [ 26.513701] systemd[587]: Reexecution requested from client PID 1372 ('switch-to-confi')... machine # [ 26.518055] systemd[587]: Reexecuting. machine # [ 26.571787] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.692632] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.700655] systemd[587]: Reload requested from client PID 1372 ('switch-to-confi')... machine # [ 26.705248] systemd[587]: Reloading... machine # [ 26.823303] systemd[587]: Reloading finished in 119 ms. machine # [ 26.840274] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.850954] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 26.853574] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 26.856167] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 26.892718] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 26.897338] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 26.899446] systemd[1]: Stopping Reactivate sysinit units... machine # [ 26.904921] systemd[1]: Reached target Reactivate sysinit units. machine # [ 26.905915] systemd[1]: Reached target Remote File Systems. machine # [ 26.908138] systemd[1]: Starting linger-users.service... machine # [ 26.912416] systemd[1]: Reached target Local File Systems. machine # [ 26.924747] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.926253] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 26.927791] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 26.944625] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 26.945700] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 26.952797] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 26.957600] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 26.959482] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.966293] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.009888] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 27.014533] systemd[1]: Finished linger-users.service. machine # [ 27.165851] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 27.170269] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 27.425676] nixos[1304]: finished switching to system configuration /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.91 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 27.668955] nixos[1445]: switching to system configuration /nix/store/mrc4p9kx9rs2w8glis3kbhjvg1v952np-nixos-system-machine-test machine # [ 27.672425] systemd[1]: Stopped target Local File Systems. machine # [ 27.675645] systemd[1]: Stopped target Remote File Systems. machine # [ 28.006999] systemd[1]: Reload requested from client PID 1445 ('.switch-to-conf') (unit backdoor.service)... machine # [ 28.009274] systemd[1]: Reloading... machine # [ 28.425735] systemd[1]: Reloading finished in 414 ms. machine # [ 28.533077] systemd[587]: Reexecution requested from client PID 1514 ('switch-to-confi')... machine # [ 28.537759] systemd[587]: Reexecuting. machine # [ 28.583566] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.713695] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.721124] systemd[587]: Reload requested from client PID 1514 ('switch-to-confi')... machine # [ 28.725223] systemd[587]: Reloading... machine # [ 28.841972] systemd[587]: Reloading finished in 117 ms. machine # [ 28.856197] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.867415] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 28.870005] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 28.872922] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 28.906517] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 28.911651] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 28.913264] systemd[1]: Stopping Reactivate sysinit units... machine # [ 28.914151] systemd[1]: Reached target Reactivate sysinit units. machine # [ 28.919869] systemd[1]: Reached target Local File Systems. machine # [ 28.923638] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 28.928222] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 28.929261] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 28.930664] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 28.940926] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 28.942960] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.952897] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.954372] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.955792] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 28.957669] systemd[1]: Reached target Remote File Systems. machine # [ 29.133127] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 29.136310] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 29.141919] systemd[1]: Starting linger-users.service... machine # [ 29.145241] systemd[1]: Starting test.service... machine # [ 29.188428] systemd[1]: Finished test.service. machine # [ 29.211069] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 29.214366] systemd[1]: Finished linger-users.service. machine # [ 29.471980] nixos[1445]: finished switching to system configuration /nix/store/mrc4p9kx9rs2w8glis3kbhjvg1v952np-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 2.05 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 29.721427] nixos[1587]: switching to system configuration /nix/store/mrc4p9kx9rs2w8glis3kbhjvg1v952np-nixos-system-machine-test machine # [ 29.724722] systemd[1]: Stopped target Local File Systems. machine # [ 29.726534] systemd[1]: Stopped target Remote File Systems. machine # [ 30.030703] systemd[1]: Reload requested from client PID 1587 ('.switch-to-conf') (unit backdoor.service)... machine # [ 30.032981] systemd[1]: Reloading... machine # [ 30.402605] systemd[1]: Reloading finished in 366 ms. machine # [ 30.498731] systemd[587]: Reexecution requested from client PID 1656 ('switch-to-confi')... machine # [ 30.501092] systemd[587]: Reexecuting. machine # [ 30.560376] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.685820] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.698032] systemd[587]: Reload requested from client PID 1656 ('switch-to-confi')... machine # [ 30.707858] systemd[587]: Reloading... machine # [ 30.893797] systemd[587]: Reloading finished in 192 ms. machine # [ 30.908317] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.920733] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 30.923784] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 30.926666] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 30.965759] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 30.971101] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 30.974394] systemd[1]: Stopping Reactivate sysinit units... machine # [ 30.975514] systemd[1]: Reached target Reactivate sysinit units. machine # [ 30.980297] systemd[1]: Reached target Remote File Systems. machine # [ 30.985571] systemd[1]: Starting linger-users.service... machine # [ 30.996230] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.997818] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 31.003129] systemd[1]: Reached target Local File Systems. machine # [ 31.006653] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 31.016597] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 31.017759] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 31.019486] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 31.036530] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 31.038386] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.039954] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.098964] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 31.102302] systemd[1]: Finished linger-users.service. machine # [ 31.302654] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 31.306167] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 31.563962] nixos[1587]: finished switching to system configuration /nix/store/mrc4p9kx9rs2w8glis3kbhjvg1v952np-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 2.09 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 31.844854] nixos[1728]: switching to system configuration /nix/store/pwkg7l5crd1nxgnwn4mnw39l97c1f9xy-nixos-system-machine-test machine # [ 31.847972] systemd[1]: Stopped target Local File Systems. machine # [ 31.851073] systemd[1]: Stopped target Remote File Systems. machine # [ 32.197501] systemd[1]: Reload requested from client PID 1728 ('.switch-to-conf') (unit backdoor.service)... machine # [ 32.199727] systemd[1]: Reloading... machine # [ 32.641045] systemd[1]: Reloading finished in 439 ms. machine # [ 32.746124] systemd[587]: Reexecution requested from client PID 1797 ('switch-to-confi')... machine # [ 32.750685] systemd[587]: Reexecuting. machine # [ 32.800288] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.927921] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.936291] systemd[587]: Reload requested from client PID 1797 ('switch-to-confi')... machine # [ 32.941282] systemd[587]: Reloading... machine # [ 33.064073] systemd[587]: Reloading finished in 124 ms. machine # [ 33.080269] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.091182] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 33.093952] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 33.096398] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 33.136294] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 33.141320] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 33.145226] systemd[1]: Stopping Reactivate sysinit units... machine # [ 33.146306] systemd[1]: Reached target Reactivate sysinit units. machine # [ 33.148636] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.150178] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 33.154629] systemd[1]: Reached target Remote File Systems. machine # [ 33.157823] systemd[1]: Reached target Local File Systems. machine # [ 33.163778] systemd[1]: Starting linger-users.service... machine # [ 33.170755] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 33.183675] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 33.189608] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 33.191127] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 33.199975] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 33.206006] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.207639] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.270139] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 33.274023] systemd[1]: Finished linger-users.service. machine # [ 33.478043] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 33.482262] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 33.740162] nixos[1728]: finished switching to system configuration /nix/store/pwkg7l5crd1nxgnwn4mnw39l97c1f9xy-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 2.17 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 34.021024] nixos[1868]: switching to system configuration /nix/store/rcd74gbcbvclm8kbhf20l2fxwyrds99l-nixos-system-machine-test machine # [ 34.030593] systemd[1]: Stopped target Local File Systems. machine # [ 34.031916] systemd[1]: Stopped target Remote File Systems. machine # [ 34.037833] systemd[1]: test.service: Deactivated successfully. machine # [ 34.038925] systemd[1]: Stopped Test unit. machine # [ 34.483273] systemd[1]: Reload requested from client PID 1868 ('.switch-to-conf') (unit backdoor.service)... machine # [ 34.485742] systemd[1]: Reloading... machine # [ 35.049620] systemd[1]: Reloading finished in 562 ms. machine # [ 35.150435] systemd[587]: Reexecution requested from client PID 1937 ('switch-to-confi')... machine # [ 35.153070] systemd[587]: Reexecuting. machine # [ 35.203827] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.328345] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.336696] systemd[587]: Reload requested from client PID 1937 ('switch-to-confi')... machine # [ 35.341096] systemd[587]: Reloading... machine # [ 35.460923] systemd[587]: Reloading finished in 120 ms. machine # [ 35.476293] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.486944] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 35.489984] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 35.492375] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 35.530070] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 35.537464] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 35.538641] systemd[1]: Stopping Reactivate sysinit units... machine # [ 35.539675] systemd[1]: Reached target Reactivate sysinit units. machine # [ 35.554119] systemd[1]: Reached target Remote File Systems. machine # [ 35.555203] systemd[1]: Reached target Local File Systems. machine # [ 35.563674] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 35.574504] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 35.575679] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 35.578901] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 35.582248] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 35.584654] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.586022] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.588373] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.591085] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 35.794806] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 35.797185] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 35.804538] systemd[1]: Starting linger-users.service... machine # [ 35.810627] systemd[1]: Starting test.service... machine # [ 35.859030] systemd[1]: Finished test.service. machine # [ 35.885182] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 35.887970] systemd[1]: Finished linger-users.service. machine # [ 36.146303] nixos[1868]: finished switching to system configuration /nix/store/rcd74gbcbvclm8kbhf20l2fxwyrds99l-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 2.41 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 36.605784] nixos[2011]: switching to system configuration /nix/store/g4z5yys9wjkvy6hdkvy00nrgjm02yvnf-nixos-system-machine-test machine # [ 36.610433] systemd[1]: Stopped target Remote File Systems. machine # [ 36.613209] systemd[1]: Stopped target Local File Systems. machine # [ 37.137446] systemd[1]: Reload requested from client PID 2011 ('.switch-to-conf') (unit backdoor.service)... machine # [ 37.142990] systemd[1]: Reloading... machine # [ 37.756952] systemd[1]: Reloading finished in 610 ms. machine # [ 37.905560] systemd[587]: Reexecution requested from client PID 2080 ('switch-to-confi')... machine # [ 37.911266] systemd[587]: Reexecuting. machine # [ 37.972230] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.114529] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.122813] systemd[587]: Reload requested from client PID 2080 ('switch-to-confi')... machine # [ 38.126926] systemd[587]: Reloading... machine # [ 38.247437] systemd[587]: Reloading finished in 121 ms. machine # [ 38.264203] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.275557] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 38.278303] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 38.280851] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 38.320082] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 38.325954] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 38.329132] systemd[1]: Stopping Reactivate sysinit units... machine # [ 38.330086] systemd[1]: Reached target Reactivate sysinit units. machine # [ 38.334455] systemd[1]: test.service: Deactivated successfully. machine # [ 38.335654] systemd[1]: Stopped test.service. machine # [ 38.340473] systemd[1]: Stopping test.service... machine # [ 38.342288] systemd[1]: Starting test.service... machine # [ 38.364490] systemd[1]: Finished test.service. machine # [ 38.372182] systemd[1]: Reached target Local File Systems. machine # [ 38.377762] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 38.388272] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 38.389443] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 38.390957] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 38.401155] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 38.403061] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.411761] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.414476] systemd[1]: Reached target Remote File Systems. machine # [ 38.422368] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.425688] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 38.638338] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 38.641670] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.649752] systemd[1]: Starting linger-users.service... machine # [ 38.721163] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 38.723991] systemd[1]: Finished linger-users.service. machine # [ 38.981978] nixos[2011]: finished switching to system configuration /nix/store/g4z5yys9wjkvy6hdkvy00nrgjm02yvnf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.84 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 39.245801] nixos[2154]: switching to system configuration /nix/store/b6js6vr3x5vlaal462psa4dlabb0v4nc-nixos-system-machine-test machine # [ 39.250804] systemd[1]: Stopped target Remote File Systems. machine # [ 39.252247] systemd[1]: Stopped target Local File Systems. machine # [ 39.618051] systemd[1]: Reload requested from client PID 2154 ('.switch-to-conf') (unit backdoor.service)... machine # [ 39.620720] systemd[1]: Reloading... machine # [ 40.254994] systemd[1]: Reloading finished in 632 ms. machine # [ 40.354382] systemd[587]: Reexecution requested from client PID 2222 ('switch-to-confi')... machine # [ 40.359467] systemd[587]: Reexecuting. machine # [ 40.423788] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.924688] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.932561] systemd[587]: Reload requested from client PID 2222 ('switch-to-confi')... machine # [ 40.933942] systemd[587]: Reloading... machine # [ 41.053179] systemd[587]: Reloading finished in 117 ms. machine # [ 41.070428] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.080099] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 41.081268] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 41.084098] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 41.122073] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 41.127608] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 41.129981] systemd[1]: Stopping Reactivate sysinit units... machine # [ 41.130940] systemd[1]: Reached target Reactivate sysinit units. machine # [ 41.137495] systemd[1]: Reloading test.service... machine # [ 41.173045] systemd[1]: Reloaded test.service. machine # [ 41.178344] systemd[1]: Reached target Local File Systems. machine # [ 41.183802] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.186958] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 41.193155] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 41.197597] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 41.198627] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 41.210234] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 41.213004] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 41.214809] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.220681] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.222031] systemd[1]: Reached target Remote File Systems. machine # [ 41.461886] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 41.464479] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 41.471029] systemd[1]: Starting linger-users.service... machine # [ 41.524820] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 41.527917] systemd[1]: Finished linger-users.service. machine # [ 41.790066] nixos[2154]: finished switching to system configuration /nix/store/b6js6vr3x5vlaal462psa4dlabb0v4nc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 2.81 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 42.047203] nixos[2297]: switching to system configuration /nix/store/d6fzs56x0w5gcby739vjjaddab4izqsp-nixos-system-machine-test machine # [ 42.050430] systemd[1]: Stopped target Remote File Systems. machine # [ 42.052424] systemd[1]: Stopped target Local File Systems. machine # [ 42.395924] systemd[1]: Reload requested from client PID 2297 ('.switch-to-conf') (unit backdoor.service)... machine # [ 42.398235] systemd[1]: Reloading... machine # [ 42.765269] systemd[1]: Reloading finished in 364 ms. machine # [ 42.868595] systemd[587]: Reexecution requested from client PID 2366 ('switch-to-confi')... machine # [ 42.872491] systemd[587]: Reexecuting. machine # [ 42.924316] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.041917] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.049217] systemd[587]: Reload requested from client PID 2366 ('switch-to-confi')... machine # [ 43.053392] systemd[587]: Reloading... machine # [ 43.163961] systemd[587]: Reloading finished in 111 ms. machine # [ 43.181880] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.191509] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 43.194117] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 43.198223] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 43.233773] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 43.238128] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 43.241450] systemd[1]: Stopping Reactivate sysinit units... machine # [ 43.242418] systemd[1]: Reached target Reactivate sysinit units. machine # [ 43.246875] systemd[1]: Reached target Remote File Systems. machine # [ 43.249682] systemd[1]: Starting linger-users.service... machine # [ 43.253750] systemd[1]: Reached target Local File Systems. machine # [ 43.264261] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 43.276561] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 43.277644] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 43.279035] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 43.290636] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 43.295682] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.303406] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.308573] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.310043] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 43.353509] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 43.356877] systemd[1]: Finished linger-users.service. machine # [ 43.501016] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 43.502954] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 43.760263] nixos[2297]: finished switching to system configuration /nix/store/d6fzs56x0w5gcby739vjjaddab4izqsp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.97 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.43 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 44.401161] nixos[2448]: switching to system configuration /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test machine # [ 44.405779] systemd[1]: Stopped target Local File Systems. machine # [ 44.407959] systemd[1]: Stopped target Remote File Systems. machine # [ 44.409982] systemd[1]: test.service: Deactivated successfully. machine # [ 44.410969] systemd[1]: Stopped test.service. machine # [ 44.719979] systemd[1]: Reload requested from client PID 2448 ('.switch-to-conf') (unit backdoor.service)... machine # [ 44.722225] systemd[1]: Reloading... machine # [ 45.060392] systemd[1]: Reloading finished in 335 ms. machine # [ 45.162903] systemd[587]: Reexecution requested from client PID 2517 ('switch-to-confi')... machine # [ 45.167832] systemd[587]: Reexecuting. machine # [ 45.211911] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.322902] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.329821] systemd[587]: Reload requested from client PID 2517 ('switch-to-confi')... machine # [ 45.332510] systemd[587]: Reloading... machine # [ 45.439449] systemd[587]: Reloading finished in 105 ms. machine # [ 45.456230] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.468144] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 45.470813] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 45.473125] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 45.523324] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 45.528893] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 45.529903] systemd[1]: Stopping Reactivate sysinit units... machine # [ 45.530810] systemd[1]: Reached target Reactivate sysinit units. machine # [ 45.538180] systemd[1]: Reached target Remote File Systems. machine # [ 45.545269] systemd[1]: Starting linger-users.service... machine # [ 45.554100] systemd[1]: Reached target Local File Systems. machine # [ 45.556814] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.561339] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 45.562840] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 45.569994] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 45.571024] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 45.580529] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 45.582994] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 45.590357] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.591914] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.630991] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 45.635694] systemd[1]: Finished linger-users.service. machine # [ 45.777437] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 45.780503] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 46.036416] nixos[2448]: finished switching to system configuration /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.85 seconds) machine: must succeed: /nix/store/qdpknrfwzf0p4ncdm0awksgvandh5x95-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 46.258914] nixos[2588]: switching to system configuration /nix/store/sini1f5j2f1lj558xgzsay2dxvks1h8b-nixos-system-machine-test machine # [ 46.261804] systemd[1]: Stopped target Local File Systems. machine # [ 46.264534] systemd[1]: Stopped target Remote File Systems. machine # [ 46.567359] systemd[1]: Reload requested from client PID 2588 ('.switch-to-conf') (unit backdoor.service)... machine # [ 46.569717] systemd[1]: Reloading... machine # [ 46.895220] systemd[1]: Reloading finished in 324 ms. machine # [ 46.994997] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 46.998906] systemd[587]: Reexecution requested from client PID 2657 ('switch-to-confi')... machine # [ 47.000996] systemd[587]: Reexecuting. machine # [ 47.060304] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.179194] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.186166] systemd[587]: Reload requested from client PID 2657 ('switch-to-confi')... machine # [ 47.189205] systemd[587]: Reloading... machine # [ 47.299079] systemd[587]: Reloading finished in 108 ms. machine # [ 47.320236] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.332159] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 47.335260] systemd[1]: Stopping Reactivate sysinit units... machine # [ 47.337736] systemd[1]: Reached target Reactivate sysinit units. machine # [ 47.340363] systemd[1]: Reached target Local File Systems. machine # [ 47.341288] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 47.356306] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 47.357389] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 47.358817] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 47.365196] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 47.367028] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.370711] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.374371] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.375947] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 47.379999] systemd[1]: Reached target Remote File Systems. machine # [ 47.545493] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 47.551118] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 47.554974] systemd[1]: Starting linger-users.service... machine # [ 47.558932] systemd[1]: Starting test.service... machine # [ 47.601455] systemd[1]: Finished test.service. machine # [ 47.621858] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 47.625531] systemd[1]: Finished linger-users.service. machine # [ 47.880946] nixos[2588]: finished switching to system configuration /nix/store/sini1f5j2f1lj558xgzsay2dxvks1h8b-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qdpknrfwzf0p4ncdm0awksgvandh5x95-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.84 seconds) machine: must succeed: ! test -e /run/current-system/activate machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.02 seconds) machine: must succeed: ! test -e /run/current-system/dry-activate machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.02 seconds) machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.02 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 48.182515] nixos[2736]: switching to system configuration /nix/store/dhgwbfjgmd0ri3dqjy5nr1ziv8ri3yn0-nixos-system-machine-test machine # [ 48.185996] systemd[1]: Stopped target Remote File Systems. machine # [ 48.187913] systemd[1]: test.service: Deactivated successfully. machine # [ 48.191673] systemd[1]: Stopped test.service. machine # [ 48.192905] systemd[1]: Stopped target Local File Systems. machine # [ 48.493829] systemd[1]: Reload requested from client PID 2736 ('.switch-to-conf') (unit backdoor.service)... machine # [ 48.496110] systemd[1]: Reloading... machine # [ 48.837755] systemd[1]: Reloading finished in 339 ms. machine # [ 48.928288] systemd[587]: Reexecution requested from client PID 2805 ('switch-to-confi')... machine # [ 48.929757] systemd[587]: Reexecuting. machine # [ 48.987905] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.101289] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.107998] systemd[587]: Reload requested from client PID 2805 ('switch-to-confi')... machine # [ 49.112433] systemd[587]: Reloading... machine # [ 49.218223] systemd[587]: Reloading finished in 107 ms. machine # [ 49.232210] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.243720] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 49.276661] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 49.279859] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 49.282288] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 49.288223] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 49.290781] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 49.291746] systemd[1]: Stopping Reactivate sysinit units... machine # [ 49.296612] systemd[1]: Reached target Reactivate sysinit units. machine # [ 49.300644] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.303567] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 49.329870] systemd[1]: Started test.service. machine # [ 49.335012] systemd[1]: Reached target Remote File Systems. machine # [ 49.344435] systemd[1]: Starting linger-users.service... machine # [ 49.355860] systemd[1]: Reached target Local File Systems. machine # [ 49.358789] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 49.374760] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 49.382756] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 49.383732] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 49.390323] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 49.395895] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 49.405741] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.407428] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.415154] systemd[1]: test.service: Deactivated successfully. machine # [ 49.470600] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 49.473753] systemd[1]: Finished linger-users.service. machine # [ 49.621884] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 49.625057] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 49.879369] nixos[2736]: finished switching to system configuration /nix/store/dhgwbfjgmd0ri3dqjy5nr1ziv8ri3yn0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.94 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 50.116627] nixos[2881]: switching to system configuration /nix/store/2vrh94gvnaxqiql17g1q62fs8bhmk9sp-nixos-system-machine-test machine # [ 50.119732] systemd[1]: Stopped target Local File Systems. machine # [ 50.122173] systemd[1]: Stopped target Remote File Systems. machine # [ 50.443163] systemd[1]: Reload requested from client PID 2881 ('.switch-to-conf') (unit backdoor.service)... machine # [ 50.445585] systemd[1]: Reloading... machine # [ 51.134351] systemd[1]: Reloading finished in 686 ms. machine # [ 51.222087] systemd[587]: Reexecution requested from client PID 2950 ('switch-to-confi')... machine # [ 51.223747] systemd[587]: Reexecuting. machine # [ 51.287708] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.402793] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.409637] systemd[587]: Reload requested from client PID 2950 ('switch-to-confi')... machine # [ 51.413721] systemd[587]: Reloading... machine # [ 51.521654] systemd[587]: Reloading finished in 108 ms. machine # [ 51.536291] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.547349] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 51.549929] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 51.552280] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 51.586116] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 51.590508] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 51.592584] systemd[1]: Stopping Reactivate sysinit units... machine # [ 51.593613] systemd[1]: Reached target Reactivate sysinit units. machine # [ 51.599469] systemd[1]: Reached target Remote File Systems. machine # [ 51.603925] systemd[1]: Starting escaped\x2ddash.service... machine # [ 51.609841] systemd[1]: Starting linger-users.service... machine # [ 51.622976] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.634362] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 51.635888] systemd[1]: Reached target Local File Systems. machine # [ 51.650096] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 51.651864] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 51.661444] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 51.668380] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 51.682217] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 51.691711] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.698224] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.699633] systemd[1]: Finished escaped\x2ddash.service. machine # [ 51.737125] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 51.741962] systemd[1]: Finished linger-users.service. machine # [ 51.905830] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 51.909349] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 52.167006] nixos[2881]: finished switching to system configuration /nix/store/2vrh94gvnaxqiql17g1q62fs8bhmk9sp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 2.29 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 52.414008] nixos[3023]: switching to system configuration /nix/store/g67asrrlk1m4qbp13icwnq21694d7ric-nixos-system-machine-test machine # [ 52.417345] systemd[1]: Stopped target Remote File Systems. machine # [ 52.421217] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 52.422899] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 52.423783] systemd[1]: Stopped target Local File Systems. machine # [ 52.750379] systemd[1]: Reload requested from client PID 3023 ('.switch-to-conf') (unit backdoor.service)... machine # [ 52.752759] systemd[1]: Reloading... machine # [ 53.120663] systemd[1]: Reloading finished in 366 ms. machine # [ 53.217630] systemd[587]: Reexecution requested from client PID 3092 ('switch-to-confi')... machine # [ 53.222403] systemd[587]: Reexecuting. machine # [ 53.285292] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.404821] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.412114] systemd[587]: Reload requested from client PID 3092 ('switch-to-confi')... machine # [ 53.413571] systemd[587]: Reloading... machine # [ 53.527863] systemd[587]: Reloading finished in 112 ms. machine # [ 53.544276] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.554965] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 53.557526] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 53.561166] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 53.592630] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 53.597040] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 53.599937] systemd[1]: Stopping Reactivate sysinit units... machine # [ 53.604891] systemd[1]: Reached target Reactivate sysinit units. machine # [ 53.605847] systemd[1]: Reached target Remote File Systems. machine # [ 53.608308] systemd[1]: Starting escaped\x2ddash.service... machine # [ 53.612886] systemd[1]: Starting linger-users.service... machine # [ 53.625616] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.627148] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 53.644318] systemd[1]: Reached target Local File Systems. machine # [ 53.645260] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 53.646950] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 53.647795] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 53.656548] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 53.658942] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 53.673677] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.681888] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.695575] systemd[1]: Finished escaped\x2ddash.service. machine # [ 53.733877] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 53.736987] systemd[1]: Finished linger-users.service. machine # [ 53.872968] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 53.877120] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 54.131064] nixos[3023]: finished switching to system configuration /nix/store/g67asrrlk1m4qbp13icwnq21694d7ric-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 1.96 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 54.360399] nixos[3165]: switching to system configuration /nix/store/b8jx62l33rxa430h0hirgbk5mywq1qap-nixos-system-machine-test machine # [ 54.363108] systemd[1]: Stopped target Remote File Systems. machine # [ 54.366716] systemd[1]: Stopped target Local File Systems. machine # [ 54.367593] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 54.368649] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 54.670776] systemd[1]: Reload requested from client PID 3165 ('.switch-to-conf') (unit backdoor.service)... machine # [ 54.673216] systemd[1]: Reloading... machine # [ 55.035526] systemd[1]: Reloading finished in 360 ms. machine # [ 55.132554] systemd[587]: Reexecution requested from client PID 3234 ('switch-to-confi')... machine # [ 55.137226] systemd[587]: Reexecuting. machine # [ 55.196702] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.317274] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.324524] systemd[587]: Reload requested from client PID 3234 ('switch-to-confi')... machine # [ 55.328658] systemd[587]: Reloading... machine # [ 55.485052] systemd[587]: Reloading finished in 157 ms. machine # [ 55.500341] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.511326] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 55.514256] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 55.517422] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 55.551599] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 55.556537] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 55.559655] systemd[1]: Stopping Reactivate sysinit units... machine # [ 55.562857] systemd[1]: Reached target Reactivate sysinit units. machine # [ 55.563832] systemd[1]: Reached target Local File Systems. machine # [ 55.565723] systemd[1]: Reached target Remote File Systems. machine # [ 55.568595] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.575234] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 55.579344] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 55.588798] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 55.589833] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 55.591223] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 55.600549] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 55.602310] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.604604] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.784675] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 55.788506] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 55.793429] systemd[1]: Starting -.service... machine # [ 55.798668] systemd[1]: Starting linger-users.service... machine # [ 55.844586] systemd[1]: Finished -.service. machine # [ 55.866764] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 55.869420] systemd[1]: Finished linger-users.service. machine # [ 56.128648] nixos[3165]: finished switching to system configuration /nix/store/b8jx62l33rxa430h0hirgbk5mywq1qap-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 2.00 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 56.386880] nixos[3307]: switching to system configuration /nix/store/3jpvcvsgbc7dfw859a4y9yfh4fpcq7i0-nixos-system-machine-test machine # [ 56.392853] systemd[1]: Stopped target Remote File Systems. machine # [ 56.393811] systemd[1]: Stopped target Local File Systems. machine # [ 56.734912] systemd[1]: Reload requested from client PID 3307 ('.switch-to-conf') (unit backdoor.service)... machine # [ 56.737472] systemd[1]: Reloading... machine # [ 57.102285] systemd[1]: Reloading finished in 361 ms. machine # [ 57.191026] systemd[587]: Reexecution requested from client PID 3375 ('switch-to-confi')... machine # [ 57.195659] systemd[587]: Reexecuting. machine # [ 57.255954] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.372631] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.380125] systemd[587]: Reload requested from client PID 3375 ('switch-to-confi')... machine # [ 57.381463] systemd[587]: Reloading... machine # [ 57.497149] systemd[587]: Reloading finished in 112 ms. machine # [ 57.512290] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.523965] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 57.527176] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 57.530007] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 57.567568] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 57.572662] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 57.576474] systemd[1]: Stopping Reactivate sysinit units... machine # [ 57.577472] systemd[1]: Reached target Reactivate sysinit units. machine # [ 57.581418] systemd[1]: Reloading -.service... machine # [ 57.611723] systemd[1]: Reloaded -.service. machine # [ 57.614987] systemd[1]: Reached target Remote File Systems. machine # [ 57.622203] systemd[1]: Reached target Local File Systems. machine # [ 57.625986] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 57.631547] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 57.636769] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 57.638225] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 57.650210] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 57.652425] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.653865] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.655206] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.656638] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 57.832956] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 57.834947] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 57.845182] systemd[1]: Starting linger-users.service... machine # [ 57.889593] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 57.892463] systemd[1]: Finished linger-users.service. machine # [ 58.149083] nixos[3307]: finished switching to system configuration /nix/store/3jpvcvsgbc7dfw859a4y9yfh4fpcq7i0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 2.02 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 58.916317] nixos[3449]: switching to system configuration /nix/store/hh3xhd73ababvnvnc98r5f8wyv4w5ajf-nixos-system-machine-test machine # [ 58.919316] systemd[1]: Stopped target Remote File Systems. machine # [ 58.921653] systemd[1]: Stopped target Local File Systems. machine # [ 58.923532] systemd[1]: -.service: Deactivated successfully. machine # [ 58.925107] systemd[1]: Stopped -.service. machine # [ 59.272708] systemd[1]: Reload requested from client PID 3449 ('.switch-to-conf') (unit backdoor.service)... machine # [ 59.275015] systemd[1]: Reloading... machine # [ 59.666310] systemd[1]: Reloading finished in 389 ms. machine # [ 59.765944] systemd[587]: Reexecution requested from client PID 3518 ('switch-to-confi')... machine # [ 59.767438] systemd[587]: Reexecuting. machine # [ 59.827711] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.949338] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.956633] systemd[587]: Reload requested from client PID 3518 ('switch-to-confi')... machine # [ 59.960937] systemd[587]: Reloading... machine # [ 60.068045] systemd[587]: Reloading finished in 108 ms. machine # [ 60.084191] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.094447] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 60.097159] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 60.099368] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 60.132289] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 60.137018] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 60.138015] systemd[1]: Stopping Reactivate sysinit units... machine # [ 60.140915] systemd[1]: Reached target Reactivate sysinit units. machine # [ 60.142452] systemd[1]: Reached target Local File Systems. machine # [ 60.146422] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 60.157126] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 60.158075] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 60.159468] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 60.172965] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 60.174904] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.176282] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.177543] systemd[1]: Reached target Remote File Systems. machine # [ 60.178350] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.179676] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 60.337459] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 60.342894] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 60.346466] systemd[1]: Starting linger-users.service... machine # [ 60.350099] systemd[1]: Starting required-service.service... machine # [ 60.353809] systemd[1]: Starting test-service.service... machine # [ 60.408793] systemd[1]: Finished required-service.service. machine # [ 60.412596] systemd[1]: Finished test-service.service. machine # [ 60.430911] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 60.432960] systemd[1]: Finished linger-users.service. machine # [ 60.690880] nixos[3449]: finished switching to system configuration /nix/store/hh3xhd73ababvnvnc98r5f8wyv4w5ajf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 2.54 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 60.992751] nixos[3593]: switching to system configuration /nix/store/0yanpi5qgzs12i61yp0z31cx5cnm7b9g-nixos-system-machine-test machine # [ 60.995563] systemd[1]: Stopped target Local File Systems. machine # [ 60.998902] systemd[1]: Stopped target Remote File Systems. machine # [ 61.001318] systemd[1]: required-service.service: Deactivated successfully. machine # [ 61.002601] systemd[1]: Stopped required-service.service. machine # [ 61.003473] systemd[1]: test-service.service: Deactivated successfully. machine # [ 61.007042] systemd[1]: Stopped test-service.service. machine # [ 61.322479] systemd[1]: Reload requested from client PID 3593 ('.switch-to-conf') (unit backdoor.service)... machine # [ 61.324717] systemd[1]: Reloading... machine # [ 61.679692] systemd[1]: Reloading finished in 353 ms. machine # [ 61.770658] systemd[587]: Reexecution requested from client PID 3662 ('switch-to-confi')... machine # [ 61.774825] systemd[587]: Reexecuting. machine # [ 61.836269] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.955291] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.962842] systemd[587]: Reload requested from client PID 3662 ('switch-to-confi')... machine # [ 61.966821] systemd[587]: Reloading... machine # [ 62.075621] systemd[587]: Reloading finished in 110 ms. machine # [ 62.092258] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.104241] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 62.105415] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 62.108947] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 62.141824] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 62.148640] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 62.150786] systemd[1]: Stopping Reactivate sysinit units... machine # [ 62.151747] systemd[1]: Reached target Reactivate sysinit units. machine # [ 62.155899] systemd[1]: Reached target Local File Systems. machine # [ 62.161050] systemd[1]: Reached target Remote File Systems. machine # [ 62.167731] systemd[1]: Starting linger-users.service... machine # [ 62.172876] systemd[1]: Starting required-service.service... machine # [ 62.185649] systemd[1]: Starting test-service.service... machine # [ 62.186751] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.197846] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 62.209404] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 62.211183] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 62.224517] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 62.230736] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 62.246935] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 62.256779] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.265739] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.280236] systemd[1]: Finished test-service.service. machine # [ 62.281230] systemd[1]: Finished required-service.service. machine # [ 62.318703] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 62.323968] systemd[1]: Finished linger-users.service. machine # [ 62.470379] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 62.474367] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 62.728683] nixos[3593]: finished switching to system configuration /nix/store/0yanpi5qgzs12i61yp0z31cx5cnm7b9g-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 2.04 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 62.981586] nixos[3737]: switching to system configuration /nix/store/1hxkvh97p40vrdd67djlpclvpl0hzf95-nixos-system-machine-test machine # [ 62.984580] systemd[1]: required-service.service: Deactivated successfully. machine # [ 62.989472] systemd[1]: Stopped required-service.service. machine # [ 62.990366] systemd[1]: test-service.service: Deactivated successfully. machine # [ 62.991419] systemd[1]: Stopped test-service.service. machine # [ 62.992208] systemd[1]: Stopped target Remote File Systems. machine # [ 62.993005] systemd[1]: Stopped target Local File Systems. machine # [ 63.296148] systemd[1]: Reload requested from client PID 3737 ('.switch-to-conf') (unit backdoor.service)... machine # [ 63.298196] systemd[1]: Reloading... machine # [ 63.669933] systemd[1]: Reloading finished in 369 ms. machine # [ 63.759201] systemd[587]: Reexecution requested from client PID 3806 ('switch-to-confi')... machine # [ 63.761814] systemd[587]: Reexecuting. machine # [ 63.819684] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.934329] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.942273] systemd[587]: Reload requested from client PID 3806 ('switch-to-confi')... machine # [ 63.943936] systemd[587]: Reloading... machine # [ 64.054160] systemd[587]: Reloading finished in 107 ms. machine # [ 64.068202] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.078261] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 64.080966] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 64.083244] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 64.116461] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 64.121456] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 64.123571] systemd[1]: Stopping Reactivate sysinit units... machine # [ 64.129098] systemd[1]: Reached target Reactivate sysinit units. machine # [ 64.130070] systemd[1]: Reached target Local File Systems. machine # [ 64.130900] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 64.135047] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 64.135990] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 64.144960] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 64.147384] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 64.154664] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.159137] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.164297] systemd[1]: Reached target Remote File Systems. machine # [ 64.165245] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.166885] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 64.325148] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 64.329933] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 64.332449] systemd[1]: Starting linger-users.service... machine # [ 64.336332] systemd[1]: Starting required-service.service... machine # [ 64.342081] systemd[1]: Starting test-service.service... machine # [ 64.395947] systemd[1]: Finished required-service.service. machine # [ 64.400428] systemd[1]: Finished test-service.service. machine # [ 64.419850] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 64.423338] systemd[1]: Finished linger-users.service. machine # [ 64.679265] nixos[3737]: finished switching to system configuration /nix/store/1hxkvh97p40vrdd67djlpclvpl0hzf95-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.95 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 64.929821] nixos[3881]: switching to system configuration /nix/store/mwibm7vrm5hdmangd32vbi3803ns33lz-nixos-system-machine-test machine # [ 64.932851] systemd[1]: Stopped target Remote File Systems. machine # [ 64.937298] systemd[1]: required-service.service: Deactivated successfully. machine # [ 64.938443] systemd[1]: Stopped required-service.service. machine # [ 64.939283] systemd[1]: test-service.service: Deactivated successfully. machine # [ 64.941651] systemd[1]: Stopped test-service.service. machine # [ 64.942600] systemd[1]: Stopped target Local File Systems. machine # [ 65.259880] systemd[1]: Reload requested from client PID 3881 ('.switch-to-conf') (unit backdoor.service)... machine # [ 65.262161] systemd[1]: Reloading... machine # [ 65.609694] systemd[1]: Reloading finished in 345 ms. machine # [ 65.697516] systemd[587]: Reexecution requested from client PID 3950 ('switch-to-confi')... machine # [ 65.702312] systemd[587]: Reexecuting. machine # [ 65.760089] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.878938] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.885956] systemd[587]: Reload requested from client PID 3950 ('switch-to-confi')... machine # [ 65.889008] systemd[587]: Reloading... machine # [ 66.002218] systemd[587]: Reloading finished in 112 ms. machine # [ 66.017681] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.026616] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 66.029050] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 66.031274] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 66.065196] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 66.069413] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 66.073872] systemd[1]: Stopping Reactivate sysinit units... machine # [ 66.074851] systemd[1]: Reached target Reactivate sysinit units. machine # [ 66.076977] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.081044] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 66.082514] systemd[1]: Reached target Remote File Systems. machine # [ 66.086034] systemd[1]: Created slice Slice /system/instantiated. machine # [ 66.091626] systemd[1]: Starting instantiated@one.service... machine # [ 66.095659] systemd[1]: Starting instantiated@two.service... machine # [ 66.099816] systemd[1]: Starting linger-users.service... machine # [ 66.112406] systemd[1]: Reached target Local File Systems. machine # [ 66.122524] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 66.131501] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 66.136242] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 66.137634] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 66.139939] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 66.153951] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.155435] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.194638] systemd[1]: Finished instantiated@one.service. machine # [ 66.195609] systemd[1]: Finished instantiated@two.service. machine # [ 66.239606] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 66.242340] systemd[1]: Finished linger-users.service. machine # [ 66.372658] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 66.374614] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 66.633648] nixos[3881]: finished switching to system configuration /nix/store/mwibm7vrm5hdmangd32vbi3803ns33lz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.95 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 66.880369] nixos[4025]: switching to system configuration /nix/store/m5a8jaiyy83wz0mxzvh5pbg1qdyqrq3j-nixos-system-machine-test machine # [ 66.883464] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 66.887029] systemd[1]: Stopped instantiated@one.service. machine # [ 66.887940] systemd[1]: Stopped target Local File Systems. machine # [ 66.889394] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 66.890492] systemd[1]: Stopped instantiated@two.service. machine # [ 66.891288] systemd[1]: Stopped target Remote File Systems. machine # [ 67.195645] systemd[1]: Reload requested from client PID 4025 ('.switch-to-conf') (unit backdoor.service)... machine # [ 67.197898] systemd[1]: Reloading... machine # [ 67.545829] systemd[1]: Reloading finished in 346 ms. machine # [ 67.636378] systemd[587]: Reexecution requested from client PID 4094 ('switch-to-confi')... machine # [ 67.637873] systemd[587]: Reexecuting. machine # [ 67.691300] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.806493] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.813692] systemd[587]: Reload requested from client PID 4094 ('switch-to-confi')... machine # [ 67.816545] systemd[587]: Reloading... machine # [ 67.925645] systemd[587]: Reloading finished in 108 ms. machine # [ 67.941766] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.952245] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 67.954587] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 67.956781] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 67.983738] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 67.987879] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 67.990346] systemd[1]: Stopping Reactivate sysinit units... machine # [ 67.991902] systemd[1]: Reached target Reactivate sysinit units. machine # [ 67.996406] systemd[1]: Reached target Remote File Systems. machine # [ 67.999813] systemd[1]: Starting instantiated@one.service... machine # [ 68.004419] systemd[1]: Starting instantiated@two.service... machine # [ 68.019289] systemd[1]: Starting linger-users.service... machine # [ 68.021287] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.022693] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 68.032609] systemd[1]: Reached target Local File Systems. machine # [ 68.034912] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 68.046088] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 68.047203] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 68.065165] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 68.067670] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 68.086672] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.093841] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.107889] systemd[1]: Finished instantiated@one.service. machine # [ 68.110821] systemd[1]: Finished instantiated@two.service. machine # [ 68.146016] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 68.148704] systemd[1]: Finished linger-users.service. machine # [ 68.289517] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 68.292575] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 68.548745] nixos[4025]: finished switching to system configuration /nix/store/m5a8jaiyy83wz0mxzvh5pbg1qdyqrq3j-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.92 seconds) (finished: subtest: services, in 45.37 seconds) subtest: failing units machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 68.764200] nixos[4169]: switching to system configuration /nix/store/rcd74gbcbvclm8kbhf20l2fxwyrds99l-nixos-system-machine-test machine # [ 68.766921] systemd[1]: Stopped target Remote File Systems. machine # [ 68.771410] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 68.774051] systemd[1]: Stopped instantiated@one.service. machine # [ 68.775013] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 68.775995] systemd[1]: Stopped instantiated@two.service. machine # [ 68.777429] systemd[1]: Stopped target Local File Systems. machine # [ 69.045977] systemd[1]: Reload requested from client PID 4169 ('.switch-to-conf') (unit backdoor.service)... machine # [ 69.048256] systemd[1]: Reloading... machine # [ 69.371492] systemd[1]: Reloading finished in 321 ms. machine # [ 69.462016] systemd[587]: Reexecution requested from client PID 4238 ('switch-to-confi')... machine # [ 69.465937] systemd[587]: Reexecuting. machine # [ 69.523907] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.639918] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.647882] systemd[587]: Reload requested from client PID 4238 ('switch-to-confi')... machine # [ 69.651260] systemd[587]: Reloading... machine # [ 69.757302] systemd[587]: Reloading finished in 107 ms. machine # [ 69.768183] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.778357] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 69.780909] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 69.783014] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 69.815510] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 69.819521] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 69.825232] systemd[1]: Stopping Reactivate sysinit units... machine # [ 69.826199] systemd[1]: Reached target Reactivate sysinit units. machine # [ 69.827126] systemd[1]: Reached target Local File Systems. machine # [ 69.827937] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 69.833261] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 69.834220] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 69.835553] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 69.853787] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 69.855688] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.857287] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.858616] systemd[1]: Reached target Remote File Systems. machine # [ 69.859462] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.861917] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 70.020778] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 70.022752] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.027807] systemd[1]: Starting linger-users.service... machine # [ 70.032619] systemd[1]: Starting test.service... machine # [ 70.071406] systemd[1]: Finished test.service. machine # [ 70.092362] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 70.094189] systemd[1]: Finished linger-users.service. machine # [ 70.351320] nixos[4169]: finished switching to system configuration /nix/store/rcd74gbcbvclm8kbhf20l2fxwyrds99l-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.80 seconds) machine: must fail: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 70.594961] nixos[4311]: switching to system configuration /nix/store/izb8ngcyd91nccz1sxw01y0vbvzxgp80-nixos-system-machine-test machine # [ 70.598227] systemd[1]: Stopped target Local File Systems. machine # [ 70.600683] systemd[1]: Stopped target Remote File Systems. machine # [ 70.602540] systemd[1]: test.service: Deactivated successfully. machine # [ 70.603492] systemd[1]: Stopped test.service. machine # [ 70.893310] systemd[1]: Reload requested from client PID 4311 ('.switch-to-conf') (unit backdoor.service)... machine # [ 70.895473] systemd[1]: Reloading... machine # [ 71.215690] systemd[1]: Reloading finished in 318 ms. machine # [ 71.308605] systemd[587]: Reexecution requested from client PID 4380 ('switch-to-confi')... machine # [ 71.311304] systemd[587]: Reexecuting. machine # [ 71.363577] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.472183] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.479045] systemd[587]: Reload requested from client PID 4380 ('switch-to-confi')... machine # [ 71.482803] systemd[587]: Reloading... machine # [ 71.586855] systemd[587]: Reloading finished in 105 ms. machine # [ 71.604185] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.613730] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 71.616435] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 71.618440] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 71.647854] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 71.652788] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 71.653809] systemd[1]: Stopping Reactivate sysinit units... machine # [ 71.654755] systemd[1]: Reached target Reactivate sysinit units. machine # [ 71.657573] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.661941] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 71.667786] systemd[1]: Reached target Local File Systems. machine # [ 71.671521] systemd[1]: Reached target Remote File Systems. machine # [ 71.680555] systemd[1]: Starting linger-users.service... machine # [ 71.681412] systemd[1]: Starting test.service... machine # [ 71.694294] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 71.703847] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 71.705024] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 71.706288] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 71.714396] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 71.722565] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.729974] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.749202] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 71.750786] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 71.757836] systemd[1]: Failed to start test.service. machine # [ 71.786140] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 71.791102] systemd[1]: Finished linger-users.service. machine # [ 71.923218] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 71.926396] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 72.208101] nixos[4311]: switching to system configuration /nix/store/izb8ngcyd91nccz1sxw01y0vbvzxgp80-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.86 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 72.450352] nixos[4454]: switching to system configuration /nix/store/8ddzficlbrfrizda1h2zml5h898a4grh-nixos-system-machine-test machine # [ 72.455946] systemd[1]: Stopped target Local File Systems. machine # [ 72.458709] systemd[1]: Stopped target Remote File Systems. machine # [ 72.744769] systemd[1]: Reload requested from client PID 4454 ('.switch-to-conf') (unit backdoor.service)... machine # [ 72.746806] systemd[1]: Reloading... machine # [ 73.073375] systemd[1]: Reloading finished in 325 ms. machine # [ 73.157476] systemd[587]: Reexecution requested from client PID 4523 ('switch-to-confi')... machine # [ 73.161792] systemd[587]: Reexecuting. machine # [ 73.207237] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.317449] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.324572] systemd[587]: Reload requested from client PID 4523 ('switch-to-confi')... machine # [ 73.325959] systemd[587]: Reloading... machine # [ 73.434176] systemd[587]: Reloading finished in 105 ms. machine # [ 73.449187] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.458440] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 73.461119] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 73.463637] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 73.498139] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 73.502928] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 73.505255] systemd[1]: Stopping Reactivate sysinit units... machine # [ 73.506244] systemd[1]: Reached target Reactivate sysinit units. machine # [ 73.508807] systemd[1]: Reached target Remote File Systems. machine # [ 73.512204] systemd[1]: Reached target Local File Systems. machine # [ 73.518313] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 73.526153] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 73.527300] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 73.535808] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 73.543360] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 73.545295] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.546687] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.548430] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.549855] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 73.726296] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 73.728638] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 73.734359] systemd[1]: Started autorestart.service. machine # [ 73.740466] systemd[1]: Starting linger-users.service... machine # [ 73.782119] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 73.804158] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 73.807189] systemd[1]: Finished linger-users.service. machine # [ 74.064496] nixos[4454]: finished switching to system configuration /nix/store/8ddzficlbrfrizda1h2zml5h898a4grh-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.85 seconds) machine # [ 74.106832] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 74.303637] nixos[4601]: switching to system configuration /nix/store/8ddzficlbrfrizda1h2zml5h898a4grh-nixos-system-machine-test machine # [ 74.306216] systemd[1]: Stopped target Local File Systems. machine # [ 74.309002] systemd[1]: Stopped target Remote File Systems. machine # [ 74.585405] systemd[1]: Reload requested from client PID 4601 ('.switch-to-conf') (unit backdoor.service)... machine # [ 74.587452] systemd[1]: Reloading... machine # [ 74.910986] systemd[1]: Reloading finished in 321 ms. machine # [ 74.998220] systemd[587]: Reexecution requested from client PID 4670 ('switch-to-confi')... machine # [ 75.003075] systemd[587]: Reexecuting. machine # [ 75.051654] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.162793] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.169696] systemd[587]: Reload requested from client PID 4670 ('switch-to-confi')... machine # [ 75.172356] systemd[587]: Reloading... machine # [ 75.281431] systemd[587]: Reloading finished in 108 ms. machine # [ 75.293685] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.302274] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 75.304875] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 75.307128] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 75.340127] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 75.344167] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 75.346354] systemd[1]: Stopping Reactivate sysinit units... machine # [ 75.347300] systemd[1]: Reached target Reactivate sysinit units. machine # [ 75.353987] systemd[1]: Reached target Remote File Systems. machine # [ 75.358629] systemd[1]: Started autorestart.service. machine # [ 75.365279] systemd[1]: Starting linger-users.service... machine # [ 75.366176] systemd[1]: Reached target Local File Systems. machine # [ 75.379539] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 75.387761] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 75.392990] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 75.394335] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 75.404277] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 75.406023] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.417239] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.424333] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.429857] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 75.439895] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 75.473960] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 75.477835] systemd[1]: Finished linger-users.service. machine # [ 75.603578] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 75.606947] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 75.864256] nixos[4601]: finished switching to system configuration /nix/store/8ddzficlbrfrizda1h2zml5h898a4grh-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.75 seconds) machine # [ 75.905051] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 76.123261] nixos[4748]: switching to system configuration /nix/store/vbs6waxcs99gnmckxbhr60xj8pk128a0-nixos-system-machine-test machine # [ 76.126109] systemd[1]: Stopped target Remote File Systems. machine # [ 76.128579] systemd[1]: Stopped target Local File Systems. machine # [ 76.413979] systemd[1]: Reload requested from client PID 4748 ('.switch-to-conf') (unit backdoor.service)... machine # [ 76.416429] systemd[1]: Reloading... machine # [ 76.739524] systemd[1]: Reloading finished in 321 ms. machine # [ 76.833414] systemd[587]: Reexecution requested from client PID 4817 ('switch-to-confi')... machine # [ 76.837462] systemd[587]: Reexecuting. machine # [ 76.895652] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.010851] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.018057] systemd[587]: Reload requested from client PID 4817 ('switch-to-confi')... machine # [ 77.020431] systemd[587]: Reloading... machine # [ 77.130144] systemd[587]: Reloading finished in 107 ms. machine # [ 77.144174] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.153244] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 77.155833] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 77.158146] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 77.192999] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 77.197003] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 77.199071] systemd[1]: Stopping Reactivate sysinit units... machine # [ 77.199963] systemd[1]: Reached target Reactivate sysinit units. machine # [ 77.204952] systemd[1]: Reached target Remote File Systems. machine # [ 77.208168] systemd[1]: Started autorestart.service. machine # [ 77.212319] systemd[1]: Starting linger-users.service... machine # [ 77.221000] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.222599] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 77.235274] systemd[1]: Reached target Local File Systems. machine # [ 77.242257] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 77.243922] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 77.252932] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 77.254488] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 77.268948] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 77.270870] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.282991] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.296259] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 77.297729] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 77.333776] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 77.336597] systemd[1]: Finished linger-users.service. machine # [ 77.464808] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 77.467932] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 77.747192] nixos[4748]: switching to system configuration /nix/store/vbs6waxcs99gnmckxbhr60xj8pk128a0-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.84 seconds) (finished: subtest: failing units, in 9.20 seconds) subtest: unit file parser machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 77.956356] nixos[4891]: switching to system configuration /nix/store/g4z5yys9wjkvy6hdkvy00nrgjm02yvnf-nixos-system-machine-test machine # [ 77.959506] systemd[1]: Stopped target Local File Systems. machine # [ 77.961548] systemd[1]: Stopped autorestart.service. machine # [ 77.964367] systemd[1]: Stopped target Remote File Systems. machine # [ 78.235923] systemd[1]: Reload requested from client PID 4891 ('.switch-to-conf') (unit backdoor.service)... machine # [ 78.238194] systemd[1]: Reloading... machine # [ 78.553222] systemd[1]: Reloading finished in 313 ms. machine # [ 78.643042] systemd[587]: Reexecution requested from client PID 4960 ('switch-to-confi')... machine # [ 78.645955] systemd[587]: Reexecuting. machine # [ 78.699724] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.809867] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.816485] systemd[587]: Reload requested from client PID 4960 ('switch-to-confi')... machine # [ 78.819001] systemd[587]: Reloading... machine # [ 78.925041] systemd[587]: Reloading finished in 105 ms. machine # [ 78.940173] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.949624] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 78.952096] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 78.954375] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 78.987301] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 78.991796] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 78.993285] systemd[1]: Stopping Reactivate sysinit units... machine # [ 78.994113] systemd[1]: Reached target Reactivate sysinit units. machine # [ 78.999393] systemd[1]: Reached target Local File Systems. machine # [ 79.001643] systemd[1]: Reached target Remote File Systems. machine # [ 79.005862] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.013336] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 79.014814] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 79.023430] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 79.025972] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 79.027368] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 79.029888] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 79.031597] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.032979] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.186525] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 79.189652] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 79.195510] systemd[1]: Starting linger-users.service... machine # [ 79.198636] systemd[1]: Starting test.service... machine # [ 79.235117] systemd[1]: Finished test.service. machine # [ 79.256386] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 79.259732] systemd[1]: Finished linger-users.service. machine # [ 79.514619] nixos[4891]: finished switching to system configuration /nix/store/g4z5yys9wjkvy6hdkvy00nrgjm02yvnf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.77 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 79.745589] nixos[5033]: switching to system configuration /nix/store/mhsjz9vsv5c7phfvd5q3n0zgb9lp39h1-nixos-system-machine-test machine # [ 79.749409] systemd[1]: Stopped target Remote File Systems. machine # [ 79.751705] systemd[1]: Stopped target Local File Systems. machine # [ 80.034860] systemd[1]: Reload requested from client PID 5033 ('.switch-to-conf') (unit backdoor.service)... machine # [ 80.037025] systemd[1]: Reloading... machine # [ 80.357704] systemd[1]: Reloading finished in 317 ms. machine # [ 80.448563] systemd[587]: Reexecution requested from client PID 5102 ('switch-to-confi')... machine # [ 80.451771] systemd[587]: Reexecuting. machine # [ 80.511454] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.628797] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.635974] systemd[587]: Reload requested from client PID 5102 ('switch-to-confi')... machine # [ 80.637666] systemd[587]: Reloading... machine # [ 80.743490] systemd[587]: Reloading finished in 104 ms. machine # [ 80.760179] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.769925] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 80.772448] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 80.774565] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 80.808000] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 80.812101] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 80.816731] systemd[1]: Stopping Reactivate sysinit units... machine # [ 80.817677] systemd[1]: Reached target Reactivate sysinit units. machine # [ 80.818612] systemd[1]: test.service: Deactivated successfully. machine # [ 80.819476] systemd[1]: Stopped test.service. machine # [ 80.821146] systemd[1]: Stopping test.service... machine # [ 80.822892] systemd[1]: Starting test.service... machine # [ 80.849043] systemd[1]: Finished test.service. machine # [ 80.858095] systemd[1]: Reached target Local File Systems. machine # [ 80.863760] systemd[1]: Reached target Remote File Systems. machine # [ 80.867618] systemd[1]: Starting linger-users.service... machine # [ 80.872530] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.874039] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 80.881907] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 80.887193] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 80.892491] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 80.893929] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 80.903918] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 80.906786] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.911333] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.952927] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 80.957922] systemd[1]: Finished linger-users.service. machine # [ 81.090836] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 81.093995] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 81.349673] nixos[5033]: finished switching to system configuration /nix/store/mhsjz9vsv5c7phfvd5q3n0zgb9lp39h1-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.84 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 81.582467] nixos[5175]: switching to system configuration /nix/store/cr9q9w43x7v4sfbl8dw1ffw6rm70chrx-nixos-system-machine-test machine # [ 81.585211] systemd[1]: Stopped target Remote File Systems. machine # [ 81.587703] systemd[1]: Stopped target Local File Systems. machine # [ 81.870104] systemd[1]: Reload requested from client PID 5175 ('.switch-to-conf') (unit backdoor.service)... machine # [ 81.872366] systemd[1]: Reloading... machine # [ 82.189307] systemd[1]: Reloading finished in 315 ms. machine # [ 82.278333] systemd[587]: Reexecution requested from client PID 5244 ('switch-to-confi')... machine # [ 82.282145] systemd[587]: Reexecuting. machine # [ 82.339453] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.455356] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.462582] systemd[587]: Reload requested from client PID 5244 ('switch-to-confi')... machine # [ 82.466483] systemd[587]: Reloading... machine # [ 82.572514] systemd[587]: Reloading finished in 107 ms. machine # [ 82.588187] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.598092] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 82.600586] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 82.602721] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 82.635422] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 82.639733] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 82.644702] systemd[1]: Stopping Reactivate sysinit units... machine # [ 82.645583] systemd[1]: Reached target Reactivate sysinit units. machine # [ 82.646541] systemd[1]: test.service: Deactivated successfully. machine # [ 82.647377] systemd[1]: Stopped test.service. machine # [ 82.648329] systemd[1]: Stopping test.service... machine # [ 82.650506] systemd[1]: Starting test.service... machine # [ 82.673342] systemd[1]: Finished test.service. machine # [ 82.676975] systemd[1]: Reached target Remote File Systems. machine # [ 82.680393] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.684591] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 82.688501] systemd[1]: Starting linger-users.service... machine # [ 82.699563] systemd[1]: Reached target Local File Systems. machine # [ 82.704381] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 82.713284] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 82.714286] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 82.715599] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 82.723457] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 82.728721] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.735289] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.780755] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 82.785655] systemd[1]: Finished linger-users.service. machine # [ 82.910090] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 82.913525] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 83.167425] nixos[5175]: finished switching to system configuration /nix/store/cr9q9w43x7v4sfbl8dw1ffw6rm70chrx-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.82 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 83.377769] nixos[5317]: switching to system configuration /nix/store/g4z5yys9wjkvy6hdkvy00nrgjm02yvnf-nixos-system-machine-test machine # [ 83.380387] systemd[1]: Stopped target Local File Systems. machine # [ 83.383392] systemd[1]: Stopped target Remote File Systems. machine # [ 83.649557] systemd[1]: Reload requested from client PID 5317 ('.switch-to-conf') (unit backdoor.service)... machine # [ 83.651710] systemd[1]: Reloading... machine # [ 83.957835] systemd[1]: Reloading finished in 304 ms. machine # [ 84.040434] systemd[587]: Reexecution requested from client PID 5386 ('switch-to-confi')... machine # [ 84.043941] systemd[587]: Reexecuting. machine # [ 84.099598] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.210918] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.218226] systemd[587]: Reload requested from client PID 5386 ('switch-to-confi')... machine # [ 84.219596] systemd[587]: Reloading... machine # [ 84.322470] systemd[587]: Reloading finished in 101 ms. machine # [ 84.336156] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.346758] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 84.347810] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 84.350904] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 84.374466] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 84.378441] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 84.379827] systemd[1]: Stopping Reactivate sysinit units... machine # [ 84.381345] systemd[1]: Reached target Reactivate sysinit units. machine # [ 84.384490] systemd[1]: test.service: Deactivated successfully. machine # [ 84.385407] systemd[1]: Stopped test.service. machine # [ 84.386053] systemd[1]: Stopping test.service... machine # [ 84.388863] systemd[1]: Starting test.service... machine # [ 84.412573] systemd[1]: Finished test.service. machine # [ 84.415438] systemd[1]: Reached target Remote File Systems. machine # [ 84.419068] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.422630] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 84.428825] systemd[1]: Starting linger-users.service... machine # [ 84.432254] systemd[1]: Reached target Local File Systems. machine # [ 84.442957] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 84.452240] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 84.453164] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 84.454541] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 84.461380] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 84.463173] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.471778] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.516904] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 84.520116] systemd[1]: Finished linger-users.service. machine # [ 84.644968] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 84.647968] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 84.903625] nixos[5317]: finished switching to system configuration /nix/store/g4z5yys9wjkvy6hdkvy00nrgjm02yvnf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.74 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 85.126732] nixos[5459]: switching to system configuration /nix/store/aa4rzc55mmhbghrr837lx8k55a6nqvpm-nixos-system-machine-test machine # [ 85.129473] systemd[1]: Stopped target Remote File Systems. machine # [ 85.131762] systemd[1]: Stopped target Local File Systems. machine # [ 85.403776] systemd[1]: Reload requested from client PID 5459 ('.switch-to-conf') (unit backdoor.service)... machine # [ 85.406036] systemd[1]: Reloading... machine # [ 85.720889] systemd[1]: Reloading finished in 313 ms. machine # [ 85.810854] systemd[587]: Reexecution requested from client PID 5528 ('switch-to-confi')... machine # [ 85.812907] systemd[587]: Reexecuting. machine # [ 85.859034] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.969245] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.976275] systemd[587]: Reload requested from client PID 5528 ('switch-to-confi')... machine # [ 85.977608] systemd[587]: Reloading... machine # [ 86.081489] systemd[587]: Reloading finished in 102 ms. machine # [ 86.097567] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.106073] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 86.108505] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 86.110685] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 86.143017] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 86.147212] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 86.148920] systemd[1]: Stopping Reactivate sysinit units... machine # [ 86.149768] systemd[1]: Reached target Reactivate sysinit units. machine # [ 86.152638] systemd[1]: Reached target Local File Systems. machine # [ 86.156394] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 86.160077] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 86.160959] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 86.162209] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 86.176870] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 86.178668] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.179957] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.184694] systemd[1]: Reached target Remote File Systems. machine # [ 86.185578] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.186946] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 86.339667] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 86.344817] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 86.346887] systemd[1]: Starting linger-users.service... machine # [ 86.388419] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 86.391092] systemd[1]: Finished linger-users.service. machine # [ 86.646626] nixos[5459]: finished switching to system configuration /nix/store/aa4rzc55mmhbghrr837lx8k55a6nqvpm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.74 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 86.872896] nixos[5599]: switching to system configuration /nix/store/073xg983sr5mr5jrb1fvyykwsairqk4b-nixos-system-machine-test machine # [ 86.876685] systemd[1]: Stopped target Remote File Systems. machine # [ 86.878992] systemd[1]: Stopped target Local File Systems. machine # [ 87.153963] systemd[1]: Reload requested from client PID 5599 ('.switch-to-conf') (unit backdoor.service)... machine # [ 87.155908] systemd[1]: Reloading... machine # [ 87.471046] systemd[1]: Reloading finished in 313 ms. machine # [ 87.560672] systemd[587]: Reexecution requested from client PID 5668 ('switch-to-confi')... machine # [ 87.564906] systemd[587]: Reexecuting. machine # [ 87.623389] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.736145] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.742729] systemd[587]: Reload requested from client PID 5668 ('switch-to-confi')... machine # [ 87.746319] systemd[587]: Reloading... machine # [ 87.850157] systemd[587]: Reloading finished in 104 ms. machine # [ 87.868165] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.877720] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 87.880182] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 87.882219] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 87.914498] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 87.918216] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 87.920608] systemd[1]: Stopping Reactivate sysinit units... machine # [ 87.921512] systemd[1]: Reached target Reactivate sysinit units. machine # [ 87.924784] systemd[1]: test.service: Deactivated successfully. machine # [ 87.925700] systemd[1]: Stopped test.service. machine # [ 87.926433] systemd[1]: Stopping test.service... machine # [ 87.928294] systemd[1]: Starting test.service... machine # [ 87.952139] systemd[1]: Finished test.service. machine # [ 87.955732] systemd[1]: Reached target Remote File Systems. machine # [ 87.959834] systemd[1]: Starting linger-users.service... machine # [ 87.964831] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.966217] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 87.978577] systemd[1]: Reached target Local File Systems. machine # [ 87.982899] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 87.992788] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 87.993665] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 87.994967] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 88.006866] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 88.009314] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 88.011081] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 88.045634] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 88.048917] systemd[1]: Finished linger-users.service. machine # [ 88.178025] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 88.181500] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 88.435305] nixos[5599]: finished switching to system configuration /nix/store/073xg983sr5mr5jrb1fvyykwsairqk4b-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.79 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 88.661972] nixos[5741]: switching to system configuration /nix/store/0pncfahdv1mk7nxxhjw013pj5rf63w5a-nixos-system-machine-test machine # [ 88.664969] systemd[1]: Stopped target Remote File Systems. machine # [ 88.667751] systemd[1]: Stopped target Local File Systems. machine # [ 88.943716] systemd[1]: Reload requested from client PID 5741 ('.switch-to-conf') (unit backdoor.service)... machine # [ 88.945940] systemd[1]: Reloading... machine # [ 89.282564] systemd[1]: Reloading finished in 334 ms. machine # [ 89.364431] systemd[587]: Reexecution requested from client PID 5810 ('switch-to-confi')... machine # [ 89.367955] systemd[587]: Reexecuting. machine # [ 89.415042] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.521960] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.528227] systemd[587]: Reload requested from client PID 5810 ('switch-to-confi')... machine # [ 89.531979] systemd[587]: Reloading... machine # [ 89.635062] systemd[587]: Reloading finished in 104 ms. machine # [ 89.652186] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.661437] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 89.663904] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 89.666046] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 89.699043] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 89.702691] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 89.704630] systemd[1]: Stopping Reactivate sysinit units... machine # [ 89.705532] systemd[1]: Reached target Reactivate sysinit units. machine # [ 89.708414] systemd[1]: test.service: Deactivated successfully. machine # [ 89.709331] systemd[1]: Stopped test.service. machine # [ 89.709981] systemd[1]: Stopping test.service... machine # [ 89.712955] systemd[1]: Starting test.service... machine # [ 89.736967] systemd[1]: Finished test.service. machine # [ 89.740966] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.747270] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 89.748914] systemd[1]: Reached target Remote File Systems. machine # [ 89.750527] systemd[1]: Starting linger-users.service... machine # [ 89.762156] systemd[1]: Reached target Local File Systems. machine # [ 89.766224] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 89.777132] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 89.778029] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 89.779296] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 89.790644] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 89.794154] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.795610] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.834922] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 89.838073] systemd[1]: Finished linger-users.service. machine # [ 89.975800] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 89.979680] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 90.233332] nixos[5741]: finished switching to system configuration /nix/store/0pncfahdv1mk7nxxhjw013pj5rf63w5a-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.80 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 90.459935] nixos[5883]: switching to system configuration /nix/store/1p1d4pvjrc3lk0154ismsln4fs2jjgl0-nixos-system-machine-test machine # [ 90.463156] systemd[1]: Stopped target Remote File Systems. machine # [ 90.464870] systemd[1]: Stopped target Local File Systems. machine # [ 90.745588] systemd[1]: Reload requested from client PID 5883 ('.switch-to-conf') (unit backdoor.service)... machine # [ 90.747911] systemd[1]: Reloading... machine # [ 91.079384] systemd[1]: Reloading finished in 330 ms. machine # [ 91.165470] systemd[587]: Reexecution requested from client PID 5952 ('switch-to-confi')... machine # [ 91.169753] systemd[587]: Reexecuting. machine # [ 91.227573] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.341845] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.349169] systemd[587]: Reload requested from client PID 5952 ('switch-to-confi')... machine # [ 91.350676] systemd[587]: Reloading... machine # [ 91.455252] systemd[587]: Reloading finished in 103 ms. machine # [ 91.472161] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.482441] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 91.484785] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 91.486918] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 91.518121] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 91.522111] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 91.526688] systemd[1]: Stopping Reactivate sysinit units... machine # [ 91.527552] systemd[1]: Reached target Reactivate sysinit units. machine # [ 91.529566] systemd[1]: test.service: Deactivated successfully. machine # [ 91.530476] systemd[1]: Stopped test.service. machine # [ 91.531102] systemd[1]: Stopping test.service... machine # [ 91.531755] systemd[1]: Starting test.service... machine # [ 91.555831] systemd[1]: Finished test.service. machine # [ 91.560776] systemd[1]: Reached target Remote File Systems. machine # [ 91.563788] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.568186] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 91.569527] systemd[1]: Reached target Local File Systems. machine # [ 91.570350] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 91.575012] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 91.575881] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 91.586946] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 91.591482] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 91.593385] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.594697] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.744469] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 91.748575] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 91.751506] systemd[1]: Starting linger-users.service... machine # [ 91.791924] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 91.793981] systemd[1]: Finished linger-users.service. machine # [ 92.049945] nixos[5883]: finished switching to system configuration /nix/store/1p1d4pvjrc3lk0154ismsln4fs2jjgl0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 1.82 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 92.259387] nixos[6025]: switching to system configuration /nix/store/g4z5yys9wjkvy6hdkvy00nrgjm02yvnf-nixos-system-machine-test machine # [ 92.261942] systemd[1]: Stopped target Remote File Systems. machine # [ 92.264259] systemd[1]: Stopped target Local File Systems. machine # [ 92.520203] systemd[1]: Reload requested from client PID 6025 ('.switch-to-conf') (unit backdoor.service)... machine # [ 92.521798] systemd[1]: Reloading... machine # [ 92.822309] systemd[1]: Reloading finished in 298 ms. machine # [ 92.908131] systemd[587]: Reexecution requested from client PID 6094 ('switch-to-confi')... machine # [ 92.912063] systemd[587]: Reexecuting. machine # [ 92.967204] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.077197] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.083491] systemd[587]: Reload requested from client PID 6094 ('switch-to-confi')... machine # [ 93.087156] systemd[587]: Reloading... machine # [ 93.189483] systemd[587]: Reloading finished in 103 ms. machine # [ 93.204159] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.213503] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 93.215814] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 93.218042] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 93.246595] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 93.250203] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 93.252525] systemd[1]: Stopping Reactivate sysinit units... machine # [ 93.253433] systemd[1]: Reached target Reactivate sysinit units. machine # [ 93.256757] systemd[1]: test.service: Deactivated successfully. machine # [ 93.257658] systemd[1]: Stopped test.service. machine # [ 93.258317] systemd[1]: Stopping test.service... machine # [ 93.260256] systemd[1]: Starting test.service... machine # [ 93.283680] systemd[1]: Finished test.service. machine # [ 93.286557] systemd[1]: Reached target Remote File Systems. machine # [ 93.290425] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.294704] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 93.296599] systemd[1]: Reached target Local File Systems. machine # [ 93.298621] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 93.306182] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 93.307052] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 93.313432] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 93.315694] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 93.320339] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.321656] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.473785] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 93.478013] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 93.480355] systemd[1]: Starting linger-users.service... machine # [ 93.519017] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 93.521996] systemd[1]: Finished linger-users.service. machine # [ 93.775921] nixos[6025]: finished switching to system configuration /nix/store/g4z5yys9wjkvy6hdkvy00nrgjm02yvnf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.73 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 93.995998] nixos[6167]: switching to system configuration /nix/store/5yx3wfb1rd5vfr6107xf8b284a9l1cal-nixos-system-machine-test machine # [ 93.999048] systemd[1]: Stopped target Local File Systems. machine # [ 94.001197] systemd[1]: Stopped target Remote File Systems. machine # [ 94.272605] systemd[1]: Reload requested from client PID 6167 ('.switch-to-conf') (unit backdoor.service)... machine # [ 94.274606] systemd[1]: Reloading... machine # [ 94.586191] systemd[1]: Reloading finished in 310 ms. machine # [ 94.674244] systemd[587]: Reexecution requested from client PID 6236 ('switch-to-confi')... machine # [ 94.675681] systemd[587]: Reexecuting. machine # [ 94.735497] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.847369] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.854057] systemd[587]: Reload requested from client PID 6236 ('switch-to-confi')... machine # [ 94.857778] systemd[587]: Reloading... machine # [ 94.961214] systemd[587]: Reloading finished in 103 ms. machine # [ 94.976174] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.985668] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 94.987968] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 94.990313] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 95.023352] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 95.027660] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 95.032545] systemd[1]: Stopping Reactivate sysinit units... machine # [ 95.033466] systemd[1]: Reached target Reactivate sysinit units. machine # [ 95.035738] systemd[1]: Reloading test.service... machine # [ 95.062171] systemd[1]: Reloaded test.service. machine # [ 95.066807] systemd[1]: Reached target Remote File Systems. machine # [ 95.071834] systemd[1]: Starting linger-users.service... machine # [ 95.078847] systemd[1]: Reached target Local File Systems. machine # [ 95.079756] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 95.096277] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 95.097256] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 95.098630] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 95.108344] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 95.110068] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.111469] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.112847] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.114207] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 95.170361] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 95.175369] systemd[1]: Finished linger-users.service. machine # [ 95.299013] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 95.301786] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 95.558077] nixos[6167]: finished switching to system configuration /nix/store/5yx3wfb1rd5vfr6107xf8b284a9l1cal-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.78 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 95.783253] nixos[6309]: switching to system configuration /nix/store/0gngmrrrdpinb7sh5k2vs91g078h3d0n-nixos-system-machine-test machine # [ 95.785791] systemd[1]: Stopped target Local File Systems. machine # [ 95.788208] systemd[1]: Stopped target Remote File Systems. machine # [ 96.057115] systemd[1]: Reload requested from client PID 6309 ('.switch-to-conf') (unit backdoor.service)... machine # [ 96.059124] systemd[1]: Reloading... machine # [ 96.365966] systemd[1]: Reloading finished in 305 ms. machine # [ 96.452434] systemd[587]: Reexecution requested from client PID 6378 ('switch-to-confi')... machine # [ 96.456777] systemd[587]: Reexecuting. machine # [ 96.515321] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.627611] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.634492] systemd[587]: Reload requested from client PID 6378 ('switch-to-confi')... machine # [ 96.636815] systemd[587]: Reloading... machine # [ 96.738731] systemd[587]: Reloading finished in 100 ms. machine # [ 96.756164] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.766370] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 96.768717] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 96.770754] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 96.802732] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 96.805989] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 96.807872] systemd[1]: Stopping Reactivate sysinit units... machine # [ 96.811136] systemd[1]: Reached target Reactivate sysinit units. machine # [ 96.813278] systemd[1]: Reloading test.service... machine # [ 96.835677] systemd[1]: Reloaded test.service. machine # [ 96.840812] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.845117] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 96.846550] systemd[1]: Reached target Remote File Systems. machine # [ 96.848081] systemd[1]: Reached target Local File Systems. machine # [ 96.851608] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 96.860192] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 96.861099] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 96.862415] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 96.869900] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 96.871629] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.873065] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 97.020351] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 97.024417] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 97.026394] systemd[1]: Starting linger-users.service... machine # [ 97.063048] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 97.066172] systemd[1]: Finished linger-users.service. machine # [ 97.319928] nixos[6309]: finished switching to system configuration /nix/store/0gngmrrrdpinb7sh5k2vs91g078h3d0n-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.76 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 97.538670] nixos[6451]: switching to system configuration /nix/store/r5qp6l52kw6jg6yrrnskgjjjsv9qv6c4-nixos-system-machine-test machine # [ 97.541164] systemd[1]: Stopped target Remote File Systems. machine # [ 97.543429] systemd[1]: Stopped target Local File Systems. machine # [ 97.812397] systemd[1]: Reload requested from client PID 6451 ('.switch-to-conf') (unit backdoor.service)... machine # [ 97.814464] systemd[1]: Reloading... machine # [ 98.120400] systemd[1]: Reloading finished in 304 ms. machine # [ 98.201657] systemd[587]: Reexecution requested from client PID 6520 ('switch-to-confi')... machine # [ 98.206372] systemd[587]: Reexecuting. machine # [ 98.263304] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.373328] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.379786] systemd[587]: Reload requested from client PID 6520 ('switch-to-confi')... machine # [ 98.382290] systemd[587]: Reloading... machine # [ 98.485331] systemd[587]: Reloading finished in 102 ms. machine # [ 98.500164] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.509633] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 98.511987] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 98.514043] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 98.542129] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 98.546048] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 98.547047] systemd[1]: Stopping Reactivate sysinit units... machine # [ 98.547846] systemd[1]: Reached target Reactivate sysinit units. machine # [ 98.552362] systemd[1]: test.service: Deactivated successfully. machine # [ 98.553302] systemd[1]: Stopped test.service. machine # [ 98.553947] systemd[1]: Stopping test.service... machine # [ 98.555831] systemd[1]: Starting test.service... machine # [ 98.580346] systemd[1]: Finished test.service. machine # [ 98.586032] systemd[1]: Reached target Local File Systems. machine # [ 98.589378] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 98.591719] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 98.596318] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 98.597643] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 98.599940] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 98.613560] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.614977] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.618667] systemd[1]: Reached target Remote File Systems. machine # [ 98.620351] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.623369] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 98.768250] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 98.770095] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 98.774794] systemd[1]: Starting linger-users.service... machine # [ 98.817078] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 98.819625] systemd[1]: Finished linger-users.service. machine # [ 99.075170] nixos[6451]: finished switching to system configuration /nix/store/r5qp6l52kw6jg6yrrnskgjjjsv9qv6c4-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.76 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 99.278744] nixos[6593]: switching to system configuration /nix/store/073xg983sr5mr5jrb1fvyykwsairqk4b-nixos-system-machine-test machine # [ 99.283852] systemd[1]: Stopped target Remote File Systems. machine # [ 99.286261] systemd[1]: Stopped target Local File Systems. machine # [ 99.538711] systemd[1]: Reload requested from client PID 6593 ('.switch-to-conf') (unit backdoor.service)... machine # [ 99.540743] systemd[1]: Reloading... machine # [ 99.836238] systemd[1]: Reloading finished in 294 ms. machine # [ 99.920395] systemd[587]: Reexecution requested from client PID 6662 ('switch-to-confi')... machine # [ 99.923166] systemd[587]: Reexecuting. machine # [ 99.979541] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 100.089240] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 100.095634] systemd[587]: Reload requested from client PID 6662 ('switch-to-confi')... machine # [ 100.099284] systemd[587]: Reloading... machine # [ 100.201601] systemd[587]: Reloading finished in 103 ms. machine # [ 100.216146] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 100.225241] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 100.227335] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 100.229286] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 100.257483] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 100.261086] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 100.263019] systemd[1]: Stopping Reactivate sysinit units... machine # [ 100.263897] systemd[1]: Reached target Reactivate sysinit units. machine # [ 100.270603] systemd[1]: Reached target Local File Systems. machine # [ 100.273589] systemd[1]: Reached target Remote File Systems. machine # [ 100.275612] systemd[1]: Starting linger-users.service... machine # [ 100.281068] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 100.296789] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 100.297700] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 100.298969] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 100.301813] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 100.303469] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 100.304843] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 100.306057] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 100.307369] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 100.359071] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 100.362586] systemd[1]: Finished linger-users.service. machine # [ 100.481120] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 100.484522] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 100.738695] nixos[6593]: finished switching to system configuration /nix/store/073xg983sr5mr5jrb1fvyykwsairqk4b-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.66 seconds) (finished: subtest: unit file parser, in 22.99 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 100.943782] nixos[6733]: switching to system configuration /nix/store/d6fzs56x0w5gcby739vjjaddab4izqsp-nixos-system-machine-test machine # [ 100.948845] systemd[1]: Stopped target Local File Systems. machine # [ 100.949708] systemd[1]: Stopped target Remote File Systems. machine # [ 101.199102] systemd[1]: Reload requested from client PID 6733 ('.switch-to-conf') (unit backdoor.service)... machine # [ 101.201238] systemd[1]: Reloading... machine # [ 101.495804] systemd[1]: Reloading finished in 292 ms. machine # [ 101.583049] systemd[587]: Reexecution requested from client PID 6802 ('switch-to-confi')... machine # [ 101.585546] systemd[587]: Reexecuting. machine # [ 101.647473] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.759174] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.765546] systemd[587]: Reload requested from client PID 6802 ('switch-to-confi')... machine # [ 101.767847] systemd[587]: Reloading... machine # [ 101.869273] systemd[587]: Reloading finished in 100 ms. machine # [ 101.884140] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.893872] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 101.896068] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 101.898022] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 101.925105] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 101.928585] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 101.930467] systemd[1]: Stopping Reactivate sysinit units... machine # [ 101.931309] systemd[1]: Reached target Reactivate sysinit units. machine # [ 101.935310] systemd[1]: Reached target Remote File Systems. machine # [ 101.938579] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.939906] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 101.944976] systemd[1]: Reached target Local File Systems. machine # [ 101.945840] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 101.950449] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 101.951332] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 101.959829] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 101.963738] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 101.965598] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.966942] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 102.115985] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 102.118702] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 102.122682] systemd[1]: Starting linger-users.service... machine # [ 102.157938] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 102.160899] systemd[1]: Finished linger-users.service. machine # [ 102.414799] nixos[6733]: finished switching to system configuration /nix/store/d6fzs56x0w5gcby739vjjaddab4izqsp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.68 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 102.635197] nixos[6873]: switching to system configuration /nix/store/an390vh09m6hwcmhiqvf7pxzzky7x2ax-nixos-system-machine-test machine # [ 102.637952] systemd[1]: test.service: Deactivated successfully. machine # [ 102.641561] systemd[1]: Stopped test.service. machine # [ 102.642871] systemd[1]: Stopped target Local File Systems. machine # [ 102.643675] systemd[1]: Stopped target Remote File Systems. machine # [ 102.916808] systemd[1]: Reload requested from client PID 6873 ('.switch-to-conf') (unit backdoor.service)... machine # [ 102.919068] systemd[1]: Reloading... machine # [ 103.231028] systemd[1]: Reloading finished in 310 ms. machine # [ 103.317778] systemd[587]: Reexecution requested from client PID 6944 ('switch-to-confi')... machine # [ 103.319242] systemd[587]: Reexecuting. machine # [ 103.379266] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.491691] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.498243] systemd[587]: Reload requested from client PID 6944 ('switch-to-confi')... machine # [ 103.500737] systemd[587]: Reloading... machine # [ 103.605972] systemd[587]: Reloading finished in 104 ms. machine # [ 103.620212] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.630064] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 103.632735] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 103.635164] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 103.667675] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 103.672412] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 103.673359] systemd[1]: Stopping Reactivate sysinit units... machine # [ 103.674204] systemd[1]: Reached target Reactivate sysinit units. machine # [ 103.681286] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 103.685182] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 103.695906] systemd[1]: Starting simple-service.service... machine # [ 103.706976] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 103.713632] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 103.714698] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 103.715828] systemd[1]: Reached target Remote File Systems. machine # [ 103.721190] systemd[1]: Starting linger-users.service... machine # [ 103.736238] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 103.737273] systemd[1]: Starting reload-triggers.service... machine # [ 103.738083] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 103.739230] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 103.787195] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 103.806022] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 103.807182] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 103.840344] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 103.853141] systemd[1]: Reached target Local File Systems. machine # [ 103.878496] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 103.909861] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 103.910930] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 103.914110] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 103.917188] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 103.918958] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.922945] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.926931] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.931292] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 103.944679] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 103.945778] systemd[1]: Finished simple-service.service. machine # [ 103.946556] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 103.947718] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 103.980793] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 103.982052] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 103.983027] systemd[1]: Finished reload-triggers.service. machine # [ 103.983779] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 103.997066] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 103.998342] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 103.999320] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 104.017506] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 104.020227] systemd[1]: Finished linger-users.service. machine # [ 104.145341] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 104.149833] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 104.152175] systemd[1]: Starting no-restart-service.service... machine # [ 104.156511] systemd[1]: Starting simple-reload-service.service... machine # [ 104.160311] systemd[1]: Starting simple-restart-service.service... machine # [ 104.175127] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 104.182710] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 104.239393] systemd[1]: Finished simple-reload-service.service. machine # [ 104.242880] systemd[1]: Finished simple-restart-service.service. machine # [ 104.245847] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 104.247001] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 104.251003] systemd[1]: Finished no-restart-service.service. machine # [ 104.508426] nixos[6873]: finished switching to system configuration /nix/store/an390vh09m6hwcmhiqvf7pxzzky7x2ax-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.09 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 104.747924] nixos[7043]: switching to system configuration /nix/store/an390vh09m6hwcmhiqvf7pxzzky7x2ax-nixos-system-machine-test machine # [ 104.750941] systemd[1]: Stopped target Local File Systems. machine # [ 104.753979] systemd[1]: Stopped target Remote File Systems. machine # [ 105.032659] systemd[1]: Reload requested from client PID 7043 ('.switch-to-conf') (unit backdoor.service)... machine # [ 105.034854] systemd[1]: Reloading... machine # [ 105.346013] systemd[1]: Reloading finished in 310 ms. machine # [ 105.432411] systemd[587]: Reexecution requested from client PID 7114 ('switch-to-confi')... machine # [ 105.435490] systemd[587]: Reexecuting. machine # [ 105.495198] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.602998] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.609266] systemd[587]: Reload requested from client PID 7114 ('switch-to-confi')... machine # [ 105.611450] systemd[587]: Reloading... machine # [ 105.713052] systemd[587]: Reloading finished in 100 ms. machine # [ 105.728146] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.737316] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 105.739462] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 105.741301] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 105.769711] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 105.773624] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 105.776693] systemd[1]: Stopping Reactivate sysinit units... machine # [ 105.777558] systemd[1]: Reached target Reactivate sysinit units. machine # [ 105.782038] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 105.792874] systemd[1]: Reloading reload-triggers.service... machine # [ 105.793771] systemd[1]: Reloading simple-reload-service.service... machine # [ 105.808462] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 105.814296] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 105.824766] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 105.881794] systemd[1]: Reloaded reload-triggers.service. machine # [ 105.889403] systemd[1]: Reloaded simple-reload-service.service. machine # [ 105.890396] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 105.891473] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 105.896352] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 105.901899] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 105.904350] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 105.905541] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 105.906579] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 105.916813] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 105.917850] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 105.918965] systemd[1]: Stopped simple-restart-service.service. machine # [ 105.919789] systemd[1]: Stopping simple-restart-service.service... machine # [ 105.928496] systemd[1]: Starting simple-restart-service.service... machine # [ 105.929396] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 105.930388] systemd[1]: Stopped simple-service.service. machine # [ 105.931138] systemd[1]: Stopping simple-service.service... machine # [ 105.931915] systemd[1]: Starting simple-service.service... machine # [ 105.952218] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 105.953717] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 105.954894] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 105.972474] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 105.973733] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 105.992654] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 106.003246] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 106.011168] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 106.014231] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 106.015523] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 106.023249] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 106.027682] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 106.032875] systemd[1]: Finished simple-restart-service.service. machine # [ 106.033751] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 106.034717] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 106.035753] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 106.041525] systemd[1]: Finished simple-service.service. machine # [ 106.045734] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 106.048661] systemd[1]: Reached target Local File Systems. machine # [ 106.051013] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 106.057009] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 106.058364] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 106.062243] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 106.063144] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 106.072457] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 106.074750] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 106.079113] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 106.082309] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 106.083544] systemd[1]: Reached target Remote File Systems. machine # [ 106.224083] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 106.228539] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 106.230915] systemd[1]: Starting linger-users.service... machine # [ 106.270715] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 106.273679] systemd[1]: Finished linger-users.service. machine # [ 106.527963] nixos[7043]: finished switching to system configuration /nix/store/an390vh09m6hwcmhiqvf7pxzzky7x2ax-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.02 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 106.790312] nixos[7209]: switching to system configuration /nix/store/wnnxgcsn4f80pidnb5xznhfc4nzzcmj0-nixos-system-machine-test machine # [ 106.793020] systemd[1]: Stopped target Remote File Systems. machine # [ 106.795259] systemd[1]: Stopped target Local File Systems. machine # [ 107.079945] systemd[1]: Reload requested from client PID 7209 ('.switch-to-conf') (unit backdoor.service)... machine # [ 107.082210] systemd[1]: Reloading... machine # [ 107.401365] systemd[1]: Reloading finished in 318 ms. machine # [ 107.487139] systemd[587]: Reexecution requested from client PID 7280 ('switch-to-confi')... machine # [ 107.489718] systemd[587]: Reexecuting. machine # [ 107.547024] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.659047] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.665825] systemd[587]: Reload requested from client PID 7280 ('switch-to-confi')... machine # [ 107.667145] systemd[587]: Reloading... machine # [ 107.767401] systemd[587]: Reloading finished in 98 ms. machine # [ 107.784138] systemd[587]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.793685] systemd[587]: Stopped Run user-specific NixOS activation. machine # [ 107.795904] systemd[587]: Stopping Run user-specific NixOS activation... machine # [ 107.798172] systemd[587]: Starting Run user-specific NixOS activation... machine # [ 107.824992] systemd[587]: Finished Run user-specific NixOS activation. machine # [ 107.828757] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 107.833564] systemd[1]: Stopping Reactivate sysinit units... machine # [ 107.834438] systemd[1]: Reached target Reactivate sysinit units. machine # [ 107.836295] systemd[1]: Reloading reload-triggers.service... machine # [ 107.844396] systemd[1]: Reloading simple-reload-service.service... machine # [ 107.854604] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 107.860566] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 107.909064] systemd[1]: Reloaded simple-reload-service.service. machine # [ 107.913281] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 107.915745] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 107.919908] systemd[1]: Reloaded reload-triggers.service. machine # [ 107.922862] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 107.926189] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 107.927680] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 107.930402] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 107.940907] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 107.942051] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 107.943016] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 107.943960] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 107.952695] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 107.953754] systemd[1]: Stopped simple-restart-service.service. machine # [ 107.954603] systemd[1]: Stopping simple-restart-service.service... machine # [ 107.955453] systemd[1]: Starting simple-restart-service.service... machine # [ 107.992633] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 107.993653] systemd[1]: Stopped simple-service.service. machine # [ 108.010173] systemd[1]: Stopping simple-service.service... machine # [ 108.015540] systemd[1]: Starting simple-service.service... machine # [ 108.026675] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 108.046967] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 108.057746] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 108.068151] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 108.079498] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 108.089615] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 108.090814] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 108.091934] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 108.096561] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 108.097841] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 108.098934] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 108.099990] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 108.102401] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 108.103543] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 108.118230] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 108.119278] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 108.127253] systemd[1]: Finished simple-restart-service.service. machine # [ 108.128432] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 108.130155] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 108.131124] systemd[1]: Finished simple-service.service. machine # [ 108.131882] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 108.133199] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 108.134346] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 108.135378] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 108.136681] systemd[1]: Reached target Local File Systems. machine # [ 108.137495] systemd[1]: Reached target Remote File Systems. machine # [ 108.139006] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 108.141535] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 108.143140] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 108.145121] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 108.149411] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 108.151126] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.154997] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.156422] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.157723] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 108.292872] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 108.294724] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 108.299246] systemd[1]: Starting linger-users.service... machine # [ 108.339602] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 108.342848] systemd[1]: Finished linger-users.service. machine # [ 108.597778] nixos[7209]: finished switching to system configuration /nix/store/wnnxgcsn4f80pidnb5xznhfc4nzzcmj0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.07 seconds) machine: must succeed: /nix/store/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-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/akvr53m0hrpqz5ghxvx1y4qmb0ngp26k-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.33 seconds) (finished: subtest: restart and reload by activation script, in 8.19 seconds) (finished: run the VM test script, in 109.66 seconds) test script finished in 109.69s cleanup kill QemuMachine (pid 45) machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lq2fsnmg0q3y0vlxn91w8s8wvj1m6fld-python3-3.14.8/bin/python3.14) machine # [2026-10-20T03:09:56Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-20T03:09:56Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-20T03:09:56Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.16 seconds) additionally exposed symbols: machine, other, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh