tribuchet: building on eliza Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script machine: waiting for unit multi-user.target machine: waiting for the VM to finish booting machine: starting vm machine # Disk image does not exist, creating the virtualisation disk image... machine: QEMU running (pid 45) machine # Formatting '/build/vm-state-machine/tmp.aRzk3bGSWo', fmt=raw size=1073741824 machine # mke2fs 1.47.4 (6-Mar-2025) machine # Discarding device blocks: 0/262144 done machine # Creating filesystem with 262144 4k blocks and 65536 inodes machine # Filesystem UUID: 583bfa1a-fad7-47de-9140-654c1f7ef1dd machine # Superblock backups stored on blocks: machine # 32768, 98304, 163840, 229376 machine # machine # Allocating group tables: 0/8 done machine # Writing inode tables: 0/8 done machine # Creating journal (8192 blocks): done machine # Writing superblocks and filesystem accounting information: 0/8 done machine # machine # Virtualisation disk image created. machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.50 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 7 15:23:00 UTC 2026 machine # [ 0.000000] KASLR enabled machine # [ 0.000000] random: crng init done machine # [ 0.000000] Machine model: linux,dummy-virt machine # [ 0.000000] efi: UEFI not found. machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f] machine # [ 0.000000] Zone ranges: machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] DMA32 empty machine # [ 0.000000] Normal empty machine # [ 0.000000] Device empty machine # [ 0.000000] Movable zone start for each node machine # [ 0.000000] Early memory node ranges machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000 machine # [ 0.000000] psci: probing for conduit method from DT. machine # [ 0.000000] psci: PSCIv1.3 detected in firmware. machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs machine # [ 0.000000] psci: Trusted OS migration not required machine # [ 0.000000] psci: SMC Calling Convention v1.1 machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296 machine # [ 0.000000] Detected PIPT I-cache on CPU0 machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) machine # [ 0.000000] CPU features: detected: GICv3 CPU interface machine # [ 0.000000] CPU features: detected: Spectre-v4 machine # [ 0.000000] CPU features: detected: Spectre-BHB machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 machine # [ 0.000000] alternatives: applying boot alternatives machine # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/init regInfo=/nix/store/6qx1r7b12w7154w32l22wllgqwx08db9-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/6qx1r7b12w7154w32l22wllgqwx08db9-closure-info/registration", will be passed to user space. machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB machine # [ 0.000000] software IO TLB: area num 1. machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB) machine # [ 0.000000] Fallback order for Node 0: 0 machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 machine # [ 0.000000] Policy zone: DMA machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.000000] allocated 2097152 bytes of page_ext machine # [ 0.000000] ftrace: allocating 74885 entries in 294 pages machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups machine # [ 0.000000] rcu: Hierarchical RCU implementation. machine # [ 0.000000] rcu: RCU event tracing is enabled. machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. machine # [ 0.000000] Rude variant of Tasks RCU enabled. machine # [ 0.000000] Tracing variant of Tasks RCU enabled. machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 machine # [ 0.000000] GICv3: 256 SPIs implemented machine # [ 0.000000] GICv3: 0 Extended SPIs implemented machine # [ 0.000000] Root IRQ handler: gic_handle_irq machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1) machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1) machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000 machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns machine # [ 0.000033] arm-pv: using stolen time PV machine # [ 0.000418] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000590] Console: colour dummy device 80x25 machine # [ 0.000604] printk: legacy console [tty0] enabled machine # [ 0.000843] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000850] pid_max: default: 32768 minimum: 301 machine # [ 0.000937] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.001061] landlock: Up and running. machine # [ 0.001063] Yama: becoming mindful. machine # [ 0.001529] LSM support for eBPF active machine # [ 0.001654] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.001675] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.002824] cacheinfo: Unable to detect cache hierarchy for CPU 0 machine # [ 0.003536] rcu: Hierarchical SRCU implementation. machine # [ 0.003540] rcu: Max phase no-delay instances is 1000. machine # [ 0.004787] fsl-mc MSI: its@8080000 domain created machine # [ 0.004882] EFI services will not be available. machine # [ 0.004948] smp: Bringing up secondary CPUs ... machine # [ 0.004956] smp: Brought up 1 node, 1 CPU machine # [ 0.004960] SMP: Total of 1 processors activated. machine # [ 0.004962] CPU: All CPU(s) started at EL1 machine # [ 0.004984] CPU features: detected: Branch Target Identification machine # [ 0.004990] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.004993] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.004997] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.005000] CPU features: detected: Common not Private translations machine # [ 0.005003] CPU features: detected: CRC32 instructions machine # [ 0.005006] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.005010] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.005013] CPU features: detected: Data independent timing control (DIT) machine # [ 0.005016] CPU features: detected: E0PD machine # [ 0.005019] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.005022] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.005025] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.005028] CPU features: detected: Fine Grained Traps machine # [ 0.005031] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.005036] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.005038] CPU features: detected: LSE atomic instructions machine # [ 0.005041] CPU features: detected: Privileged Access Never machine # [ 0.005044] CPU features: detected: PMUv3 machine # [ 0.005047] CPU features: detected: RAS Extension Support machine # [ 0.005049] CPU features: detected: RASv1p1 Extension Support machine # [ 0.005052] CPU features: detected: Random Number Generator machine # [ 0.005054] CPU features: detected: Speculation barrier (SB) machine # [ 0.005057] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.005059] CPU features: detected: TLB range maintenance instructions machine # [ 0.005064] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.005100] alternatives: applying system-wide alternatives machine # [ 0.008245] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.008500] Memory: 894224K/1048576K available (24448K kernel code, 7090K rwdata, 26348K rodata, 4736K init, 1107K bss, 113068K reserved, 32768K cma-reserved) machine # [ 0.008885] devtmpfs: initialized machine # [ 0.010666] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.010689] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.010885] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.010890] 0 pages in range for non-PLT usage machine # [ 0.010890] 508288 pages in range for PLT usage machine # [ 0.011003] pinctrl core: initialized pinctrl subsystem machine # [ 0.011761] DMI not present or invalid. machine # [ 0.014979] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.018029] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.018183] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.018378] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.018408] audit: initializing netlink subsys (disabled) machine # [ 0.019032] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.019034] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.019038] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.019041] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.019046] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.019078] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 machine # [ 0.019086] cpuidle: using governor ladder machine # [ 0.019092] cpuidle: using governor menu machine # [ 0.019314] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.019475] ASID allocator initialised with 65536 entries machine # [ 0.020660] Serial: AMBA PL011 UART driver machine # [ 0.026202] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.026370] printk: console [ttyAMA0] enabled machine # [ 0.150266] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.150288] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.150293] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.150297] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.150302] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.150306] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.150310] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.150314] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.158153] fbcon: Taking over console machine # [ 0.158175] ACPI: Interpreter disabled. machine # [ 0.166709] iommu: Default domain type: Translated machine # [ 0.166720] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.167399] SCSI subsystem initialized machine # [ 0.169477] usbcore: registered new interface driver usbfs machine # [ 0.169509] usbcore: registered new interface driver hub machine # [ 0.169534] usbcore: registered new device driver usb machine # [ 0.169835] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.169841] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.169850] PTP clock support registered machine # [ 0.169900] EDAC MC: Ver: 3.0.0 machine # [ 0.174618] scmi_core: SCMI protocol bus registered machine # [ 0.175673] FPGA manager framework machine # [ 0.176710] vgaarb: loaded machine # [ 0.177384] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.181665] VFS: Disk quotas dquot_6.6.0 machine # [ 0.181711] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.185564] netfs: FS-Cache loaded machine # [ 0.185693] pnp: PnP ACPI: disabled machine # [ 0.189817] NET: Registered PF_INET protocol family machine # [ 0.189979] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.220387] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.220445] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.220471] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.220521] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.220597] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.220683] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.220714] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.220739] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.220848] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.220869] NET: Registered PF_XDP protocol family machine # [ 0.220891] PCI: CLS 0 bytes, default 64 machine # [ 0.221134] Trying to unpack rootfs image as initramfs... machine # [ 0.239240] kvm [1]: HYP mode not available machine # [ 0.346010] Initialise system trusted keyrings machine # [ 0.346809] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.348114] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.348934] 9p: Installing v9fs 9p2000 file system support machine # [ 0.377721] Key type asymmetric registered machine # [ 0.377758] Asymmetric key parser 'x509' registered machine # [ 0.377846] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.380068] io scheduler mq-deadline registered machine # [ 0.380081] io scheduler kyber registered machine # [ 0.389579] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.391146] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.391541] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.391558] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.391571] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.391580] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.391602] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.391628] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.391707] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.391717] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.391723] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.391729] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.391734] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.391800] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.392265] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.392459] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.392477] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.392511] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.392528] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.393028] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.393219] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.393236] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.393268] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.413739] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.413933] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.413949] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.413982] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.414455] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.414643] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.414659] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.414689] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.415158] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.415348] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.415366] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.415398] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.415863] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.416059] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.416075] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.416105] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.416576] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.416783] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.416800] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.416830] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.416850] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.417330] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.441642] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.441700] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.442239] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.442436] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.442466] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.442861] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.443049] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.443300] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.443630] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.443648] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.443679] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.444156] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.444342] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.444358] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.444394] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.445033] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.445045] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.445051] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.445098] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.445147] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.445195] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.445243] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.445291] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.445339] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.445409] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.445456] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.445511] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.445579] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.445661] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.445686] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.445707] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.445731] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.445754] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.445780] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.445804] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.445827] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.445850] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.445872] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.445895] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.445918] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.445943] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.445966] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.445988] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned machine # [ 0.446010] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.446033] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.446059] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned machine # [ 0.446085] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned machine # [ 0.446108] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned machine # [ 0.446131] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned machine # [ 0.446159] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.446169] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.446174] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.447390] pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.520108] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.526589] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.528649] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.538892] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.541147] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) machine # [ 0.551916] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) machine # [ 0.558052] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) machine # [ 0.560265] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.570391] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.572461] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.584377] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.594853] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.602753] msm_serial: driver initialized machine # [ 0.602909] SuperH (H)SCI(F) driver initialized machine # [ 0.602963] STM32 USART driver initialized machine # [ 0.634836] loop: module loaded machine # [ 0.635062] virtio_blk virtio5: 1/0/0 default/read/poll queues machine # [ 0.635865] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.646173] megasas: 07.734.00.00-rc1 machine # [ 0.646956] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.657491] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.657530] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.659383] Using buffer write method machine # [ 0.659493] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.661486] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.661513] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.663309] Using buffer write method machine # [ 0.663347] Concatenating MTD devices: machine # [ 0.663352] (0): "0.flash" machine # [ 0.663356] (1): "0.flash" machine # [ 0.663359] into device "0.flash" machine # [ 0.973998] Freeing initrd memory: 26208K machine # [ 0.980574] tun: Universal TUN/TAP device driver, 1.6 machine # [ 0.984780] thunder_xcv, ver 1.0 machine # [ 0.984828] thunder_bgx, ver 1.0 machine # [ 0.984851] nicpf, ver 1.0 machine # [ 0.986596] e1000: Intel(R) PRO/1000 Network Driver machine # [ 0.986607] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 0.986646] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 0.986656] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 0.986681] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 0.986686] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 0.986709] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 0.986715] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 0.986861] sky2: driver version 1.30 machine # [ 0.988536] usbcore: registered new interface driver usb-storage machine # [ 0.988594] usbcore: registered new interface driver usbserial_generic machine # [ 0.988610] usbserial: USB Serial support registered for generic machine # [ 0.989327] hv_vmbus: registering driver hyperv_keyboard machine # [ 0.990187] ehci-pci 0000:00:0a.0: EHCI Host Controller machine # [ 0.990223] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 machine # [ 0.990495] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 machine # [ 1.002097] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 machine # [ 1.002475] hub 1-0:1.0: USB hub found machine # [ 1.002492] hub 1-0:1.0: 6 ports detected machine # [ 1.005698] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 1.005735] rtc-pl031 9010000.pl031: setting system clock to 2026-09-12T02:45:38 UTC (1789181138) machine # [ 1.006055] i2c_dev: i2c /dev entries driver machine # [ 1.011434] sdhci: Secure Digital Host Controller Interface driver machine # [ 1.011453] sdhci: Copyright(c) Pierre Ossman machine # [ 1.011722] Synopsys Designware Multimedia Card Interface Driver machine # [ 1.012100] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 1.016832] hid: raw HID events driver (C) Jiri Kosina machine # [ 1.017091] usbcore: registered new interface driver usbhid machine # [ 1.017100] usbhid: USB HID core driver machine # [ 1.020135] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 1.023127] drop_monitor: Initializing network drop monitor service machine # [ 1.023289] NET: Registered PF_INET6 protocol family machine # [ 1.025322] Segment Routing with IPv6 machine # [ 1.025343] In-situ OAM (IOAM) with IPv6 machine # [ 1.025376] NET: Registered PF_PACKET protocol family machine # [ 1.027297] 9pnet: Installing 9P2000 support machine # [ 1.030415] Key type dns_resolver registered machine # [ 1.037175] registered taskstats version 1 machine # [ 1.037346] Loading compiled-in X.509 certificates machine # [ 1.046225] Demotion targets for Node 0: null machine # [ 1.046367] Key type .fscrypt registered machine # [ 1.046374] Key type fscrypt-provisioning registered machine # [ 1.046478] ima: No TPM chip found, activating TPM-bypass! machine # [ 1.046502] ima: Allocated hash algorithm: sha1 machine # [ 1.046534] ima: No architecture policies found machine # [ 1.051167] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 1.071846] clk: Disabling unused clocks machine # [ 1.071882] PM: genpd: Disabling unused power domains machine # [ 1.076505] Freeing unused kernel memory: 4736K machine # [ 1.076766] Run /init as init process machine # [ 1.091850] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.249490] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.406210] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1 machine # [ 1.426991] systemd[1]: systemd 262-b504aa0 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 1.439632] systemd[1]: Detected virtualization qemu. machine # [ 1.441859] systemd[1]: Detected architecture arm64. machine # [ 1.443788] systemd[1]: Running in initrd. machine # [ 1.446904] systemd[1]: Initializing machine ID from random generator. machine # [ 1.450072] systemd[1]: Hostname set to . machine # [ 1.501757] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0 machine # [ 1.620941] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.625707] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.682968] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.691845] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.692928] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.694052] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.694875] systemd[1]: Reached target Path Units. machine # [ 1.695516] systemd[1]: Reached target Slice Units. machine # [ 1.696175] systemd[1]: Reached target Swaps. machine # [ 1.696779] systemd[1]: Reached target Timer Units. machine # [ 1.697687] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.698707] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.699668] systemd[1]: Listening on Journal Sockets. machine # [ 1.700475] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.701243] systemd[1]: Reached target Socket Units. machine # [ 1.703598] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.713598] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 1.714593] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.717530] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.728679] systemd[1]: Starting Journal Service... machine # [ 1.753112] systemd[1]: Starting Load Kernel Modules... machine # [ 1.754486] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.781788] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.785560] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.787046] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 machine # [ 1.787186] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 machine # [ 1.792080] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 1.792670] systemd-journald[73]: Collecting audit messages is disabled. machine # [ 1.798214] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 1.799467] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.817950] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.847865] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.873462] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.878475] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 machine # [ 1.878726] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.878736] [drm] features: -context_init machine # [ 1.879519] [drm] number of scanouts: 1 machine # [ 1.879539] [drm] number of cap sets: 0 machine # [ 1.894220] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.897105] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.901919] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic machine # [ 1.901947] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 machine # [ 1.937805] Console: switching to colour frame buffer device 160x50 machine # [ 1.944688] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.966218] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.966478] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.966513] systemd[1]: Reached target Local File Systems. machine # [ 1.973816] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.975028] systemd-modules-load[74]: Inserted module 'dm_mod' machine # [ 1.997755] systemd[1]: Started Journal Service. machine # [ 1.984298] systemd-modules-load[74]: Module 'virtio_balloon' is built in machine # [ 1.985496] systemd-modules-load[74]: Module 'virtio_console' is built in machine # [ 1.986650] systemd-modules-load[74]: Inserted module 'virtio_gpu' machine # [ 1.987662] systemd-modules-load[74]: Module 'virtio_rng' is built in machine # [ 2.000473] systemd[1]: Finished Load Kernel Modules. machine # [ 2.001415] systemd[1]: Starting Apply Kernel Variables... machine # [ 2.009437] systemd[1]: Starting Create System Files and Directories... machine # [ 2.077114] systemd[1]: Finished Create System Files and Directories. machine # [ 2.082973] systemd-udevd[79]: Using default interface naming scheme 'v261'. machine # [ 2.088382] systemd[1]: Finished Apply Kernel Variables. machine # [ 2.121331] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 2.193802] systemd[1]: Starting Virtual Console Setup... machine # [ 2.282125] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.288257] systemd[1]: Finished Virtual Console Setup. machine # [ 2.936534] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.938273] systemd[1]: Reached target System Initialization. machine # [ 2.939167] systemd[1]: Reached target Basic System. machine # [ 3.116491] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line. machine # [ 3.120788] (udev-worker)[99]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 3.126819] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line. machine # [ 3.182406] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 3.185996] systemd[1]: Reached target Initrd Root Device. machine # [ 3.192503] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 3.245070] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 3.251948] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 3.267542] systemd[1]: Mounting /sysroot... machine # [ 3.324977] EXT4-fs (vda): mounted filesystem 583bfa1a-fad7-47de-9140-654c1f7ef1dd r/w with ordered data mode. Quota mode: none. machine # [ 3.313242] systemd[1]: Mounted /sysroot. machine # [ 3.316555] systemd[1]: Reached target Initrd Root File System. machine # [ 3.319428] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 3.355272] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 3.363302] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 3.367164] systemd[1]: Reloading... machine # [ 3.572704] systemd[1]: Reloading finished in 209 ms. machine # [ 3.603253] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace... machine # [ 3.607328] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace... machine # [ 3.622123] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 3.624226] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.631603] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.632849] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.655144] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 3.657356] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 3.770621] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.781614] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.797916] systemd[1]: Mounting /sysroot/run... machine # [ 3.833347] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.846773] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.876108] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.893468] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.909971] systemd[1]: Mounted /sysroot/run. machine # [ 3.929669] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.934309] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.947402] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.968145] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.971480] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.974198] systemd[1]: Mounting /sysroot/nix/store... machine # [ 4.021153] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.022317] systemd[1]: Reached target Initrd File Systems. machine # [ 4.025036] systemd[1]: Starting Find NixOS closure... machine # [ 4.048889] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.082836] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.094359] systemd[1]: Finished Find NixOS closure. machine # [ 4.096161] systemd[1]: Reached target Initrd Default Target. machine # [ 4.100314] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.130726] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.134239] systemd[1]: Stopped target Basic System. machine # [ 4.135829] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.141449] systemd[1]: Stopped target Path Units. machine # [ 4.142219] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.143292] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.148265] systemd[1]: Stopped target Slice Units. machine # [ 4.151460] systemd[1]: Stopped target Socket Units. machine # [ 4.153412] systemd[1]: Stopped target System Initialization. machine # [ 4.156764] systemd[1]: Stopped target Swaps. machine # [ 4.158260] systemd[1]: Stopped target Timer Units. machine # [ 4.161188] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.164511] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.173251] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.174368] systemd[1]: Stopped Find NixOS closure. machine # [ 4.175096] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 4.184129] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.185817] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.192344] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.194347] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.199051] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.205399] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.208391] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.210904] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.220310] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.223198] systemd[1]: Stopped target Local File Systems. machine # [ 4.225988] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.227033] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.234966] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.235905] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.240927] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.242457] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.244263] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 4.247524] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 4.249021] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.252284] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.253281] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.256458] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.257369] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.259713] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.261088] systemd[1]: systemd-udevd.service: Consumed 1.022s CPU time over 2.289s wall clock time, 15.7M memory peak. machine # [ 4.262519] systemd[1]: Starting Cleanup udev Database... machine # [ 4.263286] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.264461] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.265344] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.266558] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.267573] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.272282] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.296732] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.300551] systemd[1]: Finished Cleanup udev Database. machine # [ 4.301381] systemd[1]: Reached target Switch Root. machine # [ 4.303152] systemd[1]: Starting NixOS Activation... machine # [ 4.493422] initrd-nixos-activation-start[172]: booting system configuration /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test machine # [ 4.575075] initrd-nixos-activation-start[172]: running activation script... machine # [ 5.024700] initrd-nixos-activation-start[195]: setting up /etc... machine # [ 5.307356] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 5.310449] systemd[1]: Finished NixOS Activation. machine # [ 5.316279] systemd[1]: Starting Switch Root... machine # [ 5.336944] systemd[1]: Switching root. machine # [ 5.537834] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). machine # [ 6.156454] systemd[1]: systemd 262-b504aa0 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 6.168882] systemd[1]: Detected virtualization qemu. machine # [ 6.172280] systemd[1]: Detected architecture arm64. machine # [ 6.176832] systemd[1]: Detected first boot. machine # [ 6.184630] systemd[1]: Initializing machine ID from random generator. machine # [ 6.335097] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 6.510624] systemd[1]: Applying preset policy. machine # [ 6.990993] systemd[1]: Populated /etc with preset unit settings. machine # [ 7.523297] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 7.524767] systemd[1]: Stopped initrd-switch-root.service. machine # [ 7.528750] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 7.533709] systemd[1]: Created slice Slice /system/getty. machine # [ 7.535578] systemd[1]: Created slice User and Session Slice. machine # [ 7.536623] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 7.539615] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 7.541706] systemd[1]: Expecting device /dev/hvc0... machine # [ 7.543053] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 7.544696] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 7.547214] systemd[1]: Stopped target initrd-fs.target. machine # [ 7.549205] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 7.551258] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 7.553379] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 7.555642] systemd[1]: Reached target Path Units. machine # [ 7.557661] systemd[1]: Reached target Remote File Systems. machine # [ 7.559675] systemd[1]: Reached target Slice Units. machine # [ 7.561732] systemd[1]: Reached target Swaps. machine # [ 7.567418] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 7.572928] systemd[1]: Listening on Process Core Dump Socket. machine # [ 7.577472] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 7.581869] systemd[1]: Listening on Factory Reset Management. machine # [ 7.583271] systemd[1]: Listening on Hostname Service Socket. machine # [ 7.590311] systemd[1]: Starting Journal Log Access Socket... machine # [ 7.592265] systemd[1]: Listening on Journal Audit Socket. machine # [ 7.596801] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 7.598739] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 7.600832] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.603910] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 7.616939] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 7.618746] systemd[1]: Listening on udev Varlink Socket. machine # [ 7.625117] systemd[1]: Mounting Huge Pages File System... machine # [ 7.630494] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 7.642788] systemd[1]: Mounting Kernel Debug File System... machine # [ 7.651629] systemd[1]: Mounting Kernel Trace File System... machine # [ 7.668947] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 7.684578] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 7.686282] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 7.705617] systemd[1]: Mounting Kernel Configuration File System... machine # [ 7.707609] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 7.710445] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 7.733996] systemd[1]: Starting Load Kernel Module fuse... machine # [ 7.736912] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 7.797244] systemd[1]: Starting Journal Service... machine # [ 7.841755] systemd[1]: Starting Load Kernel Modules... machine # [ 7.870736] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 7.931760] systemd-journald[268]: Collecting audit messages is enabled. machine # [ 7.949831] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 7.935151] systemd[1]: Queued start job for default target Multi-User System. machine # [ 7.938168] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 7.957905] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.982854] fuse: init (API version 7.45) machine # [ 7.987193] systemd[1]: Starting Coldplug All udev Devices... machine # [ 7.979081] systemd-modules-load[269]: Module 'atkbd' is built in machine # [ 7.982709] systemd-modules-load[269]: Module 'loop' is built in machine # [ 8.005159] systemd[1]: Started Journal Service. machine # [ 8.009027] systemd[1]: Listening on Journal Log Access Socket. machine # [ 8.014178] systemd[1]: Mounted Huge Pages File System. machine # [ 8.017783] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 8.024955] systemd[1]: Mounted Kernel Debug File System. machine # [ 8.028306] systemd[1]: Mounted Kernel Trace File System. machine # [ 8.035535] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 8.041078] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 8.060136] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 8.061300] systemd[1]: Mounted Kernel Configuration File System. machine # [ 8.062281] systemd[1]: modprobe@fuse.service: Deactivated successfully. machine # [ 8.063285] systemd[1]: Finished Load Kernel Module fuse. machine # [ 8.072157] systemd[1]: Finished Load Kernel Modules. machine # [ 8.095042] systemd[1]: Mounting FUSE Control File System... machine # [ 8.121794] EXT4-fs (vda): re-mounted 583bfa1a-fad7-47de-9140-654c1f7ef1dd. machine # [ 8.126318] systemd[1]: Starting Firewall... machine # [ 8.144202] systemd[1]: Starting Apply Kernel Variables... machine # [ 8.146379] systemd-oomd[271]: No swap; memory pressure usage will be degraded machine # [ 8.171141] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 8.192878] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 8.210921] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 8.237742] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 8.249635] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 8.253749] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 8.283118] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 8.292621] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 8.338122] systemd[1]: Mounted FUSE Control File System. machine # [ 8.350525] systemd[1]: Finished Apply Kernel Variables. machine # [ 8.388449] systemd-journald[268]: Received client request to flush runtime journal. machine # [ 8.448733] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 8.456124] systemd[1]: Reached target First Boot Complete. machine # [ 8.458062] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 8.461803] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 8.465898] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 8.552745] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 8.557209] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 8.567544] systemd[1]: Mounting /run/wrappers... machine # [ 8.570499] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 8.652270] systemd[1]: Mounted /run/wrappers. machine # [ 8.655819] systemd[1]: Reached target Local File Systems. machine # [ 8.661579] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 8.666979] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 8.671880] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 8.684454] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 8.703549] systemd[1]: Starting Create System Files and Directories... machine # [ 8.850124] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 8.856561] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 8.918119] systemd[1]: Finished Create System Files and Directories. machine # [ 8.928729] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 8.944542] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 9.062235] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 9.139136] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 9.144591] systemd-udevd[313]: Using default interface naming scheme 'v261'. machine # [ 9.154320] systemd[1]: Starting Update is Completed... machine # [ 9.240369] systemd[1]: Finished Update is Completed. machine # [ 9.376334] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 9.662660] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 9.669870] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 10.093736] systemd[1]: Finished Coldplug All udev Devices. machine # [ 10.096151] systemd[1]: Reached target System Initialization. machine # [ 10.101709] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 10.109093] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 10.110197] systemd[1]: Reached target Timer Units. machine # [ 10.114226] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 10.124186] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 10.126311] systemd[1]: Reached target Socket Units. machine # [ 10.127604] systemd[1]: Reached target Basic System. machine # [ 10.131633] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 10.143464] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 10.153017] systemd[1]: Starting Post-Boot Actions... machine # [ 10.180990] systemd[1]: Started Reset console on configuration changes. machine # [ 10.213757] systemd[1]: Starting resolvconf update... machine # [ 10.262971] nsncd[452]: Sep 12 02:45:47.773 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 10.296325] systemd[1]: Starting D-Bus System Message Bus... machine # [ 10.310414] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 10.338811] systemd[1]: Finished Post-Boot Actions. machine # [ 10.349865] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 10.360273] systemd[1]: Reached target User and Group Name Lookups. machine # [ 10.372889] systemd[1]: Starting User Login Management... machine # [ 10.382436] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 10.580779] dbus-broker-launch[477]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 10.589506] dbus-broker-launch[477]: NSS returned no entry for 'systemd-timesync' machine # [ 10.596610] dbus-broker-launch[477]: Invalid user-name in /nix/store/8pik3vng42n4iy67gvrlnf7gkid3xs0z-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 10.606773] systemd[1]: Finished Firewall. machine # [ 10.618025] systemd-logind[482]: New seat seat0. machine # [ 10.623568] systemd[1]: Started User Login Management. machine # [ 10.629816] systemd[1]: Starting linger-users.service... machine # [ 10.649754] systemd[1]: Started D-Bus System Message Bus. machine # [ 10.700747] dbus-broker-launch[477]: Ready machine # [ 10.721812] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 10.726790] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 10.734801] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 10.739042] systemd[1]: Stopping User and Group Name Lookups... machine # [ 10.746791] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 10.751916] systemd[1]: nscd.service: Deactivated successfully. machine # [ 10.757852] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 10.769493] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 10.839954] systemd[1]: Created slice Slice /user/1001. machine # [ 10.858224] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 10.902184] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 10.919614] systemd[1]: Finished linger-users.service. machine # [ 10.972867] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 11.000611] systemd[1]: Starting User Manager for UID 1001... machine # [ 11.027059] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 11.048100] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 11.074926] nsncd[546]: Sep 12 02:45:48.540 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 11.139755] (systemd)[560]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 11.175886] systemd[1]: Reached target User and Group Name Lookups. machine # [ 11.210178] systemd-logind[482]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 11.233595] systemd[1]: Finished resolvconf update. machine # [ 11.252405] systemd[1]: Reached target Preparation for Network. machine # [ 11.270407] systemd[1]: Starting DHCP Client... machine # [ 11.289336] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 11.382270] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 machine # [ 11.569056] systemd[1]: Starting Extra networking commands.... machine # [ 11.595472] systemd[560]: Queued start job for default target Main User Target. machine # [ 11.635023] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 11.666540] systemd[560]: Created slice User Application Slice. machine # [ 11.682726] systemd[560]: Started Daily Cleanup of User's Temporary Directories. machine # [ 11.702137] systemd[560]: Reached target Paths. machine # [ 11.713371] systemd[560]: Reached target Timers. machine # [ 11.736656] systemd[560]: Starting D-Bus User Message Bus Socket... machine # [ 11.745130] systemd[560]: Starting Create User Files and Directories... machine # [ 11.760347] systemd[560]: Finished Create User Files and Directories. machine # [ 11.781361] systemd[560]: Listening on D-Bus User Message Bus Socket. machine # [ 11.791014] systemd[560]: Reached target Sockets. machine # [ 11.804730] systemd[560]: Reached target Basic System. machine # [ 11.813895] systemd[1]: Started User Manager for UID 1001. machine # [ 11.823895] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 11.849339] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 11.866972] systemd[560]: Reached target Main User Target. machine # [ 11.888699] systemd[560]: Startup finished in 476ms. machine # [ 11.921841] systemd[1]: Starting Virtual Console Setup... machine # [ 11.949467] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 12.020376] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 12.042290] systemd[1]: Stopped Virtual Console Setup. machine # [ 12.058663] systemd[1]: Starting Virtual Console Setup... machine # [ 12.238379] dhcpcd[594]: dhcpcd-10.3.2 starting machine # [ 12.254260] dhcpcd[645]: dev: loaded udev machine # [ 12.277970] systemd[1]: Finished Extra networking commands.. machine # [ 12.280390] systemd[1]: Reached target Network. machine # [ 12.282549] systemd[1]: Starting Permit User Sessions... machine # [ 12.317874] 8021q: 802.1Q VLAN Support v1.8 machine # [ 12.396259] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 12.427439] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 12.465164] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 12.467717] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 12.472308] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 12.472667] cfg80211: failed to load regulatory.db machine # [ 12.471678] dhcpcd[645]: no valid interfaces found machine # [ 12.492799] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 12.509849] dhcpcd[645]: no valid interfaces found machine # [ 12.526211] systemd[1]: Started backdoor.service. machine # [ 12.537829] (udev-worker)[654]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 12.579006] (udev-worker)[654]: Network interface NamePolicy= disabled on kernel command line. machine # [ 12.611337] (udev-worker)[657]: Network interface NamePolicy= disabled on kernel command line. machine # [ 12.639392] systemd[1]: Finished Permit User Sessions. machine # [ 12.664706] systemd[1]: Started Getty on tty1. machine # [ 12.682508] systemd[1]: Reached target Login Prompts. machine # [ 12.738805] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 12.764157] systemd[1]: Starting Address configuration of eth1... machine # [ 12.846845] systemd-logind[482]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # connecting to host... machine # [ 12.964989] mousedev: PS/2 mouse device common for all mice machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 13.32 seconds) machine: (finished: waiting for the VM to finish booting, in 13.98 seconds) machine # [ 13.026516] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 13.013132] dhcpcd[645]: eth0: waiting for carrier machine # [ 13.019726] dhcpcd[645]: eth0: carrier acquired machine # [ 13.125029] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 13.117655] dhcpcd[645]: DUID 00:01:00:01:32:37:79:5e:52:54:00:12:34:56 machine # [ 13.119563] dhcpcd[645]: eth0: IAID 00:12:34:56 machine # [ 13.148118] dhcpcd[645]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 13.165826] systemd-logind[482]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 13.221475] network-addresses-eth1-start[675]: adding address 192.168.1.1/24... done machine # [ 13.304477] network-addresses-eth1-start[675]: adding address 2001:db8:1::1/64... done machine # [ 13.412751] systemd[1]: Finished Address configuration of eth1. machine # [ 13.765163] systemd-vconsole-setup[605]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 13.794608] systemd[1]: Finished Virtual Console Setup. machine # [ 14.233084] dhcpcd[645]: eth0: soliciting a DHCP lease machine # [ 14.233932] dhcpcd[645]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 14.259684] dhcpcd[645]: eth0: probing address 10.0.2.15/24 machine # [ 14.378490] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 14.396435] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 14.397595] systemd[1]: Stopped Virtual Console Setup. machine # [ 14.398372] systemd[1]: Stopping Virtual Console Setup... machine # [ 14.399118] systemd[1]: Starting Virtual Console Setup... machine # [ 14.440977] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 14.442125] systemd[1]: Stopped Virtual Console Setup. machine # [ 14.448331] systemd[1]: Starting Virtual Console Setup... machine # [ 14.455668] systemd-logind[482]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 14.828509] systemd-vconsole-setup[713]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 14.835445] systemd[1]: Finished Virtual Console Setup. machine # [ 15.742297] dhcpcd[645]: eth0: soliciting an IPv6 router machine # [ 15.742713] dhcpcd[645]: eth0: Router Advertisement from fe80::2 machine # [ 15.742877] dhcpcd[645]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 15.751390] dhcpcd[645]: eth0: adding route to fec0::/64 machine # [ 15.756458] dhcpcd[645]: eth0: adding default route via fe80::2 machine # [ 19.026879] dhcpcd[645]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 19.030937] dhcpcd[645]: eth0: adding route to 10.0.2.0/24 machine # [ 19.035050] dhcpcd[645]: eth0: adding default route via 10.0.2.2 machine # [ 19.290152] systemd[1]: Started DHCP Client. machine # [ 19.292718] systemd[1]: Reached target Multi-User System. machine # [ 19.293969] systemd[1]: Startup finished in 1.064s (kernel) + 4.585s (initrd) + 13.642s (userspace) = 19.291s. machine: (finished: waiting for unit multi-user.target, in 21.34 seconds) machine: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 20.957779] nixos[830]: switching to system configuration /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test machine # activating the configuration... machine # [ 20.962088] systemd[1]: Stopped target Local File Systems. machine # [ 20.963236] systemd[1]: Stopped target Remote File Systems. machine # setting up /etc... machine # [ 21.422634] systemd[1]: Reload requested from client PID 830 ('.switch-to-conf') (unit backdoor.service)... machine # [ 21.424696] systemd[1]: Reloading... machine # [ 22.018161] systemd[1]: Reloading finished in 591 ms. machine # reloading user units for usertest... machine # [ 22.071995] systemd[560]: Created slice User Core Session Slice. machine # [ 22.075973] systemd[560]: Starting D-Bus User Message Bus... machine # [ 22.146511] dbus-broker-launch[900]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/8pik3vng42n4iy67gvrlnf7gkid3xs0z-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 22.150086] dbus-broker-launch[900]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/8pik3vng42n4iy67gvrlnf7gkid3xs0z-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 22.153503] dbus-broker-launch[900]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/8pik3vng42n4iy67gvrlnf7gkid3xs0z-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 22.156924] dbus-broker-launch[900]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/8pik3vng42n4iy67gvrlnf7gkid3xs0z-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 22.160713] dbus-broker-launch[900]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 22.163543] dbus-broker-launch[900]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 22.166004] systemd[560]: Started D-Bus User Message Bus. machine # [ 22.173238] dbus-broker-launch[900]: Ready machine # [ 22.275493] systemd[560]: Reexecution requested from client PID 899 ('switch-to-confi')... machine # [ 22.279266] systemd[560]: Reexecuting. machine # [ 22.342109] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.553604] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.563155] systemd[560]: Reload requested from client PID 899 ('switch-to-confi')... machine # [ 22.568581] systemd[560]: Reloading... machine # [ 22.775802] systemd[560]: Reloading finished in 209 ms. machine # [ 22.788182] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 22.799523] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 22.802085] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 22.805225] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 22.856390] systemd[560]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 22.874009] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 22.995308] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 22.998079] systemd[1]: Reached target Reactivate sysinit units. machine # [ 23.003971] systemd[1]: Reached target Remote File Systems. machine # [ 23.009769] systemd[1]: Starting linger-users.service... machine # [ 23.014365] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.015787] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 23.028521] systemd[1]: Reached target Local File Systems. machine # [ 23.029495] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 23.041696] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 23.042804] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 23.048331] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 23.051769] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 23.054570] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.056719] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.119964] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 23.122928] systemd[1]: Finished linger-users.service. machine # [ 23.411418] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 23.414850] systemd[1]: Finished Create SUID/SGID Wrappers. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 23.676703] nixos[830]: finished switching to system configuration /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/bin/switch-to-configuration test, in 3.32 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.05 seconds) machine: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/wc9s91xqi66mnv0w6vf5686lpihqwdwa-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/wc9s91xqi66mnv0w6vf5686lpihqwdwa-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 24.367545] nixos[978]: switching to system configuration /nix/store/wc9s91xqi66mnv0w6vf5686lpihqwdwa-nixos-system-other-test machine # [ 24.370357] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # [ 24.373099] systemd[1]: Stopped target Local File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 24.848991] systemd[1]: Reload requested from client PID 978 ('.switch-to-conf') (unit backdoor.service)... machine # [ 24.850919] systemd[1]: Reloading... machine # [ 25.488139] systemd[1]: Reloading finished in 635 ms. machine # reloading user units for usertest... machine # [ 25.653554] systemd[560]: Reexecution requested from client PID 1049 ('switch-to-confi')... machine # [ 25.658422] systemd[560]: Reexecuting. machine # [ 25.709925] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.941160] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.948694] systemd[560]: Reload requested from client PID 1049 ('switch-to-confi')... machine # [ 25.951428] systemd[560]: Reloading... machine # [ 26.149253] systemd[560]: Reloading finished in 196 ms. machine # [ 26.164180] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 26.175075] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 26.176188] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 26.179450] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 26.229152] systemd[560]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 26.233884] systemd[1]: Stopped target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service[ 26.236487] systemd[1]: Stopping Reactivate sysinit units... machine # [ 26.237390] systemd[1]: Reached target Reactivate sysinit units. machine # machine # [ 26.240746] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 26.242253] dbus-broker-launch[477]: Caught SIGHUP, trigger reload. machine # [ 26.262613] dbus-broker-launch[477]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 26.264955] dbus-broker-launch[477]: NSS returned no entry for 'systemd-timesync' machine # [ 26.266032] dbus-broker-launch[477]: Invalid user-name in /nix/store/mx1y8zqfrap40lzhvxqayqjls63h1pnv-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 26.310911] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 26.319093] systemd[1]: Stopping Address configuration of eth1... machine # [ 26.372256] network-addresses-eth1-pre-stop[1062]: deleting address 192.168.1.1/24... done machine # [ 26.384718] network-addresses-eth1-pre-stop[1062]: deleting address 2001:db8:1::1/64... done machine # [ 26.395531] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 26.397920] systemd[1]: Stopped Address configuration of eth1. machine # [ 26.403957] systemd[1]: Starting Address configuration of eth1... machine # [ 26.489601] network-addresses-eth1-start[1067]: adding address 192.168.1.2/24... done machine # [ 26.502991] network-addresses-eth1-start[1067]: adding address 2001:db8:1::2/64... done machine # [ 26.521371] systemd[1]: Finished Address configuration of eth1. machine # [ 26.525016] systemd[1]: Reached target Local File Systems. machine # [ 26.527787] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.530365] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 26.535079] systemd[1]: Reached target Remote File Systems. machine # [ 26.541257] systemd[1]: Starting linger-users.service... machine # [ 26.552618] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 26.557771] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 26.561329] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 26.562712] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 26.570688] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 26.573009] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.574460] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.622616] linger-users-start[1081]: id: ‘usertest’: no such user machine # [ 26.625833] linger-users-start[1078]: Removing linger for missing user usertest machine # [ 26.638368] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 26.641797] systemd[1]: Finished linger-users.service. machine # [ 27.012884] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 27.016635] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 27.275243] nixos[978]: finished switching to system configuration /nix/store/wc9s91xqi66mnv0w6vf5686lpihqwdwa-nixos-system-other-test machine: (finished: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/wc9s91xqi66mnv0w6vf5686lpihqwdwa-nixos-system-other-test/bin/switch-to-configuration test, in 3.55 seconds) subtest: services machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 27.906757] nixos[1145]: switching to system configuration /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test machine # [ 27.910287] systemd[1]: Stopped target Local File Systems. machine # [ 27.911730] systemd[1]: Stopped target Remote File Systems. machine # [ 28.377577] systemd[1]: Reload requested from client PID 1145 ('.switch-to-conf') (unit backdoor.service)... machine # [ 28.379715] systemd[1]: Reloading... machine # [ 28.997282] systemd[1]: Reloading finished in 614 ms. machine # [ 29.144455] systemd[560]: Reexecution requested from client PID 1213 ('switch-to-confi')... machine # [ 29.145857] systemd[560]: Reexecuting. machine # [ 29.222603] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.424368] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.431171] systemd[560]: Reload requested from client PID 1213 ('switch-to-confi')... machine # [ 29.433900] systemd[560]: Reloading... machine # [ 29.619318] systemd[560]: Reloading finished in 185 ms. machine # [ 29.632165] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.642090] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 29.644591] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 29.647526] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 29.699497] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 29.704563] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 29.709661] systemd[1]: Stopping Reactivate sysinit units... machine # [ 29.710761] systemd[1]: Reached target Reactivate sysinit units. machine # [ 29.711782] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 29.713560] dbus-broker-launch[477]: Caught SIGHUP, trigger reload. machine # [ 29.725971] dbus-broker-launch[477]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 29.728576] dbus-broker-launch[477]: NSS returned no entry for 'systemd-timesync' machine # [ 29.729804] dbus-broker-launch[477]: Invalid user-name in /nix/store/8pik3vng42n4iy67gvrlnf7gkid3xs0z-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 29.766315] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 29.773643] systemd[1]: Stopping Address configuration of eth1... machine # [ 29.826460] network-addresses-eth1-pre-stop[1227]: deleting address 192.168.1.2/24... done machine # [ 29.838129] network-addresses-eth1-pre-stop[1227]: deleting address 2001:db8:1::2/64... done machine # [ 29.847435] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 29.849874] systemd[1]: Stopped Address configuration of eth1. machine # [ 29.854815] systemd[1]: Starting Address configuration of eth1... machine # [ 29.928682] network-addresses-eth1-start[1232]: adding address 192.168.1.1/24... done machine # [ 29.941385] network-addresses-eth1-start[1232]: adding address 2001:db8:1::1/64... done machine # [ 29.958656] systemd[1]: Finished Address configuration of eth1. machine # [ 29.962506] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.966324] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 29.970208] systemd[1]: Reached target Remote File Systems. machine # [ 29.975977] systemd[1]: Starting linger-users.service... machine # [ 29.976929] systemd[1]: Reached target Local File Systems. machine # [ 29.979889] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 29.991803] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 29.993877] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 30.002542] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 30.007417] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 30.010574] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.013205] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.060545] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 30.063343] systemd[1]: Finished linger-users.service. machine # [ 30.358689] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 30.362191] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 30.619019] nixos[1145]: finished switching to system configuration /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.34 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 31.179540] nixos[1301]: switching to system configuration /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test machine # [ 31.182686] systemd[1]: Stopped target Local File Systems. machine # [ 31.185361] systemd[1]: Stopped target Remote File Systems. machine # [ 31.651734] systemd[1]: Reload requested from client PID 1301 ('.switch-to-conf') (unit backdoor.service)... machine # [ 31.654093] systemd[1]: Reloading... machine # [ 32.256424] systemd[1]: Reloading finished in 600 ms. machine # [ 32.407724] systemd[560]: Reexecution requested from client PID 1370 ('switch-to-confi')... machine # [ 32.411701] systemd[560]: Reexecuting. machine # [ 32.469904] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.694605] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.701899] systemd[560]: Reload requested from client PID 1370 ('switch-to-confi')... machine # [ 32.704492] systemd[560]: Reloading... machine # [ 32.894391] systemd[560]: Reloading finished in 188 ms. machine # [ 32.908160] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.916973] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 32.919327] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 32.922094] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 32.968474] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 32.972653] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 32.975561] systemd[1]: Stopping Reactivate sysinit units... machine # [ 32.977031] systemd[1]: Reached target Reactivate sysinit units. machine # [ 32.978233] systemd[1]: Reached target Local File Systems. machine # [ 32.982113] systemd[1]: Reached target Remote File Systems. machine # [ 32.984653] systemd[1]: Starting linger-users.service... machine # [ 32.987436] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 32.994902] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 32.995819] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 33.005295] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 33.007538] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 33.015476] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.018301] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.019536] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.022568] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 33.085674] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 33.089170] systemd[1]: Finished linger-users.service. machine # [ 33.350311] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 33.353780] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 33.610836] nixos[1301]: finished switching to system configuration /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.99 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 34.231027] nixos[1442]: switching to system configuration /nix/store/j7bddzhbml4r1aph0kl2v1y8yd6b5yhz-nixos-system-machine-test machine # [ 34.233590] systemd[1]: Stopped target Local File Systems. machine # [ 34.235792] systemd[1]: Stopped target Remote File Systems. machine # [ 34.726291] systemd[1]: Reload requested from client PID 1442 ('.switch-to-conf') (unit backdoor.service)... machine # [ 34.728331] systemd[1]: Reloading... machine # [ 35.337926] systemd[1]: Reloading finished in 607 ms. machine # [ 35.480392] systemd[560]: Reexecution requested from client PID 1510 ('switch-to-confi')... machine # [ 35.481793] systemd[560]: Reexecuting. machine # [ 35.550649] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.743325] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.750712] systemd[560]: Reload requested from client PID 1510 ('switch-to-confi')... machine # [ 35.754651] systemd[560]: Reloading... machine # [ 35.975646] systemd[560]: Reloading finished in 222 ms. machine # [ 35.988175] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.998150] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 36.000721] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 36.003794] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 36.051219] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 36.055745] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 36.058154] systemd[1]: Stopping Reactivate sysinit units... machine # [ 36.059455] systemd[1]: Reached target Reactivate sysinit units. machine # [ 36.063765] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.066426] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 36.068410] systemd[1]: Reached target Local File Systems. machine # [ 36.070856] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 36.078245] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 36.079186] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 36.085669] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 36.092649] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 36.095177] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.096557] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.097714] systemd[1]: Reached target Remote File Systems. machine # [ 36.424121] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 36.428659] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 36.431473] systemd[1]: Starting linger-users.service... machine # [ 36.435696] systemd[1]: Starting test.service... machine # [ 36.481430] systemd[1]: Finished test.service. machine # [ 36.509006] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 36.511852] systemd[1]: Finished linger-users.service. machine # [ 36.771432] nixos[1442]: finished switching to system configuration /nix/store/j7bddzhbml4r1aph0kl2v1y8yd6b5yhz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 3.16 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 37.351299] nixos[1585]: switching to system configuration /nix/store/j7bddzhbml4r1aph0kl2v1y8yd6b5yhz-nixos-system-machine-test machine # [ 37.354262] systemd[1]: Stopped target Local File Systems. machine # [ 37.356624] systemd[1]: Stopped target Remote File Systems. machine # [ 37.911412] systemd[1]: Reload requested from client PID 1585 ('.switch-to-conf') (unit backdoor.service)... machine # [ 37.913987] systemd[1]: Reloading... machine # [ 38.649541] systemd[1]: Reloading finished in 733 ms. machine # [ 38.811287] systemd[560]: Reexecution requested from client PID 1654 ('switch-to-confi')... machine # [ 38.813524] systemd[560]: Reexecuting. machine # [ 38.885663] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.147903] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.159825] systemd[560]: Reload requested from client PID 1654 ('switch-to-confi')... machine # [ 39.164302] systemd[560]: Reloading... machine # [ 39.423895] systemd[560]: Reloading finished in 260 ms. machine # [ 39.436187] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.448111] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 39.449193] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 39.452557] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 39.502757] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 39.507555] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 39.510288] systemd[1]: Stopping Reactivate sysinit units... machine # [ 39.511236] systemd[1]: Reached target Reactivate sysinit units. machine # [ 39.514762] systemd[1]: Reached target Local File Systems. machine # [ 39.519322] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 39.523487] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 39.525896] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 39.529736] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 39.531984] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 39.539507] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.545730] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.549387] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.550686] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 39.551974] systemd[1]: Reached target Remote File Systems. machine # [ 39.907339] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 39.913155] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 39.915438] systemd[1]: Starting linger-users.service... machine # [ 39.981998] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 39.984190] systemd[1]: Finished linger-users.service. machine # [ 40.242909] nixos[1585]: finished switching to system configuration /nix/store/j7bddzhbml4r1aph0kl2v1y8yd6b5yhz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 3.48 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 41.011758] nixos[1726]: switching to system configuration /nix/store/9xxd8hzjzx91fg19dqfcjmcih6xcwjqz-nixos-system-machine-test machine # [ 41.015148] systemd[1]: Stopped target Local File Systems. machine # [ 41.017493] systemd[1]: Stopped target Remote File Systems. machine # [ 41.579269] systemd[1]: Reload requested from client PID 1726 ('.switch-to-conf') (unit backdoor.service)... machine # [ 41.581726] systemd[1]: Reloading... machine # [ 42.285213] systemd[1]: Reloading finished in 701 ms. machine # [ 42.438024] systemd[560]: Reexecution requested from client PID 1795 ('switch-to-confi')... machine # [ 42.439447] systemd[560]: Reexecuting. machine # [ 42.515421] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.757829] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.766104] systemd[560]: Reload requested from client PID 1795 ('switch-to-confi')... machine # [ 42.768603] systemd[560]: Reloading... machine # [ 42.984695] systemd[560]: Reloading finished in 214 ms. machine # [ 43.000197] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.009967] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 43.012813] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 43.015831] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 43.070034] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 43.074823] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 43.077073] systemd[1]: Stopping Reactivate sysinit units... machine # [ 43.078712] systemd[1]: Reached target Reactivate sysinit units. machine # [ 43.082443] systemd[1]: Reached target Remote File Systems. machine # [ 43.085377] systemd[1]: Reached target Local File Systems. machine # [ 43.089040] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 43.094728] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 43.095740] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 43.100999] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 43.108998] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 43.117916] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.119353] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.121686] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.123079] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 43.463383] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 43.468527] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 43.471474] systemd[1]: Starting linger-users.service... machine # [ 43.543999] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 43.545877] systemd[1]: Finished linger-users.service. machine # [ 43.805322] nixos[1726]: finished switching to system configuration /nix/store/9xxd8hzjzx91fg19dqfcjmcih6xcwjqz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 3.56 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 44.480689] nixos[1867]: switching to system configuration /nix/store/68g3ac6i44dp6spfylk9v6fm02jjd1wi-nixos-system-machine-test machine # [ 44.484615] systemd[1]: Stopped target Local File Systems. machine # [ 44.486406] systemd[1]: Stopped target Remote File Systems. machine # [ 44.487281] systemd[1]: test.service: Deactivated successfully. machine # [ 44.488806] systemd[1]: Stopped Test unit. machine # [ 45.012124] systemd[1]: Reload requested from client PID 1867 ('.switch-to-conf') (unit backdoor.service)... machine # [ 45.014136] systemd[1]: Reloading... machine # [ 45.669762] systemd[1]: Reloading finished in 653 ms. machine # [ 45.830969] systemd[560]: Reexecution requested from client PID 1936 ('switch-to-confi')... machine # [ 45.834232] systemd[560]: Reexecuting. machine # [ 45.901705] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.094524] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.101752] systemd[560]: Reload requested from client PID 1936 ('switch-to-confi')... machine # [ 46.104247] systemd[560]: Reloading... machine # [ 46.295750] systemd[560]: Reloading finished in 190 ms. machine # [ 46.308192] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.317895] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 46.320416] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 46.323420] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 46.369609] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 46.373905] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 46.376975] systemd[1]: Stopping Reactivate sysinit units... machine # [ 46.378389] systemd[1]: Reached target Reactivate sysinit units. machine # [ 46.379916] systemd[1]: Reached target Remote File Systems. machine # [ 46.388266] systemd[1]: Starting linger-users.service... machine # [ 46.392864] systemd[1]: Starting test.service... machine # [ 46.393656] systemd[1]: Reached target Local File Systems. machine # [ 46.408749] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 46.413822] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 46.414756] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 46.415997] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 46.428550] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 46.430248] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.431705] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.436158] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.438921] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 46.468480] systemd[1]: Finished test.service. machine # [ 46.505512] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 46.508781] systemd[1]: Finished linger-users.service. machine # [ 46.785349] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 46.788107] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 47.045010] nixos[1867]: finished switching to system configuration /nix/store/68g3ac6i44dp6spfylk9v6fm02jjd1wi-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 3.24 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 47.669505] nixos[2010]: switching to system configuration /nix/store/cxhwm59m0fgjyyhyqnb02hzn66jf0prk-nixos-system-machine-test machine # [ 47.672055] systemd[1]: Stopped target Local File Systems. machine # [ 47.674227] systemd[1]: Stopped target Remote File Systems. machine # [ 48.172768] systemd[1]: Reload requested from client PID 2010 ('.switch-to-conf') (unit backdoor.service)... machine # [ 48.174785] systemd[1]: Reloading... machine # [ 48.807813] systemd[1]: Reloading finished in 630 ms. machine # [ 48.952776] systemd[560]: Reexecution requested from client PID 2079 ('switch-to-confi')... machine # [ 48.956888] systemd[560]: Reexecuting. machine # [ 49.018391] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.197637] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.204666] systemd[560]: Reload requested from client PID 2079 ('switch-to-confi')... machine # [ 49.206779] systemd[560]: Reloading... machine # [ 49.394231] systemd[560]: Reloading finished in 186 ms. machine # [ 49.412199] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.422622] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 49.425182] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 49.428405] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 49.479416] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 49.484953] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 49.488633] systemd[1]: Stopping Reactivate sysinit units... machine # [ 49.489512] systemd[1]: Reached target Reactivate sysinit units. machine # [ 49.490337] systemd[1]: test.service: Deactivated successfully. machine # [ 49.491233] systemd[1]: Stopped test.service. machine # [ 49.491891] systemd[1]: Stopping test.service... machine # [ 49.495115] systemd[1]: Starting test.service... machine # [ 49.534703] systemd[1]: Finished test.service. machine # [ 49.539575] systemd[1]: Reached target Local File Systems. machine # [ 49.543548] systemd[1]: Reached target Remote File Systems. machine # [ 49.549138] systemd[1]: Starting linger-users.service... machine # [ 49.554606] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 49.562804] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 49.563816] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 49.576633] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 49.578893] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 49.582865] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.586207] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.588513] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.591419] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 49.658679] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 49.662113] systemd[1]: Finished linger-users.service. machine # [ 49.945688] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 49.949055] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 50.206141] nixos[2010]: finished switching to system configuration /nix/store/cxhwm59m0fgjyyhyqnb02hzn66jf0prk-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.16 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 50.857814] nixos[2152]: switching to system configuration /nix/store/19a4q3aiwb16kmq58cznmv6dwvb1axyj-nixos-system-machine-test machine # [ 50.861218] systemd[1]: Stopped target Local File Systems. machine # [ 50.862627] systemd[1]: Stopped target Remote File Systems. machine # [ 51.374490] systemd[1]: Reload requested from client PID 2152 ('.switch-to-conf') (unit backdoor.service)... machine # [ 51.376867] systemd[1]: Reloading... machine # [ 52.052779] systemd[1]: Reloading finished in 673 ms. machine # [ 52.204438] systemd[560]: Reexecution requested from client PID 2221 ('switch-to-confi')... machine # [ 52.205901] systemd[560]: Reexecuting. machine # [ 52.270427] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.472778] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.479945] systemd[560]: Reload requested from client PID 2221 ('switch-to-confi')... machine # [ 52.482642] systemd[560]: Reloading... machine # [ 52.678088] systemd[560]: Reloading finished in 194 ms. machine # [ 52.692200] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.701931] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 52.704626] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 52.707675] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 52.754609] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 52.759016] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 52.763484] systemd[1]: Stopping Reactivate sysinit units... machine # [ 52.765196] systemd[1]: Reached target Reactivate sysinit units. machine # [ 52.767481] systemd[1]: Reloading test.service... machine # [ 52.804188] systemd[1]: Reloaded test.service. machine # [ 52.806633] systemd[1]: Reached target Remote File Systems. machine # [ 52.815037] systemd[1]: Reached target Local File Systems. machine # [ 52.818490] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 52.822959] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 52.823898] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 52.832742] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 52.835022] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 52.840806] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.842178] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.843411] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.844787] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 53.166229] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 53.171085] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 53.173858] systemd[1]: Starting linger-users.service... machine # [ 53.238961] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 53.241996] systemd[1]: Finished linger-users.service. machine # [ 53.499952] nixos[2152]: finished switching to system configuration /nix/store/19a4q3aiwb16kmq58cznmv6dwvb1axyj-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 3.29 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 54.147394] nixos[2294]: switching to system configuration /nix/store/nx6l9vsfd584jdskbz0fsnwf1p8m5iii-nixos-system-machine-test machine # [ 54.150003] systemd[1]: Stopped target Local File Systems. machine # [ 54.152149] systemd[1]: Stopped target Remote File Systems. machine # [ 54.668929] systemd[1]: Reload requested from client PID 2294 ('.switch-to-conf') (unit backdoor.service)... machine # [ 54.670994] systemd[1]: Reloading... machine # [ 55.350444] systemd[1]: Reloading finished in 677 ms. machine # [ 55.510010] systemd[560]: Reexecution requested from client PID 2363 ('switch-to-confi')... machine # [ 55.513969] systemd[560]: Reexecuting. machine # [ 55.566400] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.766206] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.774027] systemd[560]: Reload requested from client PID 2363 ('switch-to-confi')... machine # [ 55.776700] systemd[560]: Reloading... machine # [ 55.970784] systemd[560]: Reloading finished in 192 ms. machine # [ 55.985646] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.995275] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 55.997666] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 56.000529] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 56.051557] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 56.056462] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 56.059380] systemd[1]: Stopping Reactivate sysinit units... machine # [ 56.061345] systemd[1]: Reached target Reactivate sysinit units. machine # [ 56.063373] systemd[1]: Reached target Remote File Systems. machine # [ 56.066799] systemd[1]: Reached target Local File Systems. machine # [ 56.070680] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 56.075003] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 56.075914] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 56.080675] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 56.088308] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 56.090070] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.091377] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.098066] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.099418] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 56.440218] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 56.444308] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 56.448347] systemd[1]: Starting linger-users.service... machine # [ 56.511263] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 56.513946] systemd[1]: Finished linger-users.service. machine # [ 56.773929] nixos[2294]: finished switching to system configuration /nix/store/nx6l9vsfd584jdskbz0fsnwf1p8m5iii-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 3.27 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.68 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 57.982018] nixos[2444]: switching to system configuration /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test machine # [ 57.986013] systemd[1]: Stopped target Local File Systems. machine # [ 57.987820] systemd[1]: Stopped target Remote File Systems. machine # [ 57.989309] systemd[1]: test.service: Deactivated successfully. machine # [ 57.990591] systemd[1]: Stopped test.service. machine # [ 58.455676] systemd[1]: Reload requested from client PID 2444 ('.switch-to-conf') (unit backdoor.service)... machine # [ 58.457980] systemd[1]: Reloading... machine # [ 59.072943] systemd[1]: Reloading finished in 612 ms. machine # [ 59.224057] systemd[560]: Reexecution requested from client PID 2513 ('switch-to-confi')... machine # [ 59.226951] systemd[560]: Reexecuting. machine # [ 59.294361] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.499131] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.505873] systemd[560]: Reload requested from client PID 2513 ('switch-to-confi')... machine # [ 59.508405] systemd[560]: Reloading... machine # [ 59.708689] systemd[560]: Reloading finished in 199 ms. machine # [ 59.724174] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.733575] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 59.735946] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 59.738967] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 59.786912] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 59.791078] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 59.794356] systemd[1]: Stopping Reactivate sysinit units... machine # [ 59.795252] systemd[1]: Reached target Reactivate sysinit units. machine # [ 59.797970] systemd[1]: Reached target Remote File Systems. machine # [ 59.798816] systemd[1]: Reached target Local File Systems. machine # [ 59.805547] systemd[1]: Starting linger-users.service... machine # [ 59.813377] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.817321] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 59.823105] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 59.827392] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 59.828989] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 59.830638] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 59.834815] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 59.840190] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.841738] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.905305] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 59.908749] systemd[1]: Finished linger-users.service. machine # [ 60.225234] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 60.228798] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 60.487423] nixos[2444]: finished switching to system configuration /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.03 seconds) machine: must succeed: /nix/store/5j9pwaqdmlg5jgdqki7vdldix56qqmhm-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 61.101780] nixos[2584]: switching to system configuration /nix/store/iwsy3idcpgnc7kgprgjnqcn96hk7vki3-nixos-system-machine-test machine # [ 61.105439] systemd[1]: Stopped target Local File Systems. machine # [ 61.106566] systemd[1]: Stopped target Remote File Systems. machine # [ 61.629956] systemd[1]: Reload requested from client PID 2584 ('.switch-to-conf') (unit backdoor.service)... machine # [ 61.631962] systemd[1]: Reloading... machine # [ 62.239130] systemd[1]: Reloading finished in 604 ms. machine # [ 62.398916] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 62.403301] systemd[560]: Reexecution requested from client PID 2653 ('switch-to-confi')... machine # [ 62.405671] systemd[560]: Reexecuting. machine # [ 62.475307] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.683261] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.690206] systemd[560]: Reload requested from client PID 2653 ('switch-to-confi')... machine # [ 62.692749] systemd[560]: Reloading... machine # [ 62.885685] systemd[560]: Reloading finished in 191 ms. machine # [ 62.900204] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.912759] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 62.915892] systemd[1]: Stopping Reactivate sysinit units... machine # [ 62.917922] systemd[1]: Reached target Reactivate sysinit units. machine # [ 62.918907] systemd[1]: Reached target Remote File Systems. machine # [ 62.922633] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.925343] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 62.930384] systemd[1]: Reached target Local File Systems. machine # [ 62.931347] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 62.937731] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 62.938756] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 62.942430] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 62.953024] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 62.954707] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.959658] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.320134] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 63.322440] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 63.328342] systemd[1]: Starting linger-users.service... machine # [ 63.332874] systemd[1]: Starting test.service... machine # [ 63.380450] systemd[1]: Finished test.service. machine # [ 63.410910] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 63.413618] systemd[1]: Finished linger-users.service. machine # [ 63.672608] nixos[2584]: finished switching to system configuration /nix/store/iwsy3idcpgnc7kgprgjnqcn96hk7vki3-nixos-system-machine-test machine: (finished: must succeed: /nix/store/5j9pwaqdmlg5jgdqki7vdldix56qqmhm-separate-activation-script/bin/switch-to-configuration test 2>&1, in 3.18 seconds) machine: must succeed: ! test -e /run/current-system/activate machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.04 seconds) machine: must succeed: ! test -e /run/current-system/dry-activate machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.03 seconds) machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.03 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 64.381369] nixos[2732]: switching to system configuration /nix/store/ycjnnxs5755s9w6rd2xc87sz3aac0ahg-nixos-system-machine-test machine # [ 64.384906] systemd[1]: Stopped target Remote File Systems. machine # [ 64.387151] systemd[1]: Stopped target Local File Systems. machine # [ 64.389753] systemd[1]: test.service: Deactivated successfully. machine # [ 64.390798] systemd[1]: Stopped test.service. machine # [ 64.899253] systemd[1]: Reload requested from client PID 2732 ('.switch-to-conf') (unit backdoor.service)... machine # [ 64.901486] systemd[1]: Reloading... machine # [ 65.533379] systemd[1]: Reloading finished in 629 ms. machine # [ 65.678954] systemd[560]: Reexecution requested from client PID 2801 ('switch-to-confi')... machine # [ 65.681398] systemd[560]: Reexecuting. machine # [ 65.742454] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.931734] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.938855] systemd[560]: Reload requested from client PID 2801 ('switch-to-confi')... machine # [ 65.941711] systemd[560]: Reloading... machine # [ 66.137691] systemd[560]: Reloading finished in 194 ms. machine # [ 66.152218] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.163930] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 66.214523] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 66.218851] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 66.219905] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 66.223922] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 66.227175] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 66.229577] systemd[1]: Stopping Reactivate sysinit units... machine # [ 66.230404] systemd[1]: Reached target Reactivate sysinit units. machine # [ 66.247499] systemd[1]: Reached target Remote File Systems. machine # [ 66.251797] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.258428] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 66.259883] systemd[1]: Started test.service. machine # [ 66.276201] systemd[1]: Starting linger-users.service... machine # [ 66.278633] systemd[1]: Reached target Local File Systems. machine # [ 66.296976] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 66.312660] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 66.321199] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 66.324410] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 66.332977] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 66.334760] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.336684] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.339087] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 66.358336] systemd[1]: test.service: Deactivated successfully. machine # [ 66.416788] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 66.421038] systemd[1]: Finished linger-users.service. machine # [ 66.707088] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 66.710559] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 66.967198] nixos[2732]: finished switching to system configuration /nix/store/ycjnnxs5755s9w6rd2xc87sz3aac0ahg-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 3.19 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 67.628553] nixos[2877]: switching to system configuration /nix/store/3r20fzmn151zapywszlv9l3ddy3qb0g8-nixos-system-machine-test machine # [ 67.631906] systemd[1]: Stopped target Local File Systems. machine # [ 67.633536] systemd[1]: Stopped target Remote File Systems. machine # [ 68.161372] systemd[1]: Reload requested from client PID 2877 ('.switch-to-conf') (unit backdoor.service)... machine # [ 68.163400] systemd[1]: Reloading... machine # [ 68.849689] systemd[1]: Reloading finished in 682 ms. machine # [ 69.002930] systemd[560]: Reexecution requested from client PID 2946 ('switch-to-confi')... machine # [ 69.006853] systemd[560]: Reexecuting. machine # [ 69.070434] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.271087] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.278077] systemd[560]: Reload requested from client PID 2946 ('switch-to-confi')... machine # [ 69.280811] systemd[560]: Reloading... machine # [ 69.478431] systemd[560]: Reloading finished in 196 ms. machine # [ 69.493669] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.501929] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 69.504893] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 69.508063] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 69.555459] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 69.560877] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 69.561836] systemd[1]: Stopping Reactivate sysinit units... machine # [ 69.562618] systemd[1]: Reached target Reactivate sysinit units. machine # [ 69.566990] systemd[1]: Reached target Local File Systems. machine # [ 69.570636] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 69.575812] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 69.580450] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 69.581729] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 69.583907] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 69.594037] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.595662] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.599441] systemd[1]: Reached target Remote File Systems. machine # [ 69.600819] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.602606] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 69.924083] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 69.928584] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 69.932379] systemd[1]: Starting escaped\x2ddash.service... machine # [ 69.935304] systemd[1]: Starting linger-users.service... machine # [ 69.981991] systemd[1]: Finished escaped\x2ddash.service. machine # [ 70.012204] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 70.013248] systemd[1]: Finished linger-users.service. machine # [ 70.270565] nixos[2877]: finished switching to system configuration /nix/store/3r20fzmn151zapywszlv9l3ddy3qb0g8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 3.30 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 70.931357] nixos[3019]: switching to system configuration /nix/store/hzhw4rr790wndv526231dwixdjvqv89k-nixos-system-machine-test machine # [ 70.935585] systemd[1]: Stopped target Local File Systems. machine # [ 70.937582] systemd[1]: Stopped target Remote File Systems. machine # [ 70.938452] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 70.939423] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 71.451399] systemd[1]: Reload requested from client PID 3019 ('.switch-to-conf') (unit backdoor.service)... machine # [ 71.453705] systemd[1]: Reloading... machine # [ 72.080332] systemd[1]: Reloading finished in 624 ms. machine # [ 72.227388] systemd[560]: Reexecution requested from client PID 3088 ('switch-to-confi')... machine # [ 72.231402] systemd[560]: Reexecuting. machine # [ 72.278246] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.473364] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.480637] systemd[560]: Reload requested from client PID 3088 ('switch-to-confi')... machine # [ 72.483007] systemd[560]: Reloading... machine # [ 72.679465] systemd[560]: Reloading finished in 195 ms. machine # [ 72.692162] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.702460] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 72.703611] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 72.706600] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 72.754626] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 72.758816] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 72.761486] systemd[1]: Stopping Reactivate sysinit units... machine # [ 72.762959] systemd[1]: Reached target Reactivate sysinit units. machine # [ 72.768095] systemd[1]: Starting escaped\x2ddash.service... machine # [ 72.770909] systemd[1]: Reached target Local File Systems. machine # [ 72.774833] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 72.782234] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 72.783612] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 72.789488] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 72.791953] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 72.801357] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.811357] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.813379] systemd[1]: Reached target Remote File Systems. machine # [ 72.816236] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.818191] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 72.841792] systemd[1]: Finished escaped\x2ddash.service. machine # [ 73.160315] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 73.164659] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 73.168386] systemd[1]: Starting linger-users.service... machine # [ 73.232870] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 73.235673] systemd[1]: Finished linger-users.service. machine # [ 73.494045] nixos[3019]: finished switching to system configuration /nix/store/hzhw4rr790wndv526231dwixdjvqv89k-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 3.23 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 74.162775] nixos[3161]: switching to system configuration /nix/store/581kzc00wd5g1nngc919zxfygj3x9dbi-nixos-system-machine-test machine # [ 74.166892] systemd[1]: Stopped target Local File Systems. machine # [ 74.168781] systemd[1]: Stopped target Remote File Systems. machine # [ 74.169687] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 74.170641] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 74.743717] systemd[1]: Reload requested from client PID 3161 ('.switch-to-conf') (unit backdoor.service)... machine # [ 74.746137] systemd[1]: Reloading... machine # [ 75.417822] systemd[1]: Reloading finished in 668 ms. machine # [ 75.565599] systemd[560]: Reexecution requested from client PID 3230 ('switch-to-confi')... machine # [ 75.570098] systemd[560]: Reexecuting. machine # [ 75.634567] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.835821] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.843337] systemd[560]: Reload requested from client PID 3230 ('switch-to-confi')... machine # [ 75.845999] systemd[560]: Reloading... machine # [ 76.044641] systemd[560]: Reloading finished in 197 ms. machine # [ 76.061733] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.069794] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 76.072157] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 76.075469] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 76.124435] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 76.128714] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 76.130600] systemd[1]: Stopping Reactivate sysinit units... machine # [ 76.132424] systemd[1]: Reached target Reactivate sysinit units. machine # [ 76.136188] systemd[1]: Reached target Remote File Systems. machine # [ 76.140253] systemd[1]: Starting -.service... machine # [ 76.142930] systemd[1]: Starting linger-users.service... machine # [ 76.147334] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.157873] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 76.162595] systemd[1]: Reached target Local File Systems. machine # [ 76.165738] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 76.171349] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 76.173144] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 76.175895] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 76.186937] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 76.192499] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.195877] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.231046] systemd[1]: Finished -.service. machine # [ 76.267503] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 76.271008] systemd[1]: Finished linger-users.service. machine # [ 76.575071] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 76.579047] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 76.838937] nixos[3161]: finished switching to system configuration /nix/store/581kzc00wd5g1nngc919zxfygj3x9dbi-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 3.34 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 77.534889] nixos[3303]: switching to system configuration /nix/store/xvw6jkq06xbqkslqk48cdpqnbbs65g80-nixos-system-machine-test machine # [ 77.538035] systemd[1]: Stopped target Local File Systems. machine # [ 77.539557] systemd[1]: Stopped target Remote File Systems. machine # [ 78.078225] systemd[1]: Reload requested from client PID 3303 ('.switch-to-conf') (unit backdoor.service)... machine # [ 78.080411] systemd[1]: Reloading... machine # [ 78.787884] systemd[1]: Reloading finished in 705 ms. machine # [ 78.943336] systemd[560]: Reexecution requested from client PID 3372 ('switch-to-confi')... machine # [ 78.945818] systemd[560]: Reexecuting. machine # [ 79.014345] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.225395] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.232158] systemd[560]: Reload requested from client PID 3372 ('switch-to-confi')... machine # [ 79.234959] systemd[560]: Reloading... machine # [ 79.447919] systemd[560]: Reloading finished in 211 ms. machine # [ 79.464212] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.475104] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 79.477769] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 79.480908] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 79.534340] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 79.539059] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 79.543624] systemd[1]: Stopping Reactivate sysinit units... machine # [ 79.544950] systemd[1]: Reached target Reactivate sysinit units. machine # [ 79.547775] systemd[1]: Reloading -.service... machine # [ 79.587575] systemd[1]: Reloaded -.service. machine # [ 79.593439] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.597871] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 79.599736] systemd[1]: Reached target Local File Systems. machine # [ 79.603126] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 79.610427] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 79.611452] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 79.617257] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 79.624323] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 79.625984] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.627332] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.629677] systemd[1]: Reached target Remote File Systems. machine # [ 80.015378] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 80.020548] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 80.023291] systemd[1]: Starting linger-users.service... machine # [ 80.090624] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 80.093893] systemd[1]: Finished linger-users.service. machine # [ 80.351116] nixos[3303]: finished switching to system configuration /nix/store/xvw6jkq06xbqkslqk48cdpqnbbs65g80-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 3.51 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 81.052490] nixos[3445]: switching to system configuration /nix/store/z525138f6qpi297g4dv1q75n4yglp60d-nixos-system-machine-test machine # [ 81.056618] systemd[1]: Stopped target Local File Systems. machine # [ 81.059122] systemd[1]: Stopped target Remote File Systems. machine # [ 81.060222] systemd[1]: -.service: Deactivated successfully. machine # [ 81.061556] systemd[1]: Stopped -.service. machine # [ 81.603376] systemd[1]: Reload requested from client PID 3445 ('.switch-to-conf') (unit backdoor.service)... machine # [ 81.605618] systemd[1]: Reloading... machine # [ 82.307459] systemd[1]: Reloading finished in 699 ms. machine # [ 82.462418] systemd[560]: Reexecution requested from client PID 3514 ('switch-to-confi')... machine # [ 82.463991] systemd[560]: Reexecuting. machine # [ 82.535034] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.750242] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.757511] systemd[560]: Reload requested from client PID 3514 ('switch-to-confi')... machine # [ 82.760833] systemd[560]: Reloading... machine # [ 82.964898] systemd[560]: Reloading finished in 205 ms. machine # [ 82.980243] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.992113] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 82.993241] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 82.997108] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 83.049351] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 83.053937] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 83.055860] systemd[1]: Stopping Reactivate sysinit units... machine # [ 83.057596] systemd[1]: Reached target Reactivate sysinit units. machine # [ 83.059528] systemd[1]: Reached target Remote File Systems. machine # [ 83.066648] systemd[1]: Reached target Local File Systems. machine # [ 83.070508] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 83.075210] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 83.080346] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 83.081659] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 83.083795] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 83.091673] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.094926] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.096738] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.098990] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 83.441810] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 83.446456] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 83.450567] systemd[1]: Starting linger-users.service... machine # [ 83.453102] systemd[1]: Starting required-service.service... machine # [ 83.461367] systemd[1]: Starting test-service.service... machine # [ 83.513953] systemd[1]: Finished required-service.service. machine # [ 83.516528] systemd[1]: Finished test-service.service. machine # [ 83.547690] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 83.550003] systemd[1]: Finished linger-users.service. machine # [ 83.810885] nixos[3445]: finished switching to system configuration /nix/store/z525138f6qpi297g4dv1q75n4yglp60d-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 3.46 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 84.509608] nixos[3589]: switching to system configuration /nix/store/0pfy2x2ba7sjicf510qhcqllgshs5fqk-nixos-system-machine-test machine # [ 84.514113] systemd[1]: Stopped target Local File Systems. machine # [ 84.516493] systemd[1]: Stopped target Remote File Systems. machine # [ 84.517389] systemd[1]: required-service.service: Deactivated successfully. machine # [ 84.518378] systemd[1]: Stopped required-service.service. machine # [ 84.519157] systemd[1]: test-service.service: Deactivated successfully. machine # [ 84.521121] systemd[1]: Stopped test-service.service. machine # [ 85.058341] systemd[1]: Reload requested from client PID 3589 ('.switch-to-conf') (unit backdoor.service)... machine # [ 85.060567] systemd[1]: Reloading... machine # [ 85.731424] systemd[1]: Reloading finished in 668 ms. machine # [ 85.872420] systemd[560]: Reexecution requested from client PID 3658 ('switch-to-confi')... machine # [ 85.875707] systemd[560]: Reexecuting. machine # [ 85.938519] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.121181] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.127919] systemd[560]: Reload requested from client PID 3658 ('switch-to-confi')... machine # [ 86.132128] systemd[560]: Reloading... machine # [ 86.325149] systemd[560]: Reloading finished in 193 ms. machine # [ 86.340195] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.350852] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 86.353502] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 86.356701] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 86.409389] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 86.413886] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 86.415883] systemd[1]: Stopping Reactivate sysinit units... machine # [ 86.417303] systemd[1]: Reached target Reactivate sysinit units. machine # [ 86.427382] systemd[1]: Starting required-service.service... machine # [ 86.430995] systemd[1]: Starting test-service.service... machine # [ 86.437472] systemd[1]: Reached target Remote File Systems. machine # [ 86.442462] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.456444] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 86.458107] systemd[1]: Reached target Local File Systems. machine # [ 86.459231] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 86.474097] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 86.475094] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 86.483333] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 86.488390] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 86.490689] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.493934] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.520993] systemd[1]: Finished required-service.service. machine # [ 86.529667] systemd[1]: Finished test-service.service. machine # [ 86.814737] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 86.819625] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 86.822254] systemd[1]: Starting linger-users.service... machine # [ 86.884159] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 86.886953] systemd[1]: Finished linger-users.service. machine # [ 87.145133] nixos[3589]: finished switching to system configuration /nix/store/0pfy2x2ba7sjicf510qhcqllgshs5fqk-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 3.34 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 87.797720] nixos[3733]: switching to system configuration /nix/store/5cbv8yaj2flm19d5rlmhvf0zy5ns26zj-nixos-system-machine-test machine # [ 87.801715] systemd[1]: Stopped target Local File Systems. machine # [ 87.803858] systemd[1]: Stopped target Remote File Systems. machine # [ 87.805625] systemd[1]: required-service.service: Deactivated successfully. machine # [ 87.806613] systemd[1]: Stopped required-service.service. machine # [ 87.807382] systemd[1]: test-service.service: Deactivated successfully. machine # [ 87.808484] systemd[1]: Stopped test-service.service. machine # [ 88.339678] systemd[1]: Reload requested from client PID 3733 ('.switch-to-conf') (unit backdoor.service)... machine # [ 88.341961] systemd[1]: Reloading... machine # [ 89.042145] systemd[1]: Reloading finished in 697 ms. machine # [ 89.194699] systemd[560]: Reexecution requested from client PID 3802 ('switch-to-confi')... machine # [ 89.198405] systemd[560]: Reexecuting. machine # [ 89.262148] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.463617] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.470602] systemd[560]: Reload requested from client PID 3802 ('switch-to-confi')... machine # [ 89.473397] systemd[560]: Reloading... machine # [ 89.667407] systemd[560]: Reloading finished in 192 ms. machine # [ 89.680180] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.690683] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 89.693616] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 89.696948] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 89.749044] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 89.753797] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 89.756702] systemd[1]: Stopping Reactivate sysinit units... machine # [ 89.758114] systemd[1]: Reached target Reactivate sysinit units. machine # [ 89.762985] systemd[1]: Reached target Local File Systems. machine # [ 89.766767] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 89.771079] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 89.772002] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 89.780111] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 89.782497] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 89.785846] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.790385] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.793260] systemd[1]: Reached target Remote File Systems. machine # [ 89.797370] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.800502] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 90.130087] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 90.135190] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 90.139390] systemd[1]: Starting linger-users.service... machine # [ 90.143641] systemd[1]: Starting required-service.service... machine # [ 90.147093] systemd[1]: Starting test-service.service... machine # [ 90.201267] systemd[1]: Finished required-service.service. machine # [ 90.203950] systemd[1]: Finished test-service.service. machine # [ 90.231030] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 90.234428] systemd[1]: Finished linger-users.service. machine # [ 90.491161] nixos[3733]: finished switching to system configuration /nix/store/5cbv8yaj2flm19d5rlmhvf0zy5ns26zj-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 3.34 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 91.157637] nixos[3877]: switching to system configuration /nix/store/qw578f50pkddf803lnssgzxdvzrd976q-nixos-system-machine-test machine # [ 91.162165] systemd[1]: Stopped target Local File Systems. machine # [ 91.165266] systemd[1]: Stopped target Remote File Systems. machine # [ 91.166356] systemd[1]: required-service.service: Deactivated successfully. machine # [ 91.167460] systemd[1]: Stopped required-service.service. machine # [ 91.168867] systemd[1]: test-service.service: Deactivated successfully. machine # [ 91.169836] systemd[1]: Stopped test-service.service. machine # [ 91.691982] systemd[1]: Reload requested from client PID 3877 ('.switch-to-conf') (unit backdoor.service)... machine # [ 91.693997] systemd[1]: Reloading... machine # [ 92.341594] systemd[1]: Reloading finished in 645 ms. machine # [ 92.486797] systemd[560]: Reexecution requested from client PID 3946 ('switch-to-confi')... machine # [ 92.491181] systemd[560]: Reexecuting. machine # [ 92.554340] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.752747] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.760206] systemd[560]: Reload requested from client PID 3946 ('switch-to-confi')... machine # [ 92.762871] systemd[560]: Reloading... machine # [ 92.953381] systemd[560]: Reloading finished in 189 ms. machine # [ 92.968188] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.977673] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 92.980211] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 92.983248] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 93.033306] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 93.038126] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 93.040607] systemd[1]: Stopping Reactivate sysinit units... machine # [ 93.042082] systemd[1]: Reached target Reactivate sysinit units. machine # [ 93.047625] systemd[1]: Created slice Slice /system/instantiated. machine # [ 93.049628] systemd[1]: Reached target Remote File Systems. machine # [ 93.056481] systemd[1]: Starting instantiated@one.service... machine # [ 93.060235] systemd[1]: Starting instantiated@two.service... machine # [ 93.065323] systemd[1]: Starting linger-users.service... machine # [ 93.081055] systemd[1]: Reached target Local File Systems. machine # [ 93.084399] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 93.101038] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 93.102139] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 93.103477] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 93.125635] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 93.129553] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.133820] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.138293] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.139994] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 93.183530] systemd[1]: Finished instantiated@one.service. machine # [ 93.184989] systemd[1]: Finished instantiated@two.service. machine # [ 93.230658] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 93.234548] systemd[1]: Finished linger-users.service. machine # [ 93.534426] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 93.537598] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 93.798559] nixos[3877]: finished switching to system configuration /nix/store/qw578f50pkddf803lnssgzxdvzrd976q-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 3.31 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 94.417492] nixos[4021]: switching to system configuration /nix/store/22d0cl8chysykxabhy05rsrnmbx1h3ac-nixos-system-machine-test machine # [ 94.420308] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 94.425193] systemd[1]: Stopped instantiated@one.service. machine # [ 94.426460] systemd[1]: Stopped target Remote File Systems. machine # [ 94.427803] systemd[1]: Stopped target Local File Systems. machine # [ 94.429084] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 94.430516] systemd[1]: Stopped instantiated@two.service. machine # [ 94.965913] systemd[1]: Reload requested from client PID 4021 ('.switch-to-conf') (unit backdoor.service)... machine # [ 94.967903] systemd[1]: Reloading... machine # [ 95.627405] systemd[1]: Reloading finished in 657 ms. machine # [ 95.780745] systemd[560]: Reexecution requested from client PID 4089 ('switch-to-confi')... machine # [ 95.783701] systemd[560]: Reexecuting. machine # [ 95.842216] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.022542] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.030046] systemd[560]: Reload requested from client PID 4089 ('switch-to-confi')... machine # [ 96.032921] systemd[560]: Reloading... machine # [ 96.227527] systemd[560]: Reloading finished in 193 ms. machine # [ 96.240209] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.250254] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 96.252980] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 96.256107] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 96.306116] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 96.311394] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 96.314234] systemd[1]: Stopping Reactivate sysinit units... machine # [ 96.319429] systemd[1]: Reached target Reactivate sysinit units. machine # [ 96.321364] systemd[1]: Reached target Remote File Systems. machine # [ 96.324403] systemd[1]: Starting instantiated@one.service... machine # [ 96.330403] systemd[1]: Starting instantiated@two.service... machine # [ 96.336448] systemd[1]: Starting linger-users.service... machine # [ 96.354924] systemd[1]: Reached target Local File Systems. machine # [ 96.361994] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.363505] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 96.369663] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 96.381999] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 96.382996] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 96.390108] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 96.397718] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 96.399488] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.407089] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.439584] systemd[1]: Finished instantiated@one.service. machine # [ 96.443601] systemd[1]: Finished instantiated@two.service. machine # [ 96.490114] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 96.494741] systemd[1]: Finished linger-users.service. machine # [ 96.799414] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 96.802880] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 97.061014] nixos[4021]: finished switching to system configuration /nix/store/22d0cl8chysykxabhy05rsrnmbx1h3ac-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 3.26 seconds) (finished: subtest: services, in 69.78 seconds) subtest: failing units machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 97.675336] nixos[4165]: switching to system configuration /nix/store/68g3ac6i44dp6spfylk9v6fm02jjd1wi-nixos-system-machine-test machine # [ 97.678389] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 97.682347] systemd[1]: Stopped instantiated@one.service. machine # [ 97.683345] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 97.685430] systemd[1]: Stopped instantiated@two.service. machine # [ 97.686598] systemd[1]: Stopped target Remote File Systems. machine # [ 97.687713] systemd[1]: Stopped target Local File Systems. machine # [ 98.161587] systemd[1]: Reload requested from client PID 4165 ('.switch-to-conf') (unit backdoor.service)... machine # [ 98.163690] systemd[1]: Reloading... machine # [ 98.782211] systemd[1]: Reloading finished in 615 ms. machine # [ 98.937441] systemd[560]: Reexecution requested from client PID 4234 ('switch-to-confi')... machine # [ 98.942001] systemd[560]: Reexecuting. machine # [ 99.002198] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.201436] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.208185] systemd[560]: Reload requested from client PID 4234 ('switch-to-confi')... machine # [ 99.210791] systemd[560]: Reloading... machine # [ 99.410981] systemd[560]: Reloading finished in 199 ms. machine # [ 99.424189] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.434365] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 99.435532] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 99.439952] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 99.487532] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 99.491770] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 99.493545] systemd[1]: Stopping Reactivate sysinit units... machine # [ 99.494402] systemd[1]: Reached target Reactivate sysinit units. machine # [ 99.498936] systemd[1]: Reached target Remote File Systems. machine # [ 99.507770] systemd[1]: Starting linger-users.service... machine # [ 99.511252] systemd[1]: Starting test.service... machine # [ 99.519447] systemd[1]: Reached target Local File Systems. machine # [ 99.525904] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 99.527548] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 99.542711] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 99.544490] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 99.546731] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 99.551043] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.553367] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.555957] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.558792] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 99.592468] systemd[1]: Finished test.service. machine # [ 99.630390] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 99.631540] systemd[1]: Finished linger-users.service. machine # [ 99.933258] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 99.936253] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 100.194733] nixos[4165]: finished switching to system configuration /nix/store/68g3ac6i44dp6spfylk9v6fm02jjd1wi-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 3.13 seconds) machine: must fail: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 100.820447] nixos[4307]: switching to system configuration /nix/store/hn4mvjjh5fnr12ds0aw5bqyvjbd3g577-nixos-system-machine-test machine # [ 100.823752] systemd[1]: test.service: Deactivated successfully. machine # [ 100.825860] systemd[1]: Stopped test.service. machine # [ 100.826607] systemd[1]: Stopped target Local File Systems. machine # [ 100.828061] systemd[1]: Stopped target Remote File Systems. machine # [ 101.346918] systemd[1]: Reload requested from client PID 4307 ('.switch-to-conf') (unit backdoor.service)... machine # [ 101.349348] systemd[1]: Reloading... machine # [ 101.961535] systemd[1]: Reloading finished in 609 ms. machine # [ 102.119101] systemd[560]: Reexecution requested from client PID 4376 ('switch-to-confi')... machine # [ 102.123036] systemd[560]: Reexecuting. machine # [ 102.174049] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 102.375692] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 102.383458] systemd[560]: Reload requested from client PID 4376 ('switch-to-confi')... machine # [ 102.386820] systemd[560]: Reloading... machine # [ 102.568630] systemd[560]: Reloading finished in 182 ms. machine # [ 102.584325] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 102.596585] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 102.599329] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 102.602859] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 102.655325] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 102.660714] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 102.662912] systemd[1]: Stopping Reactivate sysinit units... machine # [ 102.664884] systemd[1]: Reached target Reactivate sysinit units. machine # [ 102.674191] systemd[1]: Starting test.service... machine # [ 102.687312] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 102.691971] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 102.694095] systemd[1]: Reached target Local File Systems. machine # [ 102.695009] systemd[1]: Reached target Remote File Systems. machine # [ 102.699800] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 102.709056] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 102.710159] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 102.711450] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 102.714181] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 102.718725] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 102.721101] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 102.751643] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 102.756427] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 102.757800] systemd[1]: Failed to start test.service. machine # [ 103.108804] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 103.114306] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 103.117113] systemd[1]: Starting linger-users.service... machine # [ 103.190324] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 103.193232] systemd[1]: Finished linger-users.service. machine # [ 103.502862] nixos[4307]: switching to system configuration /nix/store/hn4mvjjh5fnr12ds0aw5bqyvjbd3g577-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 3.30 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 104.160188] nixos[4450]: switching to system configuration /nix/store/3lbv0h1lp0xhm8kpzhfhsdkx77rml1bz-nixos-system-machine-test machine # [ 104.163699] systemd[1]: Stopped target Local File Systems. machine # [ 104.165060] systemd[1]: Stopped target Remote File Systems. machine # [ 104.733108] systemd[1]: Reload requested from client PID 4450 ('.switch-to-conf') (unit backdoor.service)... machine # [ 104.735258] systemd[1]: Reloading... machine # [ 105.446060] systemd[1]: Reloading finished in 707 ms. machine # [ 105.607310] systemd[560]: Reexecution requested from client PID 4519 ('switch-to-confi')... machine # [ 105.611131] systemd[560]: Reexecuting. machine # [ 105.667245] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.872261] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.878854] systemd[560]: Reload requested from client PID 4519 ('switch-to-confi')... machine # [ 105.881506] systemd[560]: Reloading... machine # [ 106.084103] systemd[560]: Reloading finished in 201 ms. machine # [ 106.100176] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 106.110429] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 106.112921] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 106.115967] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 106.164142] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 106.168694] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 106.171884] systemd[1]: Stopping Reactivate sysinit units... machine # [ 106.173701] systemd[1]: Reached target Reactivate sysinit units. machine # [ 106.176633] systemd[1]: Reached target Local File Systems. machine # [ 106.179537] systemd[1]: Reached target Remote File Systems. machine # [ 106.186185] systemd[1]: Started autorestart.service. machine # [ 106.189182] systemd[1]: Starting linger-users.service... machine # [ 106.196319] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 106.197789] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 106.211777] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 106.217477] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 106.218433] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 106.219750] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 106.228334] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 106.233030] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 106.239307] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 106.269764] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 106.308905] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 106.311850] systemd[1]: Finished linger-users.service. machine # [ 106.609784] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 106.613046] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 106.872851] nixos[4450]: finished switching to system configuration /nix/store/3lbv0h1lp0xhm8kpzhfhsdkx77rml1bz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 3.37 seconds) machine # [ 106.958127] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 107.545212] nixos[4597]: switching to system configuration /nix/store/3lbv0h1lp0xhm8kpzhfhsdkx77rml1bz-nixos-system-machine-test machine # [ 107.548401] systemd[1]: Stopped target Local File Systems. machine # [ 107.549903] systemd[1]: Stopped target Remote File Systems. machine # [ 108.019097] systemd[1]: Reload requested from client PID 4597 ('.switch-to-conf') (unit backdoor.service)... machine # [ 108.021640] systemd[1]: Reloading... machine # [ 108.675868] systemd[1]: Reloading finished in 651 ms. machine # [ 108.830897] systemd[560]: Reexecution requested from client PID 4666 ('switch-to-confi')... machine # [ 108.833150] systemd[560]: Reexecuting. machine # [ 108.907456] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 109.117783] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 109.125256] systemd[560]: Reload requested from client PID 4666 ('switch-to-confi')... machine # [ 109.127862] systemd[560]: Reloading... machine # [ 109.330557] systemd[560]: Reloading finished in 201 ms. machine # [ 109.348258] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 109.358677] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 109.361405] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 109.365114] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 109.419267] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 109.423787] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 109.427221] systemd[1]: Stopping Reactivate sysinit units... machine # [ 109.428826] systemd[1]: Reached target Reactivate sysinit units. machine # [ 109.429718] systemd[1]: Reached target Remote File Systems. machine # [ 109.433022] systemd[1]: Reached target Local File Systems. machine # [ 109.442017] systemd[1]: Started autorestart.service. machine # [ 109.445189] systemd[1]: Starting linger-users.service... machine # [ 109.460892] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 109.466302] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 109.471496] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 109.474535] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 109.479051] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 109.485184] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 109.489907] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 109.491898] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 109.493866] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 109.522630] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 109.563174] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 109.565495] systemd[1]: Finished linger-users.service. machine # [ 109.857741] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 109.861108] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 110.115683] nixos[4597]: finished switching to system configuration /nix/store/3lbv0h1lp0xhm8kpzhfhsdkx77rml1bz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 3.15 seconds) machine # [ 110.172491] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 110.848309] nixos[4744]: switching to system configuration /nix/store/hidjbzmk3vnmx44yx9z4k5g58mkh8nql-nixos-system-machine-test machine # [ 110.851832] systemd[1]: Stopped target Local File Systems. machine # [ 110.854565] systemd[1]: Stopped target Remote File Systems. machine # [ 111.455594] systemd[1]: Reload requested from client PID 4744 ('.switch-to-conf') (unit backdoor.service)... machine # [ 111.458082] systemd[1]: Reloading... machine # [ 112.175441] systemd[1]: Reloading finished in 715 ms. machine # [ 112.348309] systemd[560]: Reexecution requested from client PID 4813 ('switch-to-confi')... machine # [ 112.349799] systemd[560]: Reexecuting. machine # [ 112.423041] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 112.639365] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 112.647213] systemd[560]: Reload requested from client PID 4813 ('switch-to-confi')... machine # [ 112.650916] systemd[560]: Reloading... machine # [ 112.857844] systemd[560]: Reloading finished in 208 ms. machine # [ 112.872227] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 112.883767] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 112.886502] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 112.889955] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 112.945244] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 112.949653] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 112.951592] systemd[1]: Stopping Reactivate sysinit units... machine # [ 112.953336] systemd[1]: Reached target Reactivate sysinit units. machine # [ 112.958703] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 112.961691] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 112.965076] systemd[1]: Reached target Local File Systems. machine # [ 112.968726] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 112.973312] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 112.974207] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 112.975514] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 112.979858] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 112.985753] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 112.987421] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 112.988935] systemd[1]: Reached target Remote File Systems. machine # [ 113.372290] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 113.376528] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 113.383126] systemd[1]: Started autorestart.service. machine # [ 113.386668] systemd[1]: Starting linger-users.service... machine # [ 113.435110] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 113.438700] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 113.469603] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 113.472654] systemd[1]: Finished linger-users.service. machine # [ 113.781867] nixos[4744]: switching to system configuration /nix/store/hidjbzmk3vnmx44yx9z4k5g58mkh8nql-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 3.61 seconds) (finished: subtest: failing units, in 16.72 seconds) subtest: unit file parser machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 114.344264] nixos[4887]: switching to system configuration /nix/store/cxhwm59m0fgjyyhyqnb02hzn66jf0prk-nixos-system-machine-test machine # [ 114.347047] systemd[1]: Stopped target Remote File Systems. machine # [ 114.350128] systemd[1]: Stopped target Local File Systems. machine # [ 114.351115] systemd[1]: Stopped autorestart.service. machine # [ 114.835592] systemd[1]: Reload requested from client PID 4887 ('.switch-to-conf') (unit backdoor.service)... machine # [ 114.837689] systemd[1]: Reloading... machine # [ 115.499610] systemd[1]: Reloading finished in 659 ms. machine # [ 115.669125] systemd[560]: Reexecution requested from client PID 4955 ('switch-to-confi')... machine # [ 115.673942] systemd[560]: Reexecuting. machine # [ 115.732436] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 115.937686] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 115.945192] systemd[560]: Reload requested from client PID 4955 ('switch-to-confi')... machine # [ 115.947746] systemd[560]: Reloading... machine # [ 116.151355] systemd[560]: Reloading finished in 202 ms. machine # [ 116.165651] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 116.174504] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 116.176994] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 116.180278] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 116.233391] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 116.238291] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 116.240654] systemd[1]: Stopping Reactivate sysinit units... machine # [ 116.243086] systemd[1]: Reached target Reactivate sysinit units. machine # [ 116.245783] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 116.247456] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 116.252567] systemd[1]: Reached target Remote File Systems. machine # [ 116.255856] systemd[1]: Starting linger-users.service... machine # [ 116.258816] systemd[1]: Starting test.service... machine # [ 116.275571] systemd[1]: Reached target Local File Systems. machine # [ 116.280186] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 116.281792] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 116.282641] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 116.283881] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 116.300498] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 116.303336] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 116.306562] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 116.337131] systemd[1]: Finished test.service. machine # [ 116.376532] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 116.380244] systemd[1]: Finished linger-users.service. machine # [ 116.679210] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 116.681748] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 116.943179] nixos[4887]: finished switching to system configuration /nix/store/cxhwm59m0fgjyyhyqnb02hzn66jf0prk-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.16 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 117.739860] nixos[5029]: switching to system configuration /nix/store/6zpyjdwc1fwhalkwjpx7qam5d8jzvyn3-nixos-system-machine-test machine # [ 117.743879] systemd[1]: Stopped target Local File Systems. machine # [ 117.745409] systemd[1]: Stopped target Remote File Systems. machine # [ 118.342187] systemd[1]: Reload requested from client PID 5029 ('.switch-to-conf') (unit backdoor.service)... machine # [ 118.344416] systemd[1]: Reloading... machine # [ 119.058879] systemd[1]: Reloading finished in 711 ms. machine # [ 119.237971] systemd[560]: Reexecution requested from client PID 5098 ('switch-to-confi')... machine # [ 119.241992] systemd[560]: Reexecuting. machine # [ 119.290046] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 119.494822] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 119.502278] systemd[560]: Reload requested from client PID 5098 ('switch-to-confi')... machine # [ 119.504157] systemd[560]: Reloading... machine # [ 119.706542] systemd[560]: Reloading finished in 201 ms. machine # [ 119.720177] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 119.730515] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 119.733014] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 119.736145] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 119.784337] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 119.788810] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 119.790720] systemd[1]: Stopping Reactivate sysinit units... machine # [ 119.792571] systemd[1]: Reached target Reactivate sysinit units. machine # [ 119.795810] systemd[1]: test.service: Deactivated successfully. machine # [ 119.797178] systemd[1]: Stopped test.service. machine # [ 119.798022] systemd[1]: Stopping test.service... machine # [ 119.799889] systemd[1]: Starting test.service... machine # [ 119.836742] systemd[1]: Finished test.service. machine # [ 119.842621] systemd[1]: Reached target Remote File Systems. machine # [ 119.847814] systemd[1]: Starting linger-users.service... machine # [ 119.851725] systemd[1]: Reached target Local File Systems. machine # [ 119.860570] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 119.863156] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 119.869552] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 119.874908] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 119.878008] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 119.879768] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 119.882994] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 119.885369] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 119.886661] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 119.949420] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 119.952780] systemd[1]: Finished linger-users.service. machine # [ 120.246866] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 120.250011] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 120.507304] nixos[5029]: finished switching to system configuration /nix/store/6zpyjdwc1fwhalkwjpx7qam5d8jzvyn3-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 3.57 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 121.182731] nixos[5171]: switching to system configuration /nix/store/ivmqygr8w9b4sk0kvi7adi3kanhqm2yw-nixos-system-machine-test machine # [ 121.185988] systemd[1]: Stopped target Remote File Systems. machine # [ 121.187941] systemd[1]: Stopped target Local File Systems. machine # [ 121.761249] systemd[1]: Reload requested from client PID 5171 ('.switch-to-conf') (unit backdoor.service)... machine # [ 121.763333] systemd[1]: Reloading... machine # [ 122.517809] systemd[1]: Reloading finished in 750 ms. machine # [ 122.704549] systemd[560]: Reexecution requested from client PID 5240 ('switch-to-confi')... machine # [ 122.706063] systemd[560]: Reexecuting. machine # [ 122.767343] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 122.990783] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 122.997386] systemd[560]: Reload requested from client PID 5240 ('switch-to-confi')... machine # [ 123.000157] systemd[560]: Reloading... machine # [ 123.212943] systemd[560]: Reloading finished in 211 ms. machine # [ 123.228218] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 123.240115] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 123.241255] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 123.245256] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 123.299169] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 123.305287] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 123.307180] systemd[1]: Stopping Reactivate sysinit units... machine # [ 123.309638] systemd[1]: Reached target Reactivate sysinit units. machine # [ 123.312384] systemd[1]: test.service: Deactivated successfully. machine # [ 123.313352] systemd[1]: Stopped test.service. machine # [ 123.314028] systemd[1]: Stopping test.service... machine # [ 123.318962] systemd[1]: Starting test.service... machine # [ 123.361122] systemd[1]: Finished test.service. machine # [ 123.366263] systemd[1]: Reached target Remote File Systems. machine # [ 123.373197] systemd[1]: Starting linger-users.service... machine # [ 123.377175] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 123.378675] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 123.388265] systemd[1]: Reached target Local File Systems. machine # [ 123.392621] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 123.399310] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 123.406654] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 123.407997] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 123.419351] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 123.422075] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 123.424699] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 123.497068] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 123.500409] systemd[1]: Finished linger-users.service. machine # [ 123.794213] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 123.797124] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 124.055714] nixos[5171]: finished switching to system configuration /nix/store/ivmqygr8w9b4sk0kvi7adi3kanhqm2yw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 3.55 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 124.663791] nixos[5313]: switching to system configuration /nix/store/cxhwm59m0fgjyyhyqnb02hzn66jf0prk-nixos-system-machine-test machine # [ 124.666740] systemd[1]: Stopped target Local File Systems. machine # [ 124.669108] systemd[1]: Stopped target Remote File Systems. machine # [ 125.143570] systemd[1]: Reload requested from client PID 5313 ('.switch-to-conf') (unit backdoor.service)... machine # [ 125.145970] systemd[1]: Reloading... machine # [ 125.813274] systemd[1]: Reloading finished in 664 ms. machine # [ 125.967543] systemd[560]: Reexecution requested from client PID 5382 ('switch-to-confi')... machine # [ 125.971604] systemd[560]: Reexecuting. machine # [ 126.021427] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 126.216959] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 126.225193] systemd[560]: Reload requested from client PID 5382 ('switch-to-confi')... machine # [ 126.227718] systemd[560]: Reloading... machine # [ 126.421417] systemd[560]: Reloading finished in 192 ms. machine # [ 126.436199] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 126.445451] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 126.448127] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 126.451213] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 126.498966] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 126.503340] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 126.505846] systemd[1]: Stopping Reactivate sysinit units... machine # [ 126.506729] systemd[1]: Reached target Reactivate sysinit units. machine # [ 126.510332] systemd[1]: test.service: Deactivated successfully. machine # [ 126.511255] systemd[1]: Stopped test.service. machine # [ 126.511898] systemd[1]: Stopping test.service... machine # [ 126.514522] systemd[1]: Starting test.service... machine # [ 126.555326] systemd[1]: Finished test.service. machine # [ 126.561250] systemd[1]: Reached target Remote File Systems. machine # [ 126.566145] systemd[1]: Reached target Local File Systems. machine # [ 126.569758] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 126.575126] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 126.576961] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 126.581355] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 126.584432] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 126.592000] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 126.593403] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 126.594628] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 126.595879] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 126.935394] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 126.940175] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 126.942671] systemd[1]: Starting linger-users.service... machine # [ 127.007976] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 127.010973] systemd[1]: Finished linger-users.service. machine # [ 127.268415] nixos[5313]: finished switching to system configuration /nix/store/cxhwm59m0fgjyyhyqnb02hzn66jf0prk-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.21 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 127.886713] nixos[5455]: switching to system configuration /nix/store/afgm2136r4p3baqy1mix3xs083fi8psf-nixos-system-machine-test machine # [ 127.890606] systemd[1]: Stopped target Local File Systems. machine # [ 127.891854] systemd[1]: Stopped target Remote File Systems. machine # [ 128.422084] systemd[1]: Reload requested from client PID 5455 ('.switch-to-conf') (unit backdoor.service)... machine # [ 128.424232] systemd[1]: Reloading... machine # [ 129.078165] systemd[1]: Reloading finished in 651 ms. machine # [ 129.236368] systemd[560]: Reexecution requested from client PID 5524 ('switch-to-confi')... machine # [ 129.237781] systemd[560]: Reexecuting. machine # [ 129.306252] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 129.514110] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 129.522243] systemd[560]: Reload requested from client PID 5524 ('switch-to-confi')... machine # [ 129.525141] systemd[560]: Reloading... machine # [ 129.718259] systemd[560]: Reloading finished in 192 ms. machine # [ 129.732176] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 129.741770] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 129.744138] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 129.747277] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 129.796041] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 129.800422] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 129.803036] systemd[1]: Stopping Reactivate sysinit units... machine # [ 129.804435] systemd[1]: Reached target Reactivate sysinit units. machine # [ 129.806851] systemd[1]: Reached target Local File Systems. machine # [ 129.810015] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 129.812501] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 129.815076] systemd[1]: Reached target Remote File Systems. machine # [ 129.820546] systemd[1]: Starting linger-users.service... machine # [ 129.826255] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 129.832903] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 129.839517] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 129.843029] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 129.846036] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 129.853095] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 129.854636] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 129.931968] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 129.935207] systemd[1]: Finished linger-users.service. machine # [ 130.247401] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 130.250384] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 130.510707] nixos[5455]: finished switching to system configuration /nix/store/afgm2136r4p3baqy1mix3xs083fi8psf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 3.24 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 131.143588] nixos[5595]: switching to system configuration /nix/store/iqawc7f2ic464nsznv6052vfwmyi1m25-nixos-system-machine-test machine # [ 131.147357] systemd[1]: Stopped target Local File Systems. machine # [ 131.148924] systemd[1]: Stopped target Remote File Systems. machine # [ 131.667054] systemd[1]: Reload requested from client PID 5595 ('.switch-to-conf') (unit backdoor.service)... machine # [ 131.669684] systemd[1]: Reloading... machine # [ 132.345889] systemd[1]: Reloading finished in 671 ms. machine # [ 132.494096] systemd[560]: Reexecution requested from client PID 5664 ('switch-to-confi')... machine # [ 132.498565] systemd[560]: Reexecuting. machine # [ 132.553890] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 132.749124] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 132.756468] systemd[560]: Reload requested from client PID 5664 ('switch-to-confi')... machine # [ 132.758905] systemd[560]: Reloading... machine # [ 132.954847] systemd[560]: Reloading finished in 194 ms. machine # [ 132.968363] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 132.979930] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 132.982758] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 132.985911] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 133.036517] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 133.041213] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 133.043535] systemd[1]: Stopping Reactivate sysinit units... machine # [ 133.045454] systemd[1]: Reached target Reactivate sysinit units. machine # [ 133.049124] systemd[1]: test.service: Deactivated successfully. machine # [ 133.050157] systemd[1]: Stopped test.service. machine # [ 133.050886] systemd[1]: Stopping test.service... machine # [ 133.053740] systemd[1]: Starting test.service... machine # [ 133.094611] systemd[1]: Finished test.service. machine # [ 133.099143] systemd[1]: Reached target Local File Systems. machine # [ 133.103205] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 133.111082] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 133.114047] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 133.116735] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 133.119027] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 133.130690] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 133.133528] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 133.134805] systemd[1]: Reached target Remote File Systems. machine # [ 133.135635] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 133.138416] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 133.477411] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 133.481727] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 133.484697] systemd[1]: Starting linger-users.service... machine # [ 133.546139] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 133.547889] systemd[1]: Finished linger-users.service. machine # [ 133.806991] nixos[5595]: finished switching to system configuration /nix/store/iqawc7f2ic464nsznv6052vfwmyi1m25-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 3.30 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 134.458727] nixos[5737]: switching to system configuration /nix/store/9fhawrfasw72i2y21b6483pphcn8avc7-nixos-system-machine-test machine # [ 134.461957] systemd[1]: Stopped target Local File Systems. machine # [ 134.463433] systemd[1]: Stopped target Remote File Systems. machine # [ 135.007529] systemd[1]: Reload requested from client PID 5737 ('.switch-to-conf') (unit backdoor.service)... machine # [ 135.009947] systemd[1]: Reloading... machine # [ 135.685774] systemd[1]: Reloading finished in 673 ms. machine # [ 135.836083] systemd[560]: Reexecution requested from client PID 5806 ('switch-to-confi')... machine # [ 135.837574] systemd[560]: Reexecuting. machine # [ 135.906294] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 136.105751] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 136.112814] systemd[560]: Reload requested from client PID 5806 ('switch-to-confi')... machine # [ 136.115713] systemd[560]: Reloading... machine # [ 136.307331] systemd[560]: Reloading finished in 190 ms. machine # [ 136.321959] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 136.331360] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 136.333863] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 136.336754] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 136.389215] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 136.394258] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 136.399761] systemd[1]: Stopping Reactivate sysinit units... machine # [ 136.401559] systemd[1]: Reached target Reactivate sysinit units. machine # [ 136.403903] systemd[1]: test.service: Deactivated successfully. machine # [ 136.405029] systemd[1]: Stopped test.service. machine # [ 136.406174] systemd[1]: Stopping test.service... machine # [ 136.407340] systemd[1]: Starting test.service... machine # [ 136.445247] systemd[1]: Finished test.service. machine # [ 136.448265] systemd[1]: Reached target Remote File Systems. machine # [ 136.450295] systemd[1]: Reached target Local File Systems. machine # [ 136.455266] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 136.458484] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 136.462659] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 136.467581] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 136.469807] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 136.473011] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 136.475157] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 136.484311] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 136.485653] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 136.806394] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 136.810671] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 136.813220] systemd[1]: Starting linger-users.service... machine # [ 136.877122] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 136.879270] systemd[1]: Finished linger-users.service. machine # [ 137.138851] nixos[5737]: finished switching to system configuration /nix/store/9fhawrfasw72i2y21b6483pphcn8avc7-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 3.33 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 137.762026] nixos[5879]: switching to system configuration /nix/store/5j3sfphjy0kzlxd0lxh0rl3dh7c43a5n-nixos-system-machine-test machine # [ 137.764894] systemd[1]: Stopped target Remote File Systems. machine # [ 137.767114] systemd[1]: Stopped target Local File Systems. machine # [ 138.257153] systemd[1]: Reload requested from client PID 5879 ('.switch-to-conf') (unit backdoor.service)... machine # [ 138.259286] systemd[1]: Reloading... machine # [ 138.911178] systemd[1]: Reloading finished in 649 ms. machine # [ 139.062299] systemd[560]: Reexecution requested from client PID 5948 ('switch-to-confi')... machine # [ 139.063682] systemd[560]: Reexecuting. machine # [ 139.134654] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 139.328975] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 139.335744] systemd[560]: Reload requested from client PID 5948 ('switch-to-confi')... machine # [ 139.338062] systemd[560]: Reloading... machine # [ 139.529493] systemd[560]: Reloading finished in 189 ms. machine # [ 139.544183] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 139.554263] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 139.556674] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 139.559746] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 139.606693] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 139.610888] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 139.612940] systemd[1]: Stopping Reactivate sysinit units... machine # [ 139.614432] systemd[1]: Reached target Reactivate sysinit units. machine # [ 139.617890] systemd[1]: test.service: Deactivated successfully. machine # [ 139.619180] systemd[1]: Stopped test.service. machine # [ 139.620212] systemd[1]: Stopping test.service... machine # [ 139.622244] systemd[1]: Starting test.service... machine # [ 139.659942] systemd[1]: Finished test.service. machine # [ 139.666240] systemd[1]: Reached target Local File Systems. machine # [ 139.670113] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 139.674398] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 139.675317] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 139.684688] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 139.686952] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 139.693672] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 139.695048] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 139.696762] systemd[1]: Reached target Remote File Systems. machine # [ 139.697628] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 139.698935] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 140.026867] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 140.031459] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 140.035835] systemd[1]: Starting linger-users.service... machine # [ 140.099624] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 140.102482] systemd[1]: Finished linger-users.service. machine # [ 140.360698] nixos[5879]: finished switching to system configuration /nix/store/5j3sfphjy0kzlxd0lxh0rl3dh7c43a5n-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 3.22 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 140.938283] nixos[6021]: switching to system configuration /nix/store/cxhwm59m0fgjyyhyqnb02hzn66jf0prk-nixos-system-machine-test machine # [ 140.940863] systemd[1]: Stopped target Remote File Systems. machine # [ 140.943245] systemd[1]: Stopped target Local File Systems. machine # [ 141.384883] systemd[1]: Reload requested from client PID 6021 ('.switch-to-conf') (unit backdoor.service)... machine # [ 141.386923] systemd[1]: Reloading... machine # [ 141.963654] systemd[1]: Reloading finished in 574 ms. machine # [ 142.104451] systemd[560]: Reexecution requested from client PID 6090 ('switch-to-confi')... machine # [ 142.105904] systemd[560]: Reexecuting. machine # [ 142.170732] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 142.364081] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 142.371894] systemd[560]: Reload requested from client PID 6090 ('switch-to-confi')... machine # [ 142.374267] systemd[560]: Reloading... machine # [ 142.563177] systemd[560]: Reloading finished in 187 ms. machine # [ 142.576185] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 142.586722] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 142.589447] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 142.592632] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 142.643335] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 142.648816] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 142.649807] systemd[1]: Stopping Reactivate sysinit units... machine # [ 142.650705] systemd[1]: Reached target Reactivate sysinit units. machine # [ 142.653479] systemd[1]: test.service: Deactivated successfully. machine # [ 142.656350] systemd[1]: Stopped test.service. machine # [ 142.657135] systemd[1]: Stopping test.service... machine # [ 142.660652] systemd[1]: Starting test.service... machine # [ 142.697382] systemd[1]: Finished test.service. machine # [ 142.702546] systemd[1]: Reached target Remote File Systems. machine # [ 142.708417] systemd[1]: Starting linger-users.service... machine # [ 142.711831] systemd[1]: Reached target Local File Systems. machine # [ 142.724953] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 142.734135] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 142.735199] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 142.740406] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 142.744425] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 142.748515] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 142.751545] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 142.753807] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 142.755333] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 142.812255] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 142.815991] systemd[1]: Finished linger-users.service. machine # [ 143.087959] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 143.091394] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 143.349723] nixos[6021]: finished switching to system configuration /nix/store/cxhwm59m0fgjyyhyqnb02hzn66jf0prk-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.99 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 143.959055] nixos[6163]: switching to system configuration /nix/store/sdr9pirzmqvw2armwa6ssjkbiiyl2khq-nixos-system-machine-test machine # [ 143.961880] systemd[1]: Stopped target Remote File Systems. machine # [ 143.964194] systemd[1]: Stopped target Local File Systems. machine # [ 144.458061] systemd[1]: Reload requested from client PID 6163 ('.switch-to-conf') (unit backdoor.service)... machine # [ 144.460131] systemd[1]: Reloading... machine # [ 145.085428] systemd[1]: Reloading finished in 622 ms. machine # [ 145.229478] systemd[560]: Reexecution requested from client PID 6232 ('switch-to-confi')... machine # [ 145.233850] systemd[560]: Reexecuting. machine # [ 145.293741] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 145.480296] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 145.487431] systemd[560]: Reload requested from client PID 6232 ('switch-to-confi')... machine # [ 145.491333] systemd[560]: Reloading... machine # [ 145.677351] systemd[560]: Reloading finished in 187 ms. machine # [ 145.692187] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 145.702369] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 145.703400] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 145.706326] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 145.756474] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 145.760678] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 145.764428] systemd[1]: Stopping Reactivate sysinit units... machine # [ 145.765324] systemd[1]: Reached target Reactivate sysinit units. machine # [ 145.768764] systemd[1]: Reloading test.service... machine # [ 145.802858] systemd[1]: Reloaded test.service. machine # [ 145.806074] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 145.812272] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 145.814189] systemd[1]: Reached target Local File Systems. machine # [ 145.816169] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 145.817672] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 145.818480] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 145.819654] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 145.835084] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 145.838789] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 145.840454] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 145.842290] systemd[1]: Reached target Remote File Systems. machine # [ 146.145793] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 146.150532] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 146.153652] systemd[1]: Starting linger-users.service... machine # [ 146.216907] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 146.217948] systemd[1]: Finished linger-users.service. machine # [ 146.476712] nixos[6163]: finished switching to system configuration /nix/store/sdr9pirzmqvw2armwa6ssjkbiiyl2khq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 3.13 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 147.104934] nixos[6305]: switching to system configuration /nix/store/67czsjcjx7iav9b53xlxf69swkfpsyp3-nixos-system-machine-test machine # [ 147.108000] systemd[1]: Stopped target Local File Systems. machine # [ 147.109499] systemd[1]: Stopped target Remote File Systems. machine # [ 147.608595] systemd[1]: Reload requested from client PID 6305 ('.switch-to-conf') (unit backdoor.service)... machine # [ 147.610548] systemd[1]: Reloading... machine # [ 148.247506] systemd[1]: Reloading finished in 634 ms. machine # [ 148.390674] systemd[560]: Reexecution requested from client PID 6374 ('switch-to-confi')... machine # [ 148.395314] systemd[560]: Reexecuting. machine # [ 148.445689] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 148.637422] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 148.645003] systemd[560]: Reload requested from client PID 6374 ('switch-to-confi')... machine # [ 148.647466] systemd[560]: Reloading... machine # [ 148.839039] systemd[560]: Reloading finished in 190 ms. machine # [ 148.852498] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 148.863243] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 148.865898] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 148.868900] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 148.919030] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 148.923936] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 148.928948] systemd[1]: Stopping Reactivate sysinit units... machine # [ 148.930100] systemd[1]: Reached target Reactivate sysinit units. machine # [ 148.932908] systemd[1]: Reloading test.service... machine # [ 148.972743] systemd[1]: Reloaded test.service. machine # [ 148.975516] systemd[1]: Reached target Remote File Systems. machine # [ 148.982642] systemd[1]: Starting linger-users.service... machine # [ 148.994078] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 148.995588] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 148.999563] systemd[1]: Reached target Local File Systems. machine # [ 149.010887] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 149.015087] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 149.020959] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 149.022279] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 149.026103] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 149.028593] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 149.029955] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 149.085952] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 149.090154] systemd[1]: Finished linger-users.service. machine # [ 149.363884] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 149.367404] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 149.624635] nixos[6305]: finished switching to system configuration /nix/store/67czsjcjx7iav9b53xlxf69swkfpsyp3-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 3.15 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 150.243326] nixos[6447]: switching to system configuration /nix/store/dv9q0v3k93qj62y1v4b5fi1kqjdizy9i-nixos-system-machine-test machine # [ 150.246278] systemd[1]: Stopped target Remote File Systems. machine # [ 150.248586] systemd[1]: Stopped target Local File Systems. machine # [ 150.748476] systemd[1]: Reload requested from client PID 6447 ('.switch-to-conf') (unit backdoor.service)... machine # [ 150.750596] systemd[1]: Reloading... machine # [ 151.385206] systemd[1]: Reloading finished in 632 ms. machine # [ 151.527412] systemd[560]: Reexecution requested from client PID 6516 ('switch-to-confi')... machine # [ 151.531681] systemd[560]: Reexecuting. machine # [ 151.578075] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 151.768919] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 151.776190] systemd[560]: Reload requested from client PID 6516 ('switch-to-confi')... machine # [ 151.778545] systemd[560]: Reloading... machine # [ 151.968733] systemd[560]: Reloading finished in 188 ms. machine # [ 151.981604] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 151.989553] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 151.991920] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 151.994828] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 152.040344] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 152.044429] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 152.045741] systemd[1]: Stopping Reactivate sysinit units... machine # [ 152.046566] systemd[1]: Reached target Reactivate sysinit units. machine # [ 152.048967] systemd[1]: test.service: Deactivated successfully. machine # [ 152.052100] systemd[1]: Stopped test.service. machine # [ 152.052932] systemd[1]: Stopping test.service... machine # [ 152.055139] systemd[1]: Starting test.service... machine # [ 152.091337] systemd[1]: Finished test.service. machine # [ 152.094259] systemd[1]: Reached target Remote File Systems. machine # [ 152.103055] systemd[1]: Starting linger-users.service... machine # [ 152.106293] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 152.107633] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 152.119206] systemd[1]: Reached target Local File Systems. machine # [ 152.121887] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 152.125392] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 152.126326] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 152.127537] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 152.132108] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 152.138220] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 152.141630] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 152.196665] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 152.199602] systemd[1]: Finished linger-users.service. machine # [ 152.471517] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 152.474696] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 152.731162] nixos[6447]: finished switching to system configuration /nix/store/dv9q0v3k93qj62y1v4b5fi1kqjdizy9i-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 3.11 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 153.281666] nixos[6589]: switching to system configuration /nix/store/iqawc7f2ic464nsznv6052vfwmyi1m25-nixos-system-machine-test machine # [ 153.285327] systemd[1]: Stopped target Remote File Systems. machine # [ 153.286575] systemd[1]: Stopped target Local File Systems. machine # [ 153.714680] systemd[1]: Reload requested from client PID 6589 ('.switch-to-conf') (unit backdoor.service)... machine # [ 153.716909] systemd[1]: Reloading... machine # [ 154.289685] systemd[1]: Reloading finished in 570 ms. machine # [ 154.431498] systemd[560]: Reexecution requested from client PID 6658 ('switch-to-confi')... machine # [ 154.435176] systemd[560]: Reexecuting. machine # [ 154.498022] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 154.685637] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 154.691922] systemd[560]: Reload requested from client PID 6658 ('switch-to-confi')... machine # [ 154.694323] systemd[560]: Reloading... machine # [ 154.880750] systemd[560]: Reloading finished in 185 ms. machine # [ 154.896165] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 154.904838] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 154.907104] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 154.909922] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 154.957082] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 154.961256] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 154.963056] systemd[1]: Stopping Reactivate sysinit units... machine # [ 154.964786] systemd[1]: Reached target Reactivate sysinit units. machine # [ 154.968145] systemd[1]: Reached target Local File Systems. machine # [ 154.968989] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 154.973870] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 154.974736] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 154.975917] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 154.986127] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 154.990624] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 154.993143] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 154.996327] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 154.998020] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 154.999867] systemd[1]: Reached target Remote File Systems. machine # [ 155.301430] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 155.305935] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 155.308612] systemd[1]: Starting linger-users.service... machine # [ 155.369171] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 155.371461] systemd[1]: Finished linger-users.service. machine # [ 155.630854] nixos[6589]: finished switching to system configuration /nix/store/iqawc7f2ic464nsznv6052vfwmyi1m25-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 2.90 seconds) (finished: subtest: unit file parser, in 41.85 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 156.187528] nixos[6729]: switching to system configuration /nix/store/nx6l9vsfd584jdskbz0fsnwf1p8m5iii-nixos-system-machine-test machine # [ 156.190707] systemd[1]: Stopped target Local File Systems. machine # [ 156.192447] systemd[1]: Stopped target Remote File Systems. machine # [ 156.626949] systemd[1]: Reload requested from client PID 6729 ('.switch-to-conf') (unit backdoor.service)... machine # [ 156.629134] systemd[1]: Reloading... machine # [ 157.205213] systemd[1]: Reloading finished in 573 ms. machine # [ 157.350512] systemd[560]: Reexecution requested from client PID 6798 ('switch-to-confi')... machine # [ 157.351921] systemd[560]: Reexecuting. machine # [ 157.422205] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 157.617273] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 157.624331] systemd[560]: Reload requested from client PID 6798 ('switch-to-confi')... machine # [ 157.626485] systemd[560]: Reloading... machine # [ 157.814764] systemd[560]: Reloading finished in 187 ms. machine # [ 157.828175] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 157.836888] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 157.839273] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 157.842111] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 157.888492] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 157.892495] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 157.894855] systemd[1]: Stopping Reactivate sysinit units... machine # [ 157.895990] systemd[1]: Reached target Reactivate sysinit units. machine # [ 157.900895] systemd[1]: Reached target Remote File Systems. machine # [ 157.906011] systemd[1]: Starting linger-users.service... machine # [ 157.908445] systemd[1]: Reached target Local File Systems. machine # [ 157.916496] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 157.917852] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 157.923482] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 157.928453] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 157.929293] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 157.930490] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 157.932875] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 157.934719] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 157.937981] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 158.002135] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 158.005506] systemd[1]: Finished linger-users.service. machine # [ 158.277205] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 158.280281] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 158.539760] nixos[6729]: finished switching to system configuration /nix/store/nx6l9vsfd584jdskbz0fsnwf1p8m5iii-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 2.91 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 159.183486] nixos[6869]: switching to system configuration /nix/store/sb0vw2d0cv06wcfwa0idkaxz06q2m046-nixos-system-machine-test machine # [ 159.187304] systemd[1]: Stopped target Local File Systems. machine # [ 159.188948] systemd[1]: Stopped target Remote File Systems. machine # [ 159.189756] systemd[1]: test.service: Deactivated successfully. machine # [ 159.190580] systemd[1]: Stopped test.service. machine # [ 159.707094] systemd[1]: Reload requested from client PID 6869 ('.switch-to-conf') (unit backdoor.service)... machine # [ 159.709331] systemd[1]: Reloading... machine # [ 160.398724] systemd[1]: Reloading finished in 687 ms. machine # [ 160.544440] systemd[560]: Reexecution requested from client PID 6939 ('switch-to-confi')... machine # [ 160.545815] systemd[560]: Reexecuting. machine # [ 160.601898] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 160.801789] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 160.808930] systemd[560]: Reload requested from client PID 6939 ('switch-to-confi')... machine # [ 160.811413] systemd[560]: Reloading... machine # [ 161.026644] systemd[560]: Reloading finished in 214 ms. machine # [ 161.040149] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 161.050769] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 161.053322] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 161.056396] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 161.107215] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 161.111955] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 161.115050] systemd[1]: Stopping Reactivate sysinit units... machine # [ 161.115868] systemd[1]: Reached target Reactivate sysinit units. machine # [ 161.123780] systemd[1]: Starting simple-service.service... machine # [ 161.131700] systemd[1]: Starting simple-restart-service.service... machine # [ 161.149634] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 161.155671] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 161.169244] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 161.182270] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 161.194077] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 161.209964] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 161.215578] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 161.230096] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 161.235083] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 161.259659] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 161.280377] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 161.281757] systemd[1]: Reached target Local File Systems. machine # [ 161.306152] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 161.315600] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 161.341479] systemd[1]: Reached target Remote File Systems. machine # [ 161.342670] systemd[1]: Starting linger-users.service... machine # [ 161.343457] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 161.398902] systemd[1]: Starting reload-triggers.service... machine # [ 161.414484] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 161.415761] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 161.450684] systemd[1]: Finished simple-service.service. machine # [ 161.456747] systemd[1]: Finished simple-restart-service.service. machine # [ 161.478937] systemd[1]: Starting no-restart-service.service... machine # [ 161.486106] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 161.496295] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 161.506004] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 161.512883] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 161.516621] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 161.517449] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 161.518689] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 161.533949] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 161.540281] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 161.541922] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 161.544715] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 161.546716] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 161.550799] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 161.551912] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 161.553666] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 161.555220] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 161.556792] systemd[1]: Finished reload-triggers.service. machine # [ 161.558950] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 161.566148] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 161.567168] systemd[1]: Finished no-restart-service.service. machine # [ 161.591058] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 161.595272] systemd[1]: Finished linger-users.service. machine # [ 161.898466] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 161.901173] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 161.906056] systemd[1]: Starting simple-reload-service.service... machine # [ 161.941539] systemd[1]: Finished simple-reload-service.service. machine # [ 162.202724] nixos[6869]: finished switching to system configuration /nix/store/sb0vw2d0cv06wcfwa0idkaxz06q2m046-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.67 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 162.891598] nixos[7040]: switching to system configuration /nix/store/sb0vw2d0cv06wcfwa0idkaxz06q2m046-nixos-system-machine-test machine # [ 162.894956] systemd[1]: Stopped target Local File Systems. machine # [ 162.896390] systemd[1]: Stopped target Remote File Systems. machine # [ 163.367599] systemd[1]: Reload requested from client PID 7040 ('.switch-to-conf') (unit backdoor.service)... machine # [ 163.369803] systemd[1]: Reloading... machine # [ 163.963644] systemd[1]: Reloading finished in 591 ms. machine # [ 164.104627] systemd[560]: Reexecution requested from client PID 7111 ('switch-to-confi')... machine # [ 164.107995] systemd[560]: Reexecuting. machine # [ 164.169663] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 164.352816] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 164.359504] systemd[560]: Reload requested from client PID 7111 ('switch-to-confi')... machine # [ 164.361564] systemd[560]: Reloading... machine # [ 164.539456] systemd[560]: Reloading finished in 176 ms. machine # [ 164.552134] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 164.562041] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 164.563004] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 164.565807] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 164.611188] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 164.614944] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 164.617681] systemd[1]: Stopping Reactivate sysinit units... machine # [ 164.618537] systemd[1]: Reached target Reactivate sysinit units. machine # [ 164.623657] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 164.628596] systemd[1]: Reloading reload-triggers.service... machine # [ 164.636312] systemd[1]: Reloading simple-reload-service.service... machine # [ 164.643323] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 164.652910] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 164.661552] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 164.722048] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 164.727015] systemd[1]: Reloaded simple-reload-service.service. machine # [ 164.729046] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 164.730829] systemd[1]: Reloaded reload-triggers.service. machine # [ 164.737941] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 164.741770] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 164.744579] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 164.747628] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 164.749265] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 164.751438] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 164.755779] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 164.760526] systemd[1]: Stopped simple-restart-service.service. machine # [ 164.764335] systemd[1]: Stopping simple-restart-service.service... machine # [ 164.765719] systemd[1]: Starting simple-restart-service.service... machine # [ 164.773933] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 164.782343] systemd[1]: Stopped simple-service.service. machine # [ 164.783123] systemd[1]: Stopping simple-service.service... machine # [ 164.783879] systemd[1]: Starting simple-service.service... machine # [ 164.794777] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 164.801256] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 164.809273] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 164.816908] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 164.823853] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 164.836513] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 164.841681] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 164.846232] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 164.848211] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 164.851626] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 164.867950] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 164.870004] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 164.871250] systemd[1]: Finished simple-restart-service.service. machine # [ 164.873926] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 164.875700] systemd[1]: Finished simple-service.service. machine # [ 164.877117] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 164.885669] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 164.891005] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 164.895842] systemd[1]: Reached target Local File Systems. machine # [ 164.898521] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 164.902381] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 164.908290] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 164.909529] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 164.911675] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 164.918344] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 164.921532] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 164.924506] systemd[1]: Reached target Remote File Systems. machine # [ 164.926524] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 164.928308] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 165.222013] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 165.226280] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 165.228791] systemd[1]: Starting linger-users.service... machine # [ 165.283436] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 165.285682] systemd[1]: Finished linger-users.service. machine # [ 165.543953] nixos[7040]: finished switching to system configuration /nix/store/sb0vw2d0cv06wcfwa0idkaxz06q2m046-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.34 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 166.285419] nixos[7206]: switching to system configuration /nix/store/bdhmzwhf9zh1w76cmy9dqqska5r2nilp-nixos-system-machine-test machine # [ 166.288055] systemd[1]: Stopped target Remote File Systems. machine # [ 166.290270] systemd[1]: Stopped target Local File Systems. machine # [ 166.812955] systemd[1]: Reload requested from client PID 7206 ('.switch-to-conf') (unit backdoor.service)... machine # [ 166.814858] systemd[1]: Reloading... machine # [ 167.458872] systemd[1]: Reloading finished in 641 ms. machine # [ 167.600169] systemd[560]: Reexecution requested from client PID 7277 ('switch-to-confi')... machine # [ 167.603441] systemd[560]: Reexecuting. machine # [ 167.665812] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 167.850367] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 167.856602] systemd[560]: Reload requested from client PID 7277 ('switch-to-confi')... machine # [ 167.858812] systemd[560]: Reloading... machine # [ 168.037748] systemd[560]: Reloading finished in 177 ms. machine # [ 168.048135] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 168.057802] systemd[560]: Stopped Run user-specific NixOS activation. machine # [ 168.058768] systemd[560]: Stopping Run user-specific NixOS activation... machine # [ 168.061400] systemd[560]: Starting Run user-specific NixOS activation... machine # [ 168.098291] systemd[560]: Finished Run user-specific NixOS activation. machine # [ 168.101980] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 168.106420] systemd[1]: Stopping Reactivate sysinit units... machine # [ 168.107679] systemd[1]: Reached target Reactivate sysinit units. machine # [ 168.112522] systemd[1]: Reloading reload-triggers.service... machine # [ 168.114530] systemd[1]: Reloading simple-reload-service.service... machine # [ 168.131039] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 168.135808] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 168.175717] systemd[1]: Reloaded reload-triggers.service. machine # [ 168.179843] systemd[1]: Reloaded simple-reload-service.service. machine # [ 168.188916] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 168.192156] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 168.195579] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 168.197274] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 168.198361] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 168.201201] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 168.204547] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 168.206071] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 168.210614] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 168.215233] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 168.217546] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 168.225043] systemd[1]: Stopped simple-restart-service.service. machine # [ 168.226535] systemd[1]: Stopping simple-restart-service.service... machine # [ 168.234754] systemd[1]: Starting simple-restart-service.service... machine # [ 168.246138] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 168.247258] systemd[1]: Stopped simple-service.service. machine # [ 168.264419] systemd[1]: Stopping simple-service.service... machine # [ 168.269213] systemd[1]: Starting simple-service.service... machine # [ 168.279320] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 168.293602] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 168.305364] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 168.308888] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 168.323135] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 168.340824] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 168.349811] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 168.353682] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 168.355620] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 168.357528] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 168.358797] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 168.360721] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 168.362311] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 168.364081] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 168.365601] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 168.369292] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 168.374249] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 168.375211] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 168.378177] systemd[1]: Finished simple-restart-service.service. machine # [ 168.379124] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 168.382245] systemd[1]: Finished simple-service.service. machine # [ 168.383002] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 168.385238] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 168.388539] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 168.390150] systemd[1]: Reached target Remote File Systems. machine # [ 168.392408] systemd[1]: Reached target Local File Systems. machine # [ 168.395970] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 168.400694] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 168.401566] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 168.402782] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 168.406072] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 168.416900] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 168.418173] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 168.419320] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 168.420740] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 168.726001] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 168.729748] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 168.732375] systemd[1]: Starting linger-users.service... machine # [ 168.788807] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 168.790971] systemd[1]: Finished linger-users.service. machine # [ 169.048838] nixos[7206]: finished switching to system configuration /nix/store/bdhmzwhf9zh1w76cmy9dqqska5r2nilp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 3.51 seconds) machine: must succeed: /nix/store/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-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/mz8nm7vaaymc5cdybb1zwav6fvrbm7rw-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.83 seconds) (finished: subtest: restart and reload by activation script, in 14.25 seconds) (finished: run the VM test script, in 170.88 seconds) test script finished in 170.92s cleanup kill QemuMachine (pid 45) machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14) (finished: cleanup, in 0.18 seconds) additionally exposed symbols: machine, other, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh