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.F4fLTEIHib', 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: 7bb2c026-4bd6-45d1-a5ab-3ab3cf8fad6b 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.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Sep 2 12:31:51 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/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/init regInfo=/nix/store/gym0p1p4dywmcgpsl47a8zn1wgvbcjlf-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/gym0p1p4dywmcgpsl47a8zn1wgvbcjlf-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 74886 entries in 294 pages machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups machine # [ 0.000000] rcu: Hierarchical RCU implementation. machine # [ 0.000000] rcu: RCU event tracing is enabled. machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. machine # [ 0.000000] Rude variant of Tasks RCU enabled. machine # [ 0.000000] Tracing variant of Tasks RCU enabled. machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 machine # [ 0.000000] GICv3: 256 SPIs implemented machine # [ 0.000000] GICv3: 0 Extended SPIs implemented machine # [ 0.000000] Root IRQ handler: gic_handle_irq machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1) machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1) machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000 machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns machine # [ 0.000027] arm-pv: using stolen time PV machine # [ 0.000368] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000535] Console: colour dummy device 80x25 machine # [ 0.000542] printk: legacy console [tty0] enabled machine # [ 0.000743] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000749] pid_max: default: 32768 minimum: 301 machine # [ 0.000823] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.000947] landlock: Up and running. machine # [ 0.000949] Yama: becoming mindful. machine # [ 0.001356] LSM support for eBPF active machine # [ 0.001479] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.001499] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.002564] cacheinfo: Unable to detect cache hierarchy for CPU 0 machine # [ 0.003287] rcu: Hierarchical SRCU implementation. machine # [ 0.003291] rcu: Max phase no-delay instances is 1000. machine # [ 0.004426] fsl-mc MSI: its@8080000 domain created machine # [ 0.004514] EFI services will not be available. machine # [ 0.004588] smp: Bringing up secondary CPUs ... machine # [ 0.004596] smp: Brought up 1 node, 1 CPU machine # [ 0.004599] SMP: Total of 1 processors activated. machine # [ 0.004602] CPU: All CPU(s) started at EL1 machine # [ 0.004614] CPU features: detected: Branch Target Identification machine # [ 0.004618] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.004621] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.004625] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.004628] CPU features: detected: Common not Private translations machine # [ 0.004632] CPU features: detected: CRC32 instructions machine # [ 0.004634] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.004638] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.004641] CPU features: detected: Data independent timing control (DIT) machine # [ 0.004644] CPU features: detected: E0PD machine # [ 0.004647] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.004650] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.004653] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.004656] CPU features: detected: Fine Grained Traps machine # [ 0.004660] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.004665] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.004668] CPU features: detected: LSE atomic instructions machine # [ 0.004670] CPU features: detected: Privileged Access Never machine # [ 0.004673] CPU features: detected: PMUv3 machine # [ 0.004676] CPU features: detected: RAS Extension Support machine # [ 0.004679] CPU features: detected: RASv1p1 Extension Support machine # [ 0.004681] CPU features: detected: Random Number Generator machine # [ 0.004684] CPU features: detected: Speculation barrier (SB) machine # [ 0.004687] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.004690] CPU features: detected: TLB range maintenance instructions machine # [ 0.004694] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.004740] alternatives: applying system-wide alternatives machine # [ 0.007580] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.007760] Memory: 894300K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 112964K reserved, 32768K cma-reserved) machine # [ 0.008082] devtmpfs: initialized machine # [ 0.009737] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.009758] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.009927] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.009931] 0 pages in range for non-PLT usage machine # [ 0.009932] 508288 pages in range for PLT usage machine # [ 0.010031] pinctrl core: initialized pinctrl subsystem machine # [ 0.010760] DMI not present or invalid. machine # [ 0.013722] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.015910] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.016065] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.016235] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.016255] audit: initializing netlink subsys (disabled) machine # [ 0.016801] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.016803] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.016806] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.016809] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.016814] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.016836] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 machine # [ 0.016846] cpuidle: using governor ladder machine # [ 0.016851] cpuidle: using governor menu machine # [ 0.017040] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.017055] ASID allocator initialised with 65536 entries machine # [ 0.018196] Serial: AMBA PL011 UART driver machine # [ 0.023252] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.023401] printk: console [ttyAMA0] enabled machine # [ 0.144753] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.144770] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.144776] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.144780] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.144784] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.144788] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.144793] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.144797] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.152324] fbcon: Taking over console machine # [ 0.152341] ACPI: Interpreter disabled. machine # [ 0.154220] iommu: Default domain type: Translated machine # [ 0.154230] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.155908] SCSI subsystem initialized machine # [ 0.156573] usbcore: registered new interface driver usbfs machine # [ 0.156605] usbcore: registered new interface driver hub machine # [ 0.156620] usbcore: registered new device driver usb machine # [ 0.164939] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.164947] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.164959] PTP clock support registered machine # [ 0.165012] EDAC MC: Ver: 3.0.0 machine # [ 0.167660] scmi_core: SCMI protocol bus registered machine # [ 0.168580] FPGA manager framework machine # [ 0.169525] vgaarb: loaded machine # [ 0.170129] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.172354] VFS: Disk quotas dquot_6.6.0 machine # [ 0.172389] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.175945] netfs: FS-Cache loaded machine # [ 0.176059] pnp: PnP ACPI: disabled machine # [ 0.179864] NET: Registered PF_INET protocol family machine # [ 0.180015] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.208280] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.208319] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.208340] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.208386] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.208461] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.208567] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.208597] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.208621] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.208711] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.208731] NET: Registered PF_XDP protocol family machine # [ 0.208750] PCI: CLS 0 bytes, default 64 machine # [ 0.208972] Trying to unpack rootfs image as initramfs... machine # [ 0.223538] kvm [1]: HYP mode not available machine # [ 0.314584] Initialise system trusted keyrings machine # [ 0.315301] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.316505] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.317274] 9p: Installing v9fs 9p2000 file system support machine # [ 0.337813] Key type asymmetric registered machine # [ 0.337830] Asymmetric key parser 'x509' registered machine # [ 0.337887] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.346197] io scheduler mq-deadline registered machine # [ 0.346213] io scheduler kyber registered machine # [ 0.351003] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.358167] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.358621] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.358641] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.358675] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.358684] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.358705] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.358730] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.358806] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.358815] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.358821] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.358827] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.358832] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.358914] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.359352] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.359533] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.359549] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.359578] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.359594] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.360034] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.360212] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.360228] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.360257] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.360711] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.360890] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.360906] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.360936] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.361372] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.361550] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.361566] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.361595] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.362038] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.362236] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.362253] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.362282] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.362728] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.362905] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.362921] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.362950] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.363402] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.363578] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.363594] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.363623] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.363639] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.364077] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.364259] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.364288] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.364749] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.364931] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.364961] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.365335] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.365511] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.365755] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.366013] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.366030] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.366059] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.414580] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.414774] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.414791] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.414820] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.415394] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.415406] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.415412] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.415457] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.415502] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.415548] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.415594] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.415640] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.415687] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.415734] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.415780] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.415826] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.415933] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.415979] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.416000] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.416021] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.416042] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.416063] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.416088] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.416109] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.416131] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.416152] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.416174] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.416198] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.416220] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.416241] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.416262] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.416283] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned machine # [ 0.416304] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.416325] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.416346] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned machine # [ 0.416367] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned machine # [ 0.416389] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned machine # [ 0.416410] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned machine # [ 0.416435] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.416445] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.416450] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.417582] pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.477417] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.483508] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.485449] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.495554] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.497715] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) machine # [ 0.509091] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) machine # [ 0.511937] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) machine # [ 0.513987] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.523919] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.525697] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.537145] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.551343] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.553872] msm_serial: driver initialized machine # [ 0.554006] SuperH (H)SCI(F) driver initialized machine # [ 0.554060] STM32 USART driver initialized machine # [ 0.584843] loop: module loaded machine # [ 0.585030] virtio_blk virtio5: 1/0/0 default/read/poll queues machine # [ 0.585966] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.590684] megasas: 07.734.00.00-rc1 machine # [ 0.591333] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.602169] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.602193] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.603891] Using buffer write method machine # [ 0.603958] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.606915] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.606936] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.608308] Using buffer write method machine # [ 0.608333] Concatenating MTD devices: machine # [ 0.608337] (0): "0.flash" machine # [ 0.608341] (1): "0.flash" machine # [ 0.608344] into device "0.flash" machine # [ 0.837933] Freeing initrd memory: 26104K machine # [ 0.843805] tun: Universal TUN/TAP device driver, 1.6 machine # [ 0.847457] thunder_xcv, ver 1.0 machine # [ 0.847495] thunder_bgx, ver 1.0 machine # [ 0.847517] nicpf, ver 1.0 machine # [ 0.848050] e1000: Intel(R) PRO/1000 Network Driver machine # [ 0.848057] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 0.848085] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 0.848093] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 0.848117] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 0.848122] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 0.848143] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 0.848149] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 0.848281] sky2: driver version 1.30 machine # [ 0.849796] usbcore: registered new interface driver usb-storage machine # [ 0.849933] usbcore: registered new interface driver usbserial_generic machine # [ 0.849946] usbserial: USB Serial support registered for generic machine # [ 0.850868] ehci-pci 0000:00:0a.0: EHCI Host Controller machine # [ 0.850915] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 machine # [ 0.851155] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 machine # [ 0.862597] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 machine # [ 0.862904] hub 1-0:1.0: USB hub found machine # [ 0.862929] hub 1-0:1.0: 6 ports detected machine # [ 0.865363] hv_vmbus: registering driver hyperv_keyboard machine # [ 0.866869] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 0.866892] rtc-pl031 9010000.pl031: setting system clock to 2026-09-06T17:55:29 UTC (1788717329) machine # [ 0.867188] i2c_dev: i2c /dev entries driver machine # [ 0.871921] sdhci: Secure Digital Host Controller Interface driver machine # [ 0.871934] sdhci: Copyright(c) Pierre Ossman machine # [ 0.872216] Synopsys Designware Multimedia Card Interface Driver machine # [ 0.872582] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 0.876806] hid: raw HID events driver (C) Jiri Kosina machine # [ 0.877055] usbcore: registered new interface driver usbhid machine # [ 0.877061] usbhid: USB HID core driver machine # [ 0.879936] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 0.881444] drop_monitor: Initializing network drop monitor service machine # [ 0.881600] NET: Registered PF_INET6 protocol family machine # [ 0.884602] Segment Routing with IPv6 machine # [ 0.884630] In-situ OAM (IOAM) with IPv6 machine # [ 0.884658] NET: Registered PF_PACKET protocol family machine # [ 0.886476] 9pnet: Installing 9P2000 support machine # [ 0.888515] Key type dns_resolver registered machine # [ 0.895026] registered taskstats version 1 machine # [ 0.895174] Loading compiled-in X.509 certificates machine # [ 0.903441] Demotion targets for Node 0: null machine # [ 0.903535] Key type .fscrypt registered machine # [ 0.903541] Key type fscrypt-provisioning registered machine # [ 0.903632] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.903652] ima: Allocated hash algorithm: sha1 machine # [ 0.903676] ima: No architecture policies found machine # [ 0.907715] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 0.925213] clk: Disabling unused clocks machine # [ 0.925246] PM: genpd: Disabling unused power domains machine # [ 0.929435] Freeing unused kernel memory: 4736K machine # [ 0.929617] Run /init as init process machine # [ 0.944292] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.110209] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.262546] 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.279143] systemd[1]: systemd 262-9457f81 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.291166] systemd[1]: Detected virtualization qemu. machine # [ 1.293146] systemd[1]: Detected architecture arm64. machine # [ 1.295080] systemd[1]: Running in initrd. machine # [ 1.297664] systemd[1]: Initializing machine ID from random generator. machine # [ 1.300540] systemd[1]: Hostname set to . machine # [ 1.346403] 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.443261] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.466229] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.495737] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.504026] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.505080] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.506128] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.507022] systemd[1]: Reached target Path Units. machine # [ 1.507667] systemd[1]: Reached target Slice Units. machine # [ 1.508313] systemd[1]: Reached target Swaps. machine # [ 1.508896] systemd[1]: Reached target Timer Units. machine # [ 1.509659] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.510786] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.511697] systemd[1]: Listening on Journal Sockets. machine # [ 1.512450] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.513172] systemd[1]: Reached target Socket Units. machine # [ 1.515120] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.521671] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 1.522779] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.537329] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.548622] systemd[1]: Starting Journal Service... machine # [ 1.561717] systemd[1]: Starting Load Kernel Modules... machine # [ 1.562628] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.575269] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.594411] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.595524] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 1.595802] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 1.596017] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.602540] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.623144] 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.623276] 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.627765] systemd-journald[73]: Collecting audit messages is disabled. machine # [ 1.636083] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.642251] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.646631] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 machine # [ 1.646866] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.646875] [drm] features: -context_init machine # [ 1.647574] [drm] number of scanouts: 1 machine # [ 1.647591] [drm] number of cap sets: 0 machine # [ 1.666257] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.668725] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.670529] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic machine # [ 1.670545] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 machine # [ 1.702757] Console: switching to colour frame buffer device 160x50 machine # [ 1.709147] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.726705] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.726897] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.726931] systemd[1]: Reached target Local File Systems. machine # [ 1.731658] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.738736] systemd[1]: Finished Load Kernel Modules. machine # [ 1.750561] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.786694] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.810453] systemd[1]: Started Journal Service. machine # [ 1.799329] systemd-modules-load[74]: Inserted module 'dm_mod' machine # [ 1.800427] systemd-modules-load[74]: Module 'virtio_balloon' is built in machine # [ 1.801520] systemd-modules-load[74]: Module 'virtio_console' is built in machine # [ 1.802601] systemd-modules-load[74]: Inserted module 'virtio_gpu' machine # [ 1.803574] systemd-modules-load[74]: Module 'virtio_rng' is built in machine # [ 1.820403] systemd[1]: Starting Create System Files and Directories... machine # [ 1.821744] systemd-udevd[79]: Using default interface naming scheme 'v261'. machine # [ 1.850008] systemd[1]: Finished Create System Files and Directories. machine # [ 1.868892] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.947984] systemd[1]: Starting Virtual Console Setup... machine # [ 2.004443] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.007701] systemd[1]: Finished Virtual Console Setup. machine # [ 2.609149] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.610127] systemd[1]: Reached target System Initialization. machine # [ 2.611121] systemd[1]: Reached target Basic System. machine # [ 2.766716] (udev-worker)[94]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.781873] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.792588] (udev-worker)[100]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.839543] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.843054] systemd[1]: Reached target Initrd Root Device. machine # [ 2.846434] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 2.890949] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 2.898024] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.904421] systemd[1]: Mounting /sysroot... machine # [ 2.951462] EXT4-fs (vda): mounted filesystem 7bb2c026-4bd6-45d1-a5ab-3ab3cf8fad6b r/w with ordered data mode. Quota mode: none. machine # [ 2.945298] systemd[1]: Mounted /sysroot. machine # [ 2.946343] systemd[1]: Reached target Initrd Root File System. machine # [ 2.952239] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.976710] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.981315] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.985906] systemd[1]: Reloading... machine # [ 3.165302] systemd[1]: Reloading finished in 179 ms. machine # [ 3.198819] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace... machine # [ 3.201851] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace... machine # [ 3.204650] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 3.215583] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.226251] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.227317] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.233204] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 3.235815] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 3.567537] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.579256] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.593494] systemd[1]: Mounting /sysroot/run... machine # [ 3.617411] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.637299] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.639985] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.671286] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.674898] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.694082] systemd[1]: Mounted /sysroot/run. machine # [ 3.695935] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.705872] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.714288] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.727133] systemd[1]: Mounting /sysroot/nix/store... machine # [ 3.731713] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.768007] systemd[1]: Mounted /sysroot/nix/store. machine # [ 3.770514] systemd[1]: Reached target Initrd File Systems. machine # [ 3.774704] systemd[1]: Starting Find NixOS closure... machine # [ 3.784169] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 3.824120] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 3.839800] systemd[1]: Finished Find NixOS closure. machine # [ 3.843102] systemd[1]: Reached target Initrd Default Target. machine # [ 3.850923] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 3.878996] systemd[1]: Stopped target Initrd Default Target. machine # [ 3.880114] systemd[1]: Stopped target Basic System. machine # [ 3.881110] systemd[1]: Stopped target Initrd Root Device. machine # [ 3.885121] systemd[1]: Stopped target Path Units. machine # [ 3.887039] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 3.889987] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 3.892860] systemd[1]: Stopped target Slice Units. machine # [ 3.896791] systemd[1]: Stopped target Socket Units. machine # [ 3.898642] systemd[1]: Stopped target System Initialization. machine # [ 3.900844] systemd[1]: Stopped target Swaps. machine # [ 3.904768] systemd[1]: Stopped target Timer Units. machine # [ 3.906610] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 3.910458] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 3.912232] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 3.917110] systemd[1]: Stopped Find NixOS closure. machine # [ 3.918856] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 3.925543] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.929438] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 3.932464] systemd[1]: Stopped Apply Kernel Variables. machine # [ 3.940457] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 3.948725] systemd[1]: Stopped Load Kernel Modules. machine # [ 3.951479] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 3.957939] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 3.959047] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 3.962334] systemd[1]: Stopped Create System Files and Directories. machine # [ 3.965059] systemd[1]: Stopped target Local File Systems. machine # [ 3.965883] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 3.966818] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 3.967791] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 3.972843] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 3.976354] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 3.977419] systemd[1]: Stopped Virtual Console Setup. machine # [ 3.980455] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 3.981493] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 3.982580] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 3.983591] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 3.984828] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.985811] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.986617] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 3.987536] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 3.996287] systemd[1]: systemd-udevd.service: Consumed 1.128s CPU time over 2.253s wall clock time, 17.9M memory peak. machine # [ 3.997719] systemd[1]: Starting Cleanup udev Database... machine # [ 3.998726] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.004183] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.005078] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.006203] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.007171] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.012502] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.029139] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.032564] systemd[1]: Finished Cleanup udev Database. machine # [ 4.033385] systemd[1]: Reached target Switch Root. machine # [ 4.036498] systemd[1]: Starting NixOS Activation... machine # [ 4.197838] initrd-nixos-activation-start[172]: booting system configuration /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test machine # [ 4.262601] initrd-nixos-activation-start[172]: running activation script... machine # [ 4.680991] initrd-nixos-activation-start[195]: setting up /etc... machine # [ 4.935993] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 4.938692] systemd[1]: Finished NixOS Activation. machine # [ 4.943860] systemd[1]: Starting Switch Root... machine # [ 4.963906] systemd[1]: Switching root. machine # [ 5.153491] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). machine # [ 5.753522] systemd[1]: systemd 262-9457f81 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 # [ 5.766591] systemd[1]: Detected virtualization qemu. machine # [ 5.769570] systemd[1]: Detected architecture arm64. machine # [ 5.773383] systemd[1]: Detected first boot. machine # [ 5.780384] systemd[1]: Initializing machine ID from random generator. machine # [ 5.948524] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 6.111155] systemd[1]: Applying preset policy. machine # [ 6.589428] systemd[1]: Populated /etc with preset unit settings. machine # [ 7.086965] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 7.088315] systemd[1]: Stopped initrd-switch-root.service. machine # [ 7.091704] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 7.095326] systemd[1]: Created slice Slice /system/getty. machine # [ 7.097382] systemd[1]: Created slice User and Session Slice. machine # [ 7.098930] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 7.099369] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 7.099691] systemd[1]: Expecting device /dev/hvc0... machine # [ 7.099952] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 7.100208] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 7.100466] systemd[1]: Stopped target initrd-fs.target. machine # [ 7.100741] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 7.100987] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 7.101234] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 7.101494] systemd[1]: Reached target Path Units. machine # [ 7.101735] systemd[1]: Reached target Remote File Systems. machine # [ 7.101974] systemd[1]: Reached target Slice Units. machine # [ 7.110917] systemd[1]: Reached target Swaps. machine # [ 7.115416] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 7.120491] systemd[1]: Listening on Process Core Dump Socket. machine # [ 7.124462] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 7.128162] systemd[1]: Listening on Factory Reset Management. machine # [ 7.129378] systemd[1]: Listening on Hostname Service Socket. machine # [ 7.135073] systemd[1]: Starting Journal Log Access Socket... machine # [ 7.137140] systemd[1]: Listening on Journal Audit Socket. machine # [ 7.140902] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 7.142502] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 7.144214] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.147022] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 7.158232] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 7.160483] systemd[1]: Listening on udev Varlink Socket. machine # [ 7.165327] systemd[1]: Mounting Huge Pages File System... machine # [ 7.170697] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 7.179652] systemd[1]: Mounting Kernel Debug File System... machine # [ 7.191118] systemd[1]: Mounting Kernel Trace File System... machine # [ 7.203049] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 7.217005] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 7.220905] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 7.232110] systemd[1]: Mounting Kernel Configuration File System... machine # [ 7.237335] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 7.240142] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 7.265166] systemd[1]: Starting Load Kernel Module fuse... machine # [ 7.265556] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 7.336713] systemd[1]: Starting Journal Service... machine # [ 7.369196] systemd[1]: Starting Load Kernel Modules... machine # [ 7.399728] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 7.434867] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 7.438857] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.466784] systemd[1]: Starting Coldplug All udev Devices... machine # [ 7.469507] systemd[1]: Listening on Journal Log Access Socket. machine # [ 7.469926] systemd[1]: Mounted Huge Pages File System. machine # [ 7.482657] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 7.496697] fuse: init (API version 7.45) machine # [ 7.507638] systemd[1]: Mounted Kernel Debug File System. machine # [ 7.512325] systemd[1]: Mounted Kernel Trace File System. machine # [ 7.518667] systemd-journald[268]: Collecting audit messages is enabled. machine # [ 7.526250] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 7.527142] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 7.527679] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 7.528136] systemd[1]: Mounted Kernel Configuration File System. machine # [ 7.528784] systemd[1]: modprobe@fuse.service: Deactivated successfully. machine # [ 7.529299] systemd[1]: Finished Load Kernel Module fuse. machine # [ 7.529958] systemd[1]: Finished Load Kernel Modules. machine # [ 7.528828] systemd[1]: Queued start job for default target Multi-User System. machine # [ 7.531040] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 7.538232] systemd-modules-load[269]: Module 'atkbd' is built in machine # [ 7.555187] systemd[1]: Mounting FUSE Control File System... machine # [ 7.539984] systemd-modules-load[269]: Module 'loop' is built in machine # [ 7.569325] EXT4-fs (vda): re-mounted 7bb2c026-4bd6-45d1-a5ab-3ab3cf8fad6b. machine # [ 7.582607] systemd[1]: Starting Firewall... machine # [ 7.593400] systemd[1]: Starting Apply Kernel Variables... machine # [ 7.586276] systemd-oomd[270]: No swap; memory pressure usage will be degraded machine # [ 7.623158] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 7.632124] systemd[1]: Started Journal Service. machine # [ 7.645287] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 7.654061] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 7.693797] systemd[1]: Finished Apply Kernel Variables. machine # [ 7.712149] systemd[1]: Mounted FUSE Control File System. machine # [ 7.723528] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 7.733493] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 7.737904] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 7.751493] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 7.754227] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.816476] systemd-journald[268]: Received client request to flush runtime journal. machine # [ 7.870292] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 7.872367] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 7.875404] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 7.879571] systemd[1]: Reached target First Boot Complete. machine # [ 7.884943] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 7.958442] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 7.962111] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 7.965364] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 8.082193] systemd[1]: Mounting /run/wrappers... machine # [ 8.148911] systemd[1]: Mounted /run/wrappers. machine # [ 8.150374] systemd[1]: Reached target Local File Systems. machine # [ 8.154300] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 8.160747] systemd[1]: Starting register-nix-paths.service... machine # [ 8.184486] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 8.185480] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 8.201948] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 8.221109] systemd[1]: Starting Create System Files and Directories... machine # [ 8.232552] systemd-udevd[313]: Using default interface naming scheme 'v261'. machine # [ 8.376575] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 8.386164] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 8.465508] systemd[1]: Finished Create System Files and Directories. machine # [ 8.483417] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 8.493113] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 8.542942] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 8.656715] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 8.737190] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 8.752740] systemd[1]: Starting Update is Completed... machine # [ 8.860173] systemd[1]: Finished Update is Completed. machine # [ 9.225628] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 9.249722] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 9.468208] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 machine # [ 9.957409] systemd[1]: Finished register-nix-paths.service. machine # [ 10.020152] systemd[1]: Finished Coldplug All udev Devices. machine # [ 10.021177] systemd[1]: Reached target System Initialization. machine # [ 10.024213] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 10.025784] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 10.037630] systemd[1]: Reached target Timer Units. machine # [ 10.038598] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 10.039682] systemd[1]: Listening on Nix Daemon Socket. machine # [ 10.041480] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 10.048679] systemd[1]: Reached target Socket Units. machine # [ 10.056803] systemd[1]: Reached target Basic System. machine # [ 10.059395] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 10.060720] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 10.068715] systemd[1]: Starting Post-Boot Actions... machine # [ 10.080342] systemd[1]: Started Reset console on configuration changes. machine # [ 10.112116] systemd[1]: Starting resolvconf update... machine # [ 10.117060] systemd[1]: Finished Firewall. machine # [ 10.180439] systemd[1]: Starting D-Bus System Message Bus... machine # [ 10.215533] nsncd[476]: Sep 06 17:55:38.858 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 10.221831] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 10.232307] systemd[1]: Finished Post-Boot Actions. machine # [ 10.248532] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 10.256367] systemd[1]: Reached target User and Group Name Lookups. machine # [ 10.275768] systemd[1]: Starting User Login Management... machine # [ 10.320339] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 10.453870] dbus-broker-launch[484]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 10.463134] dbus-broker-launch[484]: NSS returned no entry for 'systemd-timesync' machine # [ 10.465877] dbus-broker-launch[484]: Invalid user-name in /nix/store/q9kni4k6lchfc3fafb6a1yk6yvf86s3s-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 10.478625] systemd-logind[499]: New seat seat0. machine # [ 10.485132] systemd[1]: Started User Login Management. machine # [ 10.491424] systemd[1]: Starting linger-users.service... machine # [ 10.514366] systemd[1]: Started D-Bus System Message Bus. machine # [ 10.522672] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 10.528391] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 10.539520] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 10.543893] systemd[1]: Stopping User and Group Name Lookups... machine # [ 10.546114] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 10.556442] systemd[1]: nscd.service: Deactivated successfully. machine # [ 10.557332] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 10.567676] dbus-broker-launch[484]: Ready machine # [ 10.578836] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 10.698658] systemd[1]: Created slice Slice /user/1001. machine # [ 10.717712] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 10.743752] nsncd[548]: Sep 06 17:55:39.389 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 10.788975] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 10.800477] systemd[1]: Finished linger-users.service. machine # [ 10.803979] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 10.828833] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 10.851086] systemd[1]: Reached target User and Group Name Lookups. machine # [ 10.866266] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 10.884612] systemd[1]: Starting User Manager for UID 1001... machine # [ 10.930999] systemd[1]: Finished resolvconf update. machine # [ 10.949282] systemd[1]: Reached target Preparation for Network. machine # [ 10.967011] systemd[1]: Starting DHCP Client... machine # [ 10.986818] systemd[1]: Starting Extra networking commands.... machine # [ 11.010179] systemd[1]: Starting Virtual Console Setup... machine # [ 11.037940] (systemd)[576]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 11.068528] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 11.118091] systemd-logind[499]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 11.163898] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 11.303311] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 11.316851] systemd[1]: Stopped Virtual Console Setup. machine # [ 11.325970] systemd[1]: Starting Virtual Console Setup... machine # [ 11.390509] systemd[576]: Queued start job for default target Main User Target. machine # [ 11.401036] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 11.420504] systemd[576]: Created slice User Application Slice. machine # [ 11.425054] systemd[576]: Started Daily Cleanup of User's Temporary Directories. machine # [ 11.433570] systemd[576]: Reached target Paths. machine # [ 11.439227] systemd[576]: Reached target Timers. machine # [ 11.444820] systemd[576]: Starting D-Bus User Message Bus Socket... machine # [ 11.460200] systemd[576]: Starting Create User Files and Directories... machine # [ 11.488818] systemd[576]: Finished Create User Files and Directories. machine # [ 11.568304] systemd[576]: Listening on D-Bus User Message Bus Socket. machine # [ 11.569375] systemd[576]: Reached target Sockets. machine # [ 11.570088] systemd[576]: Reached target Basic System. machine # [ 11.570872] systemd[1]: Started User Manager for UID 1001. machine # [ 11.571678] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 11.635603] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 11.650467] systemd[576]: Reached target Main User Target. machine # [ 11.665766] systemd[576]: Startup finished in 523ms. machine # [ 11.738625] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 11.772464] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 11.792720] systemd[1]: Started backdoor.service. machine # [ 11.892471] systemd-logind[499]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 11.917554] (udev-worker)[638]: Network interface NamePolicy= disabled on kernel command line. machine # [ 11.946186] (udev-worker)[626]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 12.009731] dhcpcd[596]: dhcpcd-10.3.2 starting machine # [ 12.034658] (udev-worker)[626]: Network interface NamePolicy= disabled on kernel command line. machine # [ 12.066155] dhcpcd[663]: dev: loaded udev machine # [ 12.098047] 8021q: 802.1Q VLAN Support v1.8 machine # [ 12.126888] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 12.182845] systemd[1]: Starting Address configuration of eth1...[ 12.196172] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # machine # [ 12.234684] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 12.235173] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 12.240163] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 12.240488] cfg80211: failed to load regulatory.db machine # [ 12.220226] systemd[1]: Finished Extra networking commands.. machine # [ 12.249222] systemd[1]: Reached target Network. machine # [ 12.264576] systemd[1]: Starting Permit User Sessions... machine # [ 12.279382] systemd-logind[499]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # connecting to host... machine # [ 12.421372] mousedev: PS/2 mouse device common for all mice machine: Guest shell says: b'Spawning backdoor root shell...\n' machine # [ 12.435528] systemd[1]: Finished Permit User Sessions. machine: connected to guest root shell machine # [ 12.444489] systemd[1]: Started Getty on tty1. machine: (connecting took 12.74 seconds) machine # [ 12.445179] systemd[1]: Reached target Login Prompts. machine: (finished: waiting for the VM to finish booting, in 13.24 seconds) machine # [ 12.547640] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 12.550186] dhcpcd[663]: eth0: waiting for carrier machine # [ 12.575311] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 12.583826] dhcpcd[663]: eth0: waiting for carrier machine # [ 12.594297] dhcpcd[663]: eth0: carrier acquired machine # [ 12.660591] systemd-logind[499]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 12.679556] network-addresses-eth1-start[673]: adding address 192.168.1.1/24... done machine # [ 12.703471] dhcpcd[663]: DUID 00:01:00:01:32:30:65:9d:52:54:00:12:34:56 machine # [ 12.728783] dhcpcd[663]: eth0: IAID 00:12:34:56 machine # [ 12.739851] dhcpcd[663]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 12.760947] network-addresses-eth1-start[673]: adding address 2001:db8:1::1/64... done machine # [ 12.864325] systemd[1]: Finished Address configuration of eth1. machine # [ 13.076407] systemd-vconsole-setup[591]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 13.101765] systemd[1]: Finished Virtual Console Setup. machine # [ 13.465495] dhcpcd[663]: eth0: soliciting a DHCP lease machine # [ 13.481250] dhcpcd[663]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 13.491107] dhcpcd[663]: eth0: probing address 10.0.2.15/24 machine # [ 13.709087] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 13.715761] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 13.724388] systemd[1]: Stopped Virtual Console Setup. machine # [ 13.728525] systemd[1]: Stopping Virtual Console Setup... machine # [ 13.729375] systemd[1]: Starting Virtual Console Setup... machine # [ 13.752527] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 13.753653] systemd[1]: Stopped Virtual Console Setup. machine # [ 13.757065] systemd[1]: Starting Virtual Console Setup... machine # [ 14.109339] systemd-vconsole-setup[719]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 14.114260] systemd[1]: Finished Virtual Console Setup. machine # [ 14.969248] dhcpcd[663]: eth0: soliciting an IPv6 router machine # [ 14.971754] dhcpcd[663]: eth0: Router Advertisement from fe80::2 machine # [ 14.974513] dhcpcd[663]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 14.977460] dhcpcd[663]: eth0: adding route to fec0::/64 machine # [ 14.979776] dhcpcd[663]: eth0: adding default route via fe80::2 machine # [ 18.021623] dhcpcd[663]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 18.023551] dhcpcd[663]: eth0: adding route to 10.0.2.0/24 machine # [ 18.025292] dhcpcd[663]: eth0: adding default route via 10.0.2.2 machine # [ 18.155860] systemd[1]: Started DHCP Client. machine # [ 18.158096] systemd[1]: Reached target Multi-User System. machine # [ 18.158922] systemd[1]: Startup finished in 919ms (kernel) + 4.340s (initrd) + 12.896s (userspace) = 18.157s. machine: (finished: waiting for unit multi-user.target, in 19.36 seconds) machine: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 19.204381] nixos[826]: switching to system configuration /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test machine # [ 19.207023] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # [ 19.209439] systemd[1]: Stopped target Local File Systems. machine # setting up /etc... machine # [ 19.664592] systemd[1]: Reload requested from client PID 826 ('.switch-to-conf') (unit backdoor.service)... machine # [ 19.666511] systemd[1]: Reloading... machine # [ 20.247094] systemd[1]: Reloading finished in 578 ms. machine # reloading user units for usertest... machine # [ 20.293481] systemd[576]: Created slice User Core Session Slice. machine # [ 20.296767] systemd[576]: Starting D-Bus User Message Bus... machine # [ 20.355401] dbus-broker-launch[897]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/q9kni4k6lchfc3fafb6a1yk6yvf86s3s-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 20.358589] dbus-broker-launch[897]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/q9kni4k6lchfc3fafb6a1yk6yvf86s3s-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 20.361695] dbus-broker-launch[897]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/q9kni4k6lchfc3fafb6a1yk6yvf86s3s-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 20.365041] dbus-broker-launch[897]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/q9kni4k6lchfc3fafb6a1yk6yvf86s3s-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 20.368536] dbus-broker-launch[897]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 20.371037] dbus-broker-launch[897]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 20.373346] systemd[576]: Started D-Bus User Message Bus. machine # [ 20.380218] dbus-broker-launch[897]: Ready machine # [ 20.481526] systemd[576]: Reexecution requested from client PID 896 ('switch-to-confi')... machine # [ 20.484817] systemd[576]: Reexecuting. machine # [ 20.533351] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.716063] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.722120] systemd[576]: Reload requested from client PID 896 ('switch-to-confi')... machine # [ 20.724319] systemd[576]: Reloading... machine # [ 20.909795] systemd[576]: Reloading finished in 184 ms. machine # [ 20.924140] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 20.933964] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 20.936167] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 20.938920] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 20.984164] systemd[576]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 21.000358] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 21.100111] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 21.103149] systemd[1]: Reached target Reactivate sysinit units. machine # [ 21.106313] systemd[1]: Reached target Local File Systems. machine # [ 21.109596] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 21.114061] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 21.114948] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 21.118861] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 21.125490] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 21.127233] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.133134] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.134371] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.135640] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 21.139107] systemd[1]: Reached target Remote File Systems. machine # [ 21.445020] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 21.448458] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 21.452804] systemd[1]: Starting linger-users.service... machine # [ 21.511644] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 21.514242] systemd[1]: Finished linger-users.service. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 21.778241] nixos[826]: finished switching to system configuration /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test machine: (finished: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/bin/switch-to-configuration test, in 3.22 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/fkrnrx1kb4pvplbfnsgm5jx77m1hvwvw-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/fkrnrx1kb4pvplbfnsgm5jx77m1hvwvw-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 22.487176] nixos[974]: switching to system configuration /nix/store/fkrnrx1kb4pvplbfnsgm5jx77m1hvwvw-nixos-system-other-test machine # [ 22.489957] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # [ 22.492682] systemd[1]: Stopped target Local File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 22.983787] systemd[1]: Reload requested from client PID 974 ('.switch-to-conf') (unit backdoor.service)... machine # [ 22.985970] systemd[1]: Reloading... machine # [ 23.622442] systemd[1]: Reloading finished in 634 ms. machine # reloading user units for usertest... machine # [ 23.777380] systemd[576]: Reexecution requested from client PID 1046 ('switch-to-confi')... machine # [ 23.781405] systemd[576]: Reexecuting. machine # [ 23.842267] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.039555] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.046876] systemd[576]: Reload requested from client PID 1046 ('switch-to-confi')... machine # [ 24.049386] systemd[576]: Reloading... machine # [ 24.232679] systemd[576]: Reloading finished in 182 ms. machine # [ 24.248179] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 24.258520] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 24.260848] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 24.263761] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 24.309570] systemd[576]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 24.314691] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 24.315591] systemd[1]: Stopping Reactivate sysinit units... machine # reloading the following units: dbus-broker.service machine # [ 24.317791] systemd[1]: Reached target Reactivate sysinit units. machine # [ 24.319961] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 24.322410] dbus-broker-launch[484]: Caught SIGHUP, trigger reload. machine # [ 24.343659] dbus-broker-launch[484]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 24.345864] dbus-broker-launch[484]: NSS returned no entry for 'systemd-timesync' machine # [ 24.347010] dbus-broker-launch[484]: Invalid user-name in /nix/store/2d37a0ag8593x6bsc14irprkj2vpg80c-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 24.378201] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 24.385390] systemd[1]: Stopping Address configuration of eth1... machine # [ 24.437748] network-addresses-eth1-pre-stop[1058]: deleting address 192.168.1.1/24... done machine # [ 24.449025] network-addresses-eth1-pre-stop[1058]: deleting address 2001:db8:1::1/64... done machine # [ 24.458711] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 24.462399] systemd[1]: Stopped Address configuration of eth1. machine # [ 24.464937] systemd[1]: Starting Address configuration of eth1... machine # [ 24.534947] network-addresses-eth1-start[1063]: adding address 192.168.1.2/24... done machine # [ 24.548088] network-addresses-eth1-start[1063]: adding address 2001:db8:1::2/64... done machine # [ 24.563007] systemd[1]: Finished Address configuration of eth1. machine # [ 24.568218] systemd[1]: Reached target Local File Systems. machine # [ 24.572272] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.573858] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 24.577294] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 24.578808] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 24.579581] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 24.583751] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 24.595020] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 24.599784] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.601275] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.602455] systemd[1]: Reached target Remote File Systems. machine # [ 24.974112] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 24.978679] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 24.981353] systemd[1]: Starting linger-users.service... machine # [ 25.026266] linger-users-start[1135]: id: ‘usertest’: no such user machine # [ 25.028710] linger-users-start[1133]: Removing linger for missing user usertest machine # [ 25.037718] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 25.039950] systemd[1]: Finished linger-users.service. machine # [ 25.298408] nixos[974]: finished switching to system configuration /nix/store/fkrnrx1kb4pvplbfnsgm5jx77m1hvwvw-nixos-system-other-test machine: (finished: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/fkrnrx1kb4pvplbfnsgm5jx77m1hvwvw-nixos-system-other-test/bin/switch-to-configuration test, in 3.47 seconds) subtest: services machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 25.907198] nixos[1141]: switching to system configuration /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test machine # [ 25.909699] systemd[1]: Stopped target Local File Systems. machine # [ 25.911907] systemd[1]: Stopped target Remote File Systems. machine # [ 26.359210] systemd[1]: Reload requested from client PID 1141 ('.switch-to-conf') (unit backdoor.service)... machine # [ 26.361507] systemd[1]: Reloading... machine # [ 26.959818] systemd[1]: Reloading finished in 596 ms. machine # [ 27.105986] systemd[576]: Reexecution requested from client PID 1211 ('switch-to-confi')... machine # [ 27.107372] systemd[576]: Reexecuting. machine # [ 27.169793] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.361713] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.369124] systemd[576]: Reload requested from client PID 1211 ('switch-to-confi')... machine # [ 27.371516] systemd[576]: Reloading... machine # [ 27.565568] systemd[576]: Reloading finished in 192 ms. machine # [ 27.576194] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.585767] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 27.588497] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 27.592114] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 27.640230] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 27.645077] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 27.649476] systemd[1]: Stopping Reactivate sysinit units... machine # [ 27.650534] systemd[1]: Reached target Reactivate sysinit units. machine # [ 27.651717] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 27.653495] dbus-broker-launch[484]: Caught SIGHUP, trigger reload. machine # [ 27.666362] dbus-broker-launch[484]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 27.668687] dbus-broker-launch[484]: NSS returned no entry for 'systemd-timesync' machine # [ 27.669926] dbus-broker-launch[484]: Invalid user-name in /nix/store/q9kni4k6lchfc3fafb6a1yk6yvf86s3s-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 27.689831] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 27.696684] systemd[1]: Stopping Address configuration of eth1... machine # [ 27.745243] network-addresses-eth1-pre-stop[1223]: deleting address 192.168.1.2/24... done machine # [ 27.756841] network-addresses-eth1-pre-stop[1223]: deleting address 2001:db8:1::2/64... done machine # [ 27.767084] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 27.769354] systemd[1]: Stopped Address configuration of eth1. machine # [ 27.774290] systemd[1]: Starting Address configuration of eth1... machine # [ 27.846064] network-addresses-eth1-start[1228]: adding address 192.168.1.1/24... done machine # [ 27.857566] network-addresses-eth1-start[1228]: adding address 2001:db8:1::1/64... done machine # [ 27.872597] systemd[1]: Finished Address configuration of eth1. machine # [ 27.879404] systemd[1]: Reached target Local File Systems. machine # [ 27.882871] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 27.887016] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 27.887867] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 27.892549] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 27.897221] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 27.902319] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.908245] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.909488] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.910742] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 27.911967] systemd[1]: Reached target Remote File Systems. machine # [ 28.215840] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 28.218313] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 28.223021] systemd[1]: Starting linger-users.service... machine # [ 28.270979] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 28.273847] systemd[1]: Finished linger-users.service. machine # [ 28.530795] nixos[1141]: finished switching to system configuration /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.23 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 29.149153] nixos[1297]: switching to system configuration /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test machine # [ 29.151826] systemd[1]: Stopped target Local File Systems. machine # [ 29.154178] systemd[1]: Stopped target Remote File Systems. machine # [ 29.598722] systemd[1]: Reload requested from client PID 1297 ('.switch-to-conf') (unit backdoor.service)... machine # [ 29.600973] systemd[1]: Reloading... machine # [ 30.335967] systemd[1]: Reloading finished in 732 ms. machine # [ 30.514440] systemd[576]: Reexecution requested from client PID 1367 ('switch-to-confi')... machine # [ 30.518629] systemd[576]: Reexecuting. machine # [ 30.574347] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.807177] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.816197] systemd[576]: Reload requested from client PID 1367 ('switch-to-confi')... machine # [ 30.818927] systemd[576]: Reloading... machine # [ 31.051097] systemd[576]: Reloading finished in 230 ms. machine # [ 31.068304] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.081899] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 31.085128] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 31.089254] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 31.148939] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 31.153742] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 31.156904] systemd[1]: Stopping Reactivate sysinit units... machine # [ 31.158873] systemd[1]: Reached target Reactivate sysinit units. machine # [ 31.163560] systemd[1]: Reached target Remote File Systems. machine # [ 31.167662] systemd[1]: Starting linger-users.service... machine # [ 31.171933] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.178223] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 31.179602] systemd[1]: Reached target Local File Systems. machine # [ 31.193342] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 31.203652] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 31.207239] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 31.210785] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 31.213460] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 31.220243] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.222088] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.302566] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 31.306482] systemd[1]: Finished linger-users.service. machine # [ 31.649964] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 31.654652] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 31.915477] nixos[1297]: finished switching to system configuration /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.39 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 32.583103] nixos[1438]: switching to system configuration /nix/store/0g51ffg5s2lfjpchq6xrh5x2vsha1kyf-nixos-system-machine-test machine # [ 32.586524] systemd[1]: Stopped target Local File Systems. machine # [ 32.587980] systemd[1]: Stopped target Remote File Systems. machine # [ 33.107143] systemd[1]: Reload requested from client PID 1438 ('.switch-to-conf') (unit backdoor.service)... machine # [ 33.109300] systemd[1]: Reloading... machine # [ 33.765526] systemd[1]: Reloading finished in 654 ms. machine # [ 33.914011] systemd[576]: Reexecution requested from client PID 1508 ('switch-to-confi')... machine # [ 33.917763] systemd[576]: Reexecuting. machine # [ 33.970019] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.167109] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.174131] systemd[576]: Reload requested from client PID 1508 ('switch-to-confi')... machine # [ 34.176180] systemd[576]: Reloading... machine # [ 34.366712] systemd[576]: Reloading finished in 189 ms. machine # [ 34.380166] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.389149] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 34.391492] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 34.394324] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 34.441628] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 34.446152] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 34.448181] systemd[1]: Stopping Reactivate sysinit units... machine # [ 34.449102] systemd[1]: Reached target Reactivate sysinit units. machine # [ 34.452386] systemd[1]: Reached target Local File Systems. machine # [ 34.455250] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.457666] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 34.462200] systemd[1]: Reached target Remote File Systems. machine # [ 34.465608] systemd[1]: Starting linger-users.service... machine # [ 34.468176] systemd[1]: Starting test.service... machine # [ 34.474125] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 34.486079] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 34.486984] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 34.489378] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 34.496928] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 34.501229] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.506114] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.539381] systemd[1]: Finished test.service. machine # [ 34.571927] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 34.575244] systemd[1]: Finished linger-users.service. machine # [ 34.842931] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 34.846334] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 35.104853] nixos[1438]: finished switching to system configuration /nix/store/0g51ffg5s2lfjpchq6xrh5x2vsha1kyf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 3.19 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 35.740496] nixos[1581]: switching to system configuration /nix/store/0g51ffg5s2lfjpchq6xrh5x2vsha1kyf-nixos-system-machine-test machine # [ 35.744100] systemd[1]: Stopped target Local File Systems. machine # [ 35.745455] systemd[1]: Stopped target Remote File Systems. machine # [ 36.194368] systemd[1]: Reload requested from client PID 1581 ('.switch-to-conf') (unit backdoor.service)... machine # [ 36.196336] systemd[1]: Reloading... machine # [ 36.809555] systemd[1]: Reloading finished in 610 ms. machine # [ 36.954354] systemd[576]: Reexecution requested from client PID 1651 ('switch-to-confi')... machine # [ 36.958474] systemd[576]: Reexecuting. machine # [ 37.006182] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.200779] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.208734] systemd[576]: Reload requested from client PID 1651 ('switch-to-confi')... machine # [ 37.211721] systemd[576]: Reloading... machine # [ 37.411233] systemd[576]: Reloading finished in 199 ms. machine # [ 37.424191] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.434726] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 37.435817] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 37.439046] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 37.488828] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 37.493743] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 37.497526] systemd[1]: Stopping Reactivate sysinit units... machine # [ 37.498500] systemd[1]: Reached target Reactivate sysinit units. machine # [ 37.499349] systemd[1]: Reached target Local File Systems. machine # [ 37.504285] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 37.508759] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 37.509687] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 37.510925] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 37.514609] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 37.528829] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.530187] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.531368] systemd[1]: Reached target Remote File Systems. machine # [ 37.535848] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.537610] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 37.868341] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 37.872609] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 37.875271] systemd[1]: Starting linger-users.service... machine # [ 37.939033] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 37.941719] systemd[1]: Finished linger-users.service. machine # [ 38.197562] nixos[1581]: finished switching to system configuration /nix/store/0g51ffg5s2lfjpchq6xrh5x2vsha1kyf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 3.09 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 38.814535] nixos[1722]: switching to system configuration /nix/store/h0b7sd9qr8a6vgl23jkzahr8n304nhgz-nixos-system-machine-test machine # [ 38.818488] systemd[1]: Stopped target Local File Systems. machine # [ 38.819776] systemd[1]: Stopped target Remote File Systems. machine # [ 39.373105] systemd[1]: Reload requested from client PID 1722 ('.switch-to-conf') (unit backdoor.service)... machine # [ 39.375158] systemd[1]: Reloading... machine # [ 40.033508] systemd[1]: Reloading finished in 656 ms. machine # [ 40.175396] systemd[576]: Reexecution requested from client PID 1792 ('switch-to-confi')... machine # [ 40.177519] systemd[576]: Reexecuting. machine # [ 40.247317] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.438946] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.445491] systemd[576]: Reload requested from client PID 1792 ('switch-to-confi')... machine # [ 40.447994] systemd[576]: Reloading... machine # [ 40.634942] systemd[576]: Reloading finished in 185 ms. machine # [ 40.652161] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.662142] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 40.664452] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 40.667320] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 40.713051] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 40.717396] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 40.720174] systemd[1]: Stopping Reactivate sysinit units... machine # [ 40.721136] systemd[1]: Reached target Reactivate sysinit units. machine # [ 40.721980] systemd[1]: Reached target Remote File Systems. machine # [ 40.724949] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.727499] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 40.733365] systemd[1]: Starting linger-users.service... machine # [ 40.736954] systemd[1]: Reached target Local File Systems. machine # [ 40.744143] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 40.747748] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 40.751380] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 40.756532] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 40.758711] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 40.767630] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.769316] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.825699] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 40.828528] systemd[1]: Finished linger-users.service. machine # [ 41.100906] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 41.104467] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 41.361152] nixos[1722]: finished switching to system configuration /nix/store/h0b7sd9qr8a6vgl23jkzahr8n304nhgz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 3.17 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 41.978373] nixos[1863]: switching to system configuration /nix/store/nddm39yhin93faxx4z4z7r6yf2sbc2iz-nixos-system-machine-test machine # [ 41.981152] systemd[1]: Stopped target Local File Systems. machine # [ 41.984237] systemd[1]: Stopped target Remote File Systems. machine # [ 41.985268] systemd[1]: test.service: Deactivated successfully. machine # [ 41.986176] systemd[1]: Stopped Test unit. machine # [ 42.518831] systemd[1]: Reload requested from client PID 1863 ('.switch-to-conf') (unit backdoor.service)... machine # [ 42.520935] systemd[1]: Reloading... machine # [ 43.172454] systemd[1]: Reloading finished in 648 ms. machine # [ 43.318454] systemd[576]: Reexecution requested from client PID 1933 ('switch-to-confi')... machine # [ 43.319798] systemd[576]: Reexecuting. machine # [ 43.390350] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.587886] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.594194] systemd[576]: Reload requested from client PID 1933 ('switch-to-confi')... machine # [ 43.596394] systemd[576]: Reloading... machine # [ 43.778786] systemd[576]: Reloading finished in 180 ms. machine # [ 43.792143] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.800796] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 43.803025] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 43.805697] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 43.852810] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 43.857003] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 43.858314] systemd[1]: Stopping Reactivate sysinit units... machine # [ 43.859152] systemd[1]: Reached target Reactivate sysinit units. machine # [ 43.861995] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.864648] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 43.870371] systemd[1]: Starting test.service... machine # [ 43.880935] systemd[1]: Reached target Remote File Systems. machine # [ 43.881873] systemd[1]: Reached target Local File Systems. machine # [ 43.885085] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 43.893183] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 43.894085] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 43.895343] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 43.902111] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 43.904054] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.905832] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.938059] systemd[1]: Finished test.service. machine # [ 44.220583] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 44.224680] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 44.227705] systemd[1]: Starting linger-users.service... machine # [ 44.284855] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 44.286934] systemd[1]: Finished linger-users.service. machine # [ 44.543841] nixos[1863]: finished switching to system configuration /nix/store/nddm39yhin93faxx4z4z7r6yf2sbc2iz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 3.18 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 45.150681] nixos[2006]: switching to system configuration /nix/store/9gkxac46y07mli01920h4isghs5ifx4y-nixos-system-machine-test machine # [ 45.153480] systemd[1]: Stopped target Local File Systems. machine # [ 45.155936] systemd[1]: Stopped target Remote File Systems. machine # [ 45.688545] systemd[1]: Reload requested from client PID 2006 ('.switch-to-conf') (unit backdoor.service)... machine # [ 45.690437] systemd[1]: Reloading... machine # [ 46.331547] systemd[1]: Reloading finished in 638 ms. machine # [ 46.479398] systemd[576]: Reexecution requested from client PID 2076 ('switch-to-confi')... machine # [ 46.481916] systemd[576]: Reexecuting. machine # [ 46.546227] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.749929] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.756230] systemd[576]: Reload requested from client PID 2076 ('switch-to-confi')... machine # [ 46.758597] systemd[576]: Reloading... machine # [ 46.952277] systemd[576]: Reloading finished in 192 ms. machine # [ 46.968156] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.978580] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 46.980996] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 46.983998] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 47.027364] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 47.031684] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 47.033766] systemd[1]: Stopping Reactivate sysinit units... machine # [ 47.035202] systemd[1]: Reached target Reactivate sysinit units. machine # [ 47.038706] systemd[1]: test.service: Deactivated successfully. machine # [ 47.039863] systemd[1]: Stopped test.service. machine # [ 47.041855] systemd[1]: Stopping test.service... machine # [ 47.042580] systemd[1]: Starting test.service... machine # [ 47.079684] systemd[1]: Finished test.service. machine # [ 47.085091] systemd[1]: Reached target Local File Systems. machine # [ 47.087732] systemd[1]: Reached target Remote File Systems. machine # [ 47.092787] systemd[1]: Starting linger-users.service... machine # [ 47.096334] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 47.103365] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 47.108673] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 47.109968] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 47.121131] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 47.122885] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.124283] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.125439] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.126663] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 47.187812] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 47.191165] systemd[1]: Finished linger-users.service. machine # [ 47.442886] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 47.446074] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 47.703197] nixos[2006]: finished switching to system configuration /nix/store/9gkxac46y07mli01920h4isghs5ifx4y-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.16 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 48.351866] nixos[2149]: switching to system configuration /nix/store/f405ibjvhjyddl1n8f83qbvlaa1ajz26-nixos-system-machine-test machine # [ 48.354589] systemd[1]: Stopped target Local File Systems. machine # [ 48.356909] systemd[1]: Stopped target Remote File Systems. machine # [ 48.853159] systemd[1]: Reload requested from client PID 2149 ('.switch-to-conf') (unit backdoor.service)... machine # [ 48.855116] systemd[1]: Reloading... machine # [ 49.462046] systemd[1]: Reloading finished in 604 ms. machine # [ 49.596352] systemd[576]: Reexecution requested from client PID 2218 ('switch-to-confi')... machine # [ 49.600575] systemd[576]: Reexecuting. machine # [ 49.658974] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.858658] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.865700] systemd[576]: Reload requested from client PID 2218 ('switch-to-confi')... machine # [ 49.868456] systemd[576]: Reloading... machine # [ 50.053062] systemd[576]: Reloading finished in 183 ms. machine # [ 50.068184] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.078255] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 50.080874] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 50.084094] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 50.132198] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 50.136886] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 50.140514] systemd[1]: Stopping Reactivate sysinit units... machine # [ 50.141417] systemd[1]: Reached target Reactivate sysinit units. machine # [ 50.145504] systemd[1]: Reloading test.service... machine # [ 50.185145] systemd[1]: Reloaded test.service. machine # [ 50.190921] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.193763] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 50.198098] systemd[1]: Reached target Remote File Systems. machine # [ 50.201211] systemd[1]: Starting linger-users.service... machine # [ 50.211384] systemd[1]: Reached target Local File Systems. machine # [ 50.212452] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 50.218804] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 50.223060] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 50.229287] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 50.231518] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 50.234936] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.238043] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.301826] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 50.304888] systemd[1]: Finished linger-users.service. machine # [ 50.560739] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 50.564348] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 50.823356] nixos[2149]: finished switching to system configuration /nix/store/f405ibjvhjyddl1n8f83qbvlaa1ajz26-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 3.12 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 51.462183] nixos[2291]: switching to system configuration /nix/store/c3q2ln63wnh9sc1xkp6590g4lgrv1mnn-nixos-system-machine-test machine # [ 51.465386] systemd[1]: Stopped target Local File Systems. machine # [ 51.467323] systemd[1]: Stopped target Remote File Systems. machine # [ 51.968853] systemd[1]: Reload requested from client PID 2291 ('.switch-to-conf') (unit backdoor.service)... machine # [ 51.970770] systemd[1]: Reloading... machine # [ 52.605561] systemd[1]: Reloading finished in 632 ms. machine # [ 52.758012] systemd[576]: Reexecution requested from client PID 2360 ('switch-to-confi')... machine # [ 52.762419] systemd[576]: Reexecuting. machine # [ 52.817827] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.010936] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.018425] systemd[576]: Reload requested from client PID 2360 ('switch-to-confi')... machine # [ 53.020994] systemd[576]: Reloading... machine # [ 53.211639] systemd[576]: Reloading finished in 189 ms. machine # [ 53.228153] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.237436] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 53.239724] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 53.242502] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 53.289523] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 53.294307] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 53.297546] systemd[1]: Stopping Reactivate sysinit units... machine # [ 53.299562] systemd[1]: Reached target Reactivate sysinit units. machine # [ 53.304153] systemd[1]: Reached target Local File Systems. machine # [ 53.307687] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 53.312156] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 53.313027] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 53.314233] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 53.318561] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 53.329717] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.331052] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.334330] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.335619] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 53.336977] systemd[1]: Reached target Remote File Systems. machine # [ 53.647844] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 53.652279] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 53.655740] systemd[1]: Starting linger-users.service... machine # [ 53.715505] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 53.717460] systemd[1]: Finished linger-users.service. machine # [ 53.976659] nixos[2291]: finished switching to system configuration /nix/store/c3q2ln63wnh9sc1xkp6590g4lgrv1mnn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 3.15 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.67 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 55.209632] nixos[2441]: switching to system configuration /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test machine # [ 55.213721] systemd[1]: Stopped target Local File Systems. machine # [ 55.215440] systemd[1]: Stopped target Remote File Systems. machine # [ 55.216940] systemd[1]: test.service: Deactivated successfully. machine # [ 55.217794] systemd[1]: Stopped test.service. machine # [ 55.657659] systemd[1]: Reload requested from client PID 2441 ('.switch-to-conf') (unit backdoor.service)... machine # [ 55.659649] systemd[1]: Reloading... machine # [ 56.250861] systemd[1]: Reloading finished in 588 ms. machine # [ 56.395510] systemd[576]: Reexecution requested from client PID 2510 ('switch-to-confi')... machine # [ 56.403289] systemd[576]: Reexecuting. machine # [ 56.461723] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.653660] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.660562] systemd[576]: Reload requested from client PID 2510 ('switch-to-confi')... machine # [ 56.663072] systemd[576]: Reloading... machine # [ 56.849178] systemd[576]: Reloading finished in 184 ms. machine # [ 56.864150] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.874008] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 56.876127] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 56.879085] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 56.924542] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 56.928942] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 56.929936] systemd[1]: Stopping Reactivate sysinit units... machine # [ 56.930749] systemd[1]: Reached target Reactivate sysinit units. machine # [ 56.934178] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.938643] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 56.939948] systemd[1]: Reached target Remote File Systems. machine # [ 56.941666] systemd[1]: Reached target Local File Systems. machine # [ 56.944677] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 56.951500] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 56.954323] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 56.957865] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 56.960850] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 56.963144] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.968285] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.280799] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 57.284685] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 57.288751] systemd[1]: Starting linger-users.service... machine # [ 57.347302] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 57.350279] systemd[1]: Finished linger-users.service. machine # [ 57.606919] nixos[2441]: finished switching to system configuration /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.96 seconds) machine: must succeed: /nix/store/pfd0qvyry9wawbdyq7nx8hhdipj4bbvl-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 58.214370] nixos[2581]: switching to system configuration /nix/store/wsy896zs9is9lmv0vm8jp664c7vcp1g6-nixos-system-machine-test machine # [ 58.218453] systemd[1]: Stopped target Remote File Systems. machine # [ 58.219610] systemd[1]: Stopped target Local File Systems. machine # [ 58.750370] systemd[1]: Reload requested from client PID 2581 ('.switch-to-conf') (unit backdoor.service)... machine # [ 58.752546] systemd[1]: Reloading... machine # [ 59.355297] systemd[1]: Reloading finished in 600 ms. machine # [ 59.517140] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 59.522356] systemd[576]: Reexecution requested from client PID 2649 ('switch-to-confi')... machine # [ 59.523753] systemd[576]: Reexecuting. machine # [ 59.586139] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.779511] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.786284] systemd[576]: Reload requested from client PID 2649 ('switch-to-confi')... machine # [ 59.789105] systemd[576]: Reloading... machine # [ 59.969598] systemd[576]: Reloading finished in 179 ms. machine # [ 59.984166] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.996611] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 59.999474] systemd[1]: Stopping Reactivate sysinit units... machine # [ 60.001126] systemd[1]: Reached target Reactivate sysinit units. machine # [ 60.001966] systemd[1]: Reached target Local File Systems. machine # [ 60.005843] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 60.011428] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 60.014771] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 60.017408] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 60.019584] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 60.029777] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.031141] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.034892] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.039455] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 60.044191] systemd[1]: Reached target Remote File Systems. machine # [ 60.360172] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 60.362713] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 60.370184] systemd[1]: Starting linger-users.service... machine # [ 60.373509] systemd[1]: Starting test.service... machine # [ 60.421954] systemd[1]: Finished test.service. machine # [ 60.452138] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 60.454355] systemd[1]: Finished linger-users.service. machine # [ 60.714301] nixos[2581]: finished switching to system configuration /nix/store/wsy896zs9is9lmv0vm8jp664c7vcp1g6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/pfd0qvyry9wawbdyq7nx8hhdipj4bbvl-separate-activation-script/bin/switch-to-configuration test 2>&1, in 3.11 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/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 61.392182] nixos[2729]: switching to system configuration /nix/store/igs01w5cq5hvcy0lx0lxqwfwdcqdirv2-nixos-system-machine-test machine # [ 61.396661] systemd[1]: Stopped target Local File Systems. machine # [ 61.399340] systemd[1]: Stopped target Remote File Systems. machine # [ 61.400554] systemd[1]: test.service: Deactivated successfully. machine # [ 61.401812] systemd[1]: Stopped test.service. machine # [ 61.925616] systemd[1]: Reload requested from client PID 2729 ('.switch-to-conf') (unit backdoor.service)... machine # [ 61.927635] systemd[1]: Reloading... machine # [ 62.556651] systemd[1]: Reloading finished in 626 ms. machine # [ 62.704544] systemd[576]: Reexecution requested from client PID 2798 ('switch-to-confi')... machine # [ 62.708811] systemd[576]: Reexecuting. machine # [ 62.771644] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.977965] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.985889] systemd[576]: Reload requested from client PID 2798 ('switch-to-confi')... machine # [ 62.988869] systemd[576]: Reloading... machine # [ 63.183449] systemd[576]: Reloading finished in 193 ms. machine # [ 63.200236] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.212070] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 63.264123] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 63.269857] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 63.271364] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 63.274591] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 63.277791] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 63.284586] systemd[1]: Stopping Reactivate sysinit units... machine # [ 63.285530] systemd[1]: Reached target Reactivate sysinit units. machine # [ 63.292113] systemd[1]: Reached target Local File Systems. machine # [ 63.294115] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 63.303707] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 63.307709] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 63.311216] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 63.324424] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 63.329131] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.330458] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.335018] systemd[1]: Reached target Remote File Systems. machine # [ 63.340621] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.341953] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 63.359312] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 63.682800] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 63.687242] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 63.691549] systemd[1]: Starting linger-users.service... machine # [ 63.695227] systemd[1]: Started test.service. machine # [ 63.742371] systemd[1]: test.service: Deactivated successfully. machine # [ 63.771227] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 63.774229] systemd[1]: Finished linger-users.service. machine # [ 64.031026] nixos[2729]: finished switching to system configuration /nix/store/igs01w5cq5hvcy0lx0lxqwfwdcqdirv2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 3.22 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 64.683678] nixos[2874]: switching to system configuration /nix/store/2ndvk2r0k5nlpxgv8j1fgjrr2p6qydxq-nixos-system-machine-test machine # [ 64.687320] systemd[1]: Stopped target Local File Systems. machine # [ 64.687751] systemd[1]: Stopped target Remote File Systems. machine # [ 65.256770] systemd[1]: Reload requested from client PID 2874 ('.switch-to-conf') (unit backdoor.service)... machine # [ 65.258954] systemd[1]: Reloading... machine # [ 65.957742] systemd[1]: Reloading finished in 696 ms. machine # [ 66.103894] systemd[576]: Reexecution requested from client PID 2943 ('switch-to-confi')... machine # [ 66.106186] systemd[576]: Reexecuting. machine # [ 66.173822] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.377029] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.384741] systemd[576]: Reload requested from client PID 2943 ('switch-to-confi')... machine # [ 66.388109] systemd[576]: Reloading... machine # [ 66.590889] systemd[576]: Reloading finished in 203 ms. machine # [ 66.604178] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.615868] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 66.617179] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 66.620337] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 66.667832] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 66.672866] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 66.674273] systemd[1]: Stopping Reactivate sysinit units... machine # [ 66.675129] systemd[1]: Reached target Reactivate sysinit units. machine # [ 66.678037] systemd[1]: Reached target Remote File Systems. machine # [ 66.681682] systemd[1]: Reached target Local File Systems. machine # [ 66.690711] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.694933] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 66.699701] systemd[1]: Starting escaped\x2ddash.service... machine # [ 66.703823] systemd[1]: Starting linger-users.service... machine # [ 66.712350] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 66.715798] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 66.717562] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 66.723649] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 66.726749] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 66.734215] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.735555] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.774310] systemd[1]: Finished escaped\x2ddash.service. machine # [ 66.809000] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 66.812524] systemd[1]: Finished linger-users.service. machine # [ 67.108406] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 67.111642] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 67.370325] nixos[2874]: finished switching to system configuration /nix/store/2ndvk2r0k5nlpxgv8j1fgjrr2p6qydxq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 3.34 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 68.041681] nixos[3016]: switching to system configuration /nix/store/nsgss3kmvl8y9b0z4zwvjvzip9rv1d3i-nixos-system-machine-test machine # [ 68.045585] systemd[1]: Stopped target Local File Systems. machine # [ 68.047384] systemd[1]: Stopped target Remote File Systems. machine # [ 68.048963] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 68.049944] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 68.566071] systemd[1]: Reload requested from client PID 3016 ('.switch-to-conf') (unit backdoor.service)... machine # [ 68.568046] systemd[1]: Reloading... machine # [ 69.229370] systemd[1]: Reloading finished in 659 ms. machine # [ 69.381902] systemd[576]: Reexecution requested from client PID 3085 ('switch-to-confi')... machine # [ 69.383334] systemd[576]: Reexecuting. machine # [ 69.454078] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.650469] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.656971] systemd[576]: Reload requested from client PID 3085 ('switch-to-confi')... machine # [ 69.659285] systemd[576]: Reloading... machine # [ 69.851297] systemd[576]: Reloading finished in 190 ms. machine # [ 69.864183] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.874557] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 69.875617] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 69.878779] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 69.923365] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 69.927772] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 69.930603] systemd[1]: Stopping Reactivate sysinit units... machine # [ 69.931457] systemd[1]: Reached target Reactivate sysinit units. machine # [ 69.936521] systemd[1]: Reached target Local File Systems. machine # [ 69.937402] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 69.942143] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 69.946332] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 69.947624] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 69.957084] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 69.958746] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.960387] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.965044] systemd[1]: Reached target Remote File Systems. machine # [ 69.966993] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.969690] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 70.267906] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 70.270229] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.278696] systemd[1]: Starting escaped\x2ddash.service... machine # [ 70.282482] systemd[1]: Starting linger-users.service... machine # [ 70.332899] systemd[1]: Finished escaped\x2ddash.service. machine # [ 70.366687] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 70.369273] systemd[1]: Finished linger-users.service. machine # [ 70.629184] nixos[3016]: finished switching to system configuration /nix/store/nsgss3kmvl8y9b0z4zwvjvzip9rv1d3i-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 3.26 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 71.308967] nixos[3158]: switching to system configuration /nix/store/jmr1l4mfj2pck63say225q1r6gzywf56-nixos-system-machine-test machine # [ 71.313219] systemd[1]: Stopped target Local File Systems. machine # [ 71.315134] systemd[1]: Stopped target Remote File Systems. machine # [ 71.316756] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 71.317874] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 71.856790] systemd[1]: Reload requested from client PID 3158 ('.switch-to-conf') (unit backdoor.service)... machine # [ 71.858834] systemd[1]: Reloading... machine # [ 72.525892] systemd[1]: Reloading finished in 664 ms. machine # [ 72.671727] systemd[576]: Reexecution requested from client PID 3227 ('switch-to-confi')... machine # [ 72.674351] systemd[576]: Reexecuting. machine # [ 72.742182] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.940807] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.948101] systemd[576]: Reload requested from client PID 3227 ('switch-to-confi')... machine # [ 72.949450] systemd[576]: Reloading... machine # [ 73.142199] systemd[576]: Reloading finished in 191 ms. machine # [ 73.156248] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.168107] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 73.169137] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 73.172697] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 73.219386] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 73.223940] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 73.226537] systemd[1]: Stopping Reactivate sysinit units... machine # [ 73.227423] systemd[1]: Reached target Reactivate sysinit units. machine # [ 73.232773] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.237267] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 73.239340] systemd[1]: Reached target Local File Systems. machine # [ 73.244775] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 73.249297] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 73.256733] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 73.258122] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 73.264173] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 73.265805] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.267136] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.268464] systemd[1]: Reached target Remote File Systems. machine # [ 73.582185] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 73.586471] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 73.590056] systemd[1]: Starting -.service... machine # [ 73.593046] systemd[1]: Starting linger-users.service... machine # [ 73.638205] systemd[1]: Finished -.service. machine # [ 73.662589] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 73.665826] systemd[1]: Finished linger-users.service. machine # [ 73.920843] nixos[3158]: finished switching to system configuration /nix/store/jmr1l4mfj2pck63say225q1r6gzywf56-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 3.28 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 74.581566] nixos[3300]: switching to system configuration /nix/store/j5w2c6jv7s26cmcf2swlpg91j8zpbhhp-nixos-system-machine-test machine # [ 74.585349] systemd[1]: Stopped target Local File Systems. machine # [ 74.586928] systemd[1]: Stopped target Remote File Systems. machine # [ 75.093144] systemd[1]: Reload requested from client PID 3300 ('.switch-to-conf') (unit backdoor.service)... machine # [ 75.095127] systemd[1]: Reloading... machine # [ 75.716919] systemd[1]: Reloading finished in 619 ms. machine # [ 75.857427] systemd[576]: Reexecution requested from client PID 3368 ('switch-to-confi')... machine # [ 75.861437] systemd[576]: Reexecuting. machine # [ 75.917872] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.101192] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.107689] systemd[576]: Reload requested from client PID 3368 ('switch-to-confi')... machine # [ 76.110141] systemd[576]: Reloading... machine # [ 76.294747] systemd[576]: Reloading finished in 183 ms. machine # [ 76.312194] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.322084] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 76.324394] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 76.327142] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 76.373828] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 76.377855] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 76.382030] systemd[1]: Stopping Reactivate sysinit units... machine # [ 76.383245] systemd[1]: Reached target Reactivate sysinit units. machine # [ 76.385782] systemd[1]: Reloading -.service... machine # [ 76.422483] systemd[1]: Reloaded -.service. machine # [ 76.427027] systemd[1]: Reached target Remote File Systems. machine # [ 76.429459] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.435837] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 76.437452] systemd[1]: Reached target Local File Systems. machine # [ 76.439854] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 76.448317] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 76.449256] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 76.450468] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 76.453246] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 76.455192] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.459128] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.759659] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 76.763710] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 76.767406] systemd[1]: Starting linger-users.service... machine # [ 76.827731] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 76.830407] systemd[1]: Finished linger-users.service. machine # [ 77.089289] nixos[3300]: finished switching to system configuration /nix/store/j5w2c6jv7s26cmcf2swlpg91j8zpbhhp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 3.18 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 77.705070] nixos[3442]: switching to system configuration /nix/store/yxz4byyn14f4v3wabm0sn449jl4s1qpv-nixos-system-machine-test machine # [ 77.707708] systemd[1]: Stopped target Remote File Systems. machine # [ 77.710383] systemd[1]: -.service: Deactivated successfully. machine # [ 77.711202] systemd[1]: Stopped -.service. machine # [ 77.712292] systemd[1]: Stopped target Local File Systems. machine # [ 78.211218] systemd[1]: Reload requested from client PID 3442 ('.switch-to-conf') (unit backdoor.service)... machine # [ 78.213339] systemd[1]: Reloading... machine # [ 78.841556] systemd[1]: Reloading finished in 626 ms. machine # [ 78.988523] systemd[576]: Reexecution requested from client PID 3511 ('switch-to-confi')... machine # [ 78.991256] systemd[576]: Reexecuting. machine # [ 79.053940] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.241851] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.248461] systemd[576]: Reload requested from client PID 3511 ('switch-to-confi')... machine # [ 79.250954] systemd[576]: Reloading... machine # [ 79.434385] systemd[576]: Reloading finished in 182 ms. machine # [ 79.448155] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.456920] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 79.459133] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 79.461795] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 79.508552] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 79.512812] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 79.515338] systemd[1]: Stopping Reactivate sysinit units... machine # [ 79.516844] systemd[1]: Reached target Reactivate sysinit units. machine # [ 79.518402] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.519705] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 79.523092] systemd[1]: Reached target Local File Systems. machine # [ 79.526426] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 79.530409] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 79.531285] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 79.534915] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 79.543747] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 79.545728] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.548666] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.551510] systemd[1]: Reached target Remote File Systems. machine # [ 79.854259] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 79.856660] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 79.862804] systemd[1]: Starting linger-users.service... machine # [ 79.866496] systemd[1]: Starting required-service.service... machine # [ 79.869706] systemd[1]: Starting test-service.service... machine # [ 79.919668] systemd[1]: Finished required-service.service. machine # [ 79.923381] systemd[1]: Finished test-service.service. machine # [ 79.947667] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 79.950150] systemd[1]: Finished linger-users.service. machine # [ 80.208300] nixos[3442]: finished switching to system configuration /nix/store/yxz4byyn14f4v3wabm0sn449jl4s1qpv-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 3.12 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 80.822246] nixos[3586]: switching to system configuration /nix/store/0wfw2xbqgxs0vsv2n0nl6k6a4mz78ab3-nixos-system-machine-test machine # [ 80.825001] systemd[1]: Stopped target Local File Systems. machine # [ 80.828885] systemd[1]: required-service.service: Deactivated successfully. machine # [ 80.830111] systemd[1]: Stopped required-service.service. machine # [ 80.831151] systemd[1]: test-service.service: Deactivated successfully. machine # [ 80.832392] systemd[1]: Stopped test-service.service. machine # [ 80.833202] systemd[1]: Stopped target Remote File Systems. machine # [ 81.336609] systemd[1]: Reload requested from client PID 3586 ('.switch-to-conf') (unit backdoor.service)... machine # [ 81.338582] systemd[1]: Reloading... machine # [ 82.011118] systemd[1]: Reloading finished in 670 ms. machine # [ 82.156319] systemd[576]: Reexecution requested from client PID 3655 ('switch-to-confi')... machine # [ 82.160141] systemd[576]: Reexecuting. machine # [ 82.230109] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.420972] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.427813] systemd[576]: Reload requested from client PID 3655 ('switch-to-confi')... machine # [ 82.430623] systemd[576]: Reloading... machine # [ 82.613536] systemd[576]: Reloading finished in 182 ms. machine # [ 82.628169] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.638371] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 82.639440] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 82.642247] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 82.690125] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 82.694259] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 82.696370] systemd[1]: Stopping Reactivate sysinit units... machine # [ 82.697327] systemd[1]: Reached target Reactivate sysinit units. machine # [ 82.703176] systemd[1]: Reached target Local File Systems. machine # [ 82.706665] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 82.711180] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 82.715191] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 82.718736] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 82.722554] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 82.727923] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.735797] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.737594] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.739506] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 82.741071] systemd[1]: Reached target Remote File Systems. machine # [ 83.036877] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 83.040678] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 83.044354] systemd[1]: Starting linger-users.service... machine # [ 83.048531] systemd[1]: Starting required-service.service... machine # [ 83.053832] systemd[1]: Starting test-service.service... machine # [ 83.105783] systemd[1]: Finished test-service.service. machine # [ 83.109707] systemd[1]: Finished required-service.service. machine # [ 83.135639] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 83.138778] systemd[1]: Finished linger-users.service. machine # [ 83.395307] nixos[3586]: finished switching to system configuration /nix/store/0wfw2xbqgxs0vsv2n0nl6k6a4mz78ab3-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 3.19 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 84.023931] nixos[3730]: switching to system configuration /nix/store/jdf8i31imwkdy61hpqrd1m3xj1w7nifj-nixos-system-machine-test machine # [ 84.026723] systemd[1]: required-service.service: Deactivated successfully. machine # [ 84.029933] systemd[1]: Stopped required-service.service. machine # [ 84.030764] systemd[1]: test-service.service: Deactivated successfully. machine # [ 84.031638] systemd[1]: Stopped test-service.service. machine # [ 84.033362] systemd[1]: Stopped target Local File Systems. machine # [ 84.034416] systemd[1]: Stopped target Remote File Systems. machine # [ 84.534576] systemd[1]: Reload requested from client PID 3730 ('.switch-to-conf') (unit backdoor.service)... machine # [ 84.536722] systemd[1]: Reloading... machine # [ 85.188621] systemd[1]: Reloading finished in 649 ms. machine # [ 85.331935] systemd[576]: Reexecution requested from client PID 3799 ('switch-to-confi')... machine # [ 85.335643] systemd[576]: Reexecuting. machine # [ 85.389801] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.578335] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.584899] systemd[576]: Reload requested from client PID 3799 ('switch-to-confi')... machine # [ 85.587438] systemd[576]: Reloading... machine # [ 85.775421] systemd[576]: Reloading finished in 186 ms. machine # [ 85.788155] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.797449] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 85.799773] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 85.802662] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 85.849037] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 85.853423] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 85.856563] systemd[1]: Stopping Reactivate sysinit units... machine # [ 85.857411] systemd[1]: Reached target Reactivate sysinit units. machine # [ 85.858264] systemd[1]: Reached target Local File Systems. machine # [ 85.863746] systemd[1]: Starting required-service.service... machine # [ 85.871909] systemd[1]: Reached target Remote File Systems. machine # [ 85.876704] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.878045] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 85.887210] systemd[1]: Starting linger-users.service... machine # [ 85.890093] systemd[1]: Starting test-service.service... machine # [ 85.897754] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 85.906965] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 85.913119] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 85.914403] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 85.919760] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 85.921942] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.923292] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.951903] systemd[1]: Finished required-service.service. machine # [ 85.970648] systemd[1]: Finished test-service.service. machine # [ 86.003080] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 86.006666] systemd[1]: Finished linger-users.service. machine # [ 86.266085] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 86.269199] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 86.524414] nixos[3730]: finished switching to system configuration /nix/store/jdf8i31imwkdy61hpqrd1m3xj1w7nifj-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 3.12 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 87.124379] nixos[3874]: switching to system configuration /nix/store/zdwik0mgcms0p47r7qxvafg4c8dp96l4-nixos-system-machine-test machine # [ 87.127767] systemd[1]: test-service.service: Deactivated successfully. machine # [ 87.130622] systemd[1]: Stopped test-service.service. machine # [ 87.131397] systemd[1]: required-service.service: Deactivated successfully. machine # [ 87.133895] systemd[1]: Stopped required-service.service. machine # [ 87.134704] systemd[1]: Stopped target Local File Systems. machine # [ 87.135440] systemd[1]: Stopped target Remote File Systems. machine # [ 87.671156] systemd[1]: Reload requested from client PID 3874 ('.switch-to-conf') (unit backdoor.service)... machine # [ 87.673444] systemd[1]: Reloading... machine # [ 88.334822] systemd[1]: Reloading finished in 657 ms. machine # [ 88.471683] systemd[576]: Reexecution requested from client PID 3942 ('switch-to-confi')... machine # [ 88.475337] systemd[576]: Reexecuting. machine # [ 88.537731] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 88.733531] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 88.740247] systemd[576]: Reload requested from client PID 3942 ('switch-to-confi')... machine # [ 88.742590] systemd[576]: Reloading... machine # [ 88.926339] systemd[576]: Reloading finished in 182 ms. machine # [ 88.944184] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 88.953376] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 88.955712] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 88.958570] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 88.998974] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 89.003087] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 89.004811] systemd[1]: Stopping Reactivate sysinit units... machine # [ 89.005640] systemd[1]: Reached target Reactivate sysinit units. machine # [ 89.008244] systemd[1]: Reached target Local File Systems. machine # [ 89.011747] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 89.015248] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 89.018212] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 89.024386] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 89.026593] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 89.034160] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.035441] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.039850] systemd[1]: Created slice Slice /system/instantiated. machine # [ 89.042624] systemd[1]: Reached target Remote File Systems. machine # [ 89.043410] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.045501] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 89.371457] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 89.376631] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 89.380438] systemd[1]: Starting instantiated@one.service... machine # [ 89.384209] systemd[1]: Starting instantiated@two.service... machine # [ 89.389223] systemd[1]: Starting linger-users.service... machine # [ 89.441940] systemd[1]: Finished instantiated@two.service. machine # [ 89.447007] systemd[1]: Finished instantiated@one.service. machine # [ 89.474540] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 89.477494] systemd[1]: Finished linger-users.service. machine # [ 89.736183] nixos[3874]: finished switching to system configuration /nix/store/zdwik0mgcms0p47r7qxvafg4c8dp96l4-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 3.21 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 90.441031] nixos[4018]: switching to system configuration /nix/store/xvxkmjhzpy42dda914zmrqk56ibwjlaz-nixos-system-machine-test machine # [ 90.445593] systemd[1]: Stopped target Remote File Systems. machine # [ 90.449266] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 90.450591] systemd[1]: Stopped instantiated@one.service. machine # [ 90.451583] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 90.453245] systemd[1]: Stopped instantiated@two.service. machine # [ 90.454291] systemd[1]: Stopped target Local File Systems. machine # [ 90.979958] systemd[1]: Reload requested from client PID 4018 ('.switch-to-conf') (unit backdoor.service)... machine # [ 90.982042] systemd[1]: Reloading... machine # [ 91.636534] systemd[1]: Reloading finished in 652 ms. machine # [ 91.784485] systemd[576]: Reexecution requested from client PID 4087 ('switch-to-confi')... machine # [ 91.787824] systemd[576]: Reexecuting. machine # [ 91.841834] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.031720] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.038321] systemd[576]: Reload requested from client PID 4087 ('switch-to-confi')... machine # [ 92.040864] systemd[576]: Reloading... machine # [ 92.225827] systemd[576]: Reloading finished in 183 ms. machine # [ 92.240198] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.250933] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 92.253615] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 92.256931] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 92.308588] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 92.313252] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 92.314632] systemd[1]: Stopping Reactivate sysinit units... machine # [ 92.315480] systemd[1]: Reached target Reactivate sysinit units. machine # [ 92.318924] systemd[1]: Reached target Remote File Systems. machine # [ 92.325651] systemd[1]: Starting instantiated@one.service... machine # [ 92.330028] systemd[1]: Starting instantiated@two.service... machine # [ 92.333580] systemd[1]: Starting linger-users.service... machine # [ 92.354437] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 92.357073] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 92.370007] systemd[1]: Reached target Local File Systems. machine # [ 92.380848] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 92.382357] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 92.383129] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 92.385490] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 92.395409] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 92.398991] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 92.405307] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 92.421669] systemd[1]: Finished instantiated@two.service. machine # [ 92.428168] systemd[1]: Finished instantiated@one.service. machine # [ 92.469352] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 92.473083] systemd[1]: Finished linger-users.service. machine # [ 92.730580] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 92.733759] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 92.990398] nixos[4018]: finished switching to system configuration /nix/store/xvxkmjhzpy42dda914zmrqk56ibwjlaz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 3.26 seconds) (finished: subtest: services, in 67.69 seconds) subtest: failing units machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 93.600943] nixos[4162]: switching to system configuration /nix/store/nddm39yhin93faxx4z4z7r6yf2sbc2iz-nixos-system-machine-test machine # [ 93.603601] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 93.607429] systemd[1]: Stopped instantiated@one.service. machine # [ 93.609458] systemd[1]: Stopped target Remote File Systems. machine # [ 93.610568] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 93.611547] systemd[1]: Stopped instantiated@two.service. machine # [ 93.612763] systemd[1]: Stopped target Local File Systems. machine # [ 94.068962] systemd[1]: Reload requested from client PID 4162 ('.switch-to-conf') (unit backdoor.service)... machine # [ 94.070897] systemd[1]: Reloading... machine # [ 94.667549] systemd[1]: Reloading finished in 594 ms. machine # [ 94.812338] systemd[576]: Reexecution requested from client PID 4231 ('switch-to-confi')... machine # [ 94.813826] systemd[576]: Reexecuting. machine # [ 94.882632] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.085292] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.092692] systemd[576]: Reload requested from client PID 4231 ('switch-to-confi')... machine # [ 95.096064] systemd[576]: Reloading... machine # [ 95.299797] systemd[576]: Reloading finished in 204 ms. machine # [ 95.312197] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.321598] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 95.324271] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 95.327271] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 95.379505] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 95.384814] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 95.385788] systemd[1]: Stopping Reactivate sysinit units... machine # [ 95.386582] systemd[1]: Reached target Reactivate sysinit units. machine # [ 95.390042] systemd[1]: Reached target Local File Systems. machine # [ 95.392852] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 95.399335] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 95.403631] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 95.406268] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 95.413338] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 95.414925] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.422722] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.423989] systemd[1]: Reached target Remote File Systems. machine # [ 95.426700] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.427961] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 95.759054] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 95.763910] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 95.768350] systemd[1]: Starting linger-users.service... machine # [ 95.770999] systemd[1]: Starting test.service... machine # [ 95.819599] systemd[1]: Finished test.service. machine # [ 95.845550] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 95.848656] systemd[1]: Finished linger-users.service. machine # [ 96.104084] nixos[4162]: finished switching to system configuration /nix/store/nddm39yhin93faxx4z4z7r6yf2sbc2iz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 3.11 seconds) machine: must fail: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 96.723441] nixos[4304]: switching to system configuration /nix/store/iz8bl4p3m71g63vnvl6zqy1084fhna3y-nixos-system-machine-test machine # [ 96.726403] systemd[1]: Stopped target Local File Systems. machine # [ 96.728983] systemd[1]: test.service: Deactivated successfully. machine # [ 96.729924] systemd[1]: Stopped test.service. machine # [ 96.731195] systemd[1]: Stopped target Remote File Systems. machine # [ 97.253272] systemd[1]: Reload requested from client PID 4304 ('.switch-to-conf') (unit backdoor.service)... machine # [ 97.255246] systemd[1]: Reloading... machine # [ 97.922773] systemd[1]: Reloading finished in 664 ms. machine # [ 98.067876] systemd[576]: Reexecution requested from client PID 4373 ('switch-to-confi')... machine # [ 98.071915] systemd[576]: Reexecuting. machine # [ 98.134588] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.330275] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.336926] systemd[576]: Reload requested from client PID 4373 ('switch-to-confi')... machine # [ 98.339467] systemd[576]: Reloading... machine # [ 98.524643] systemd[576]: Reloading finished in 184 ms. machine # [ 98.540170] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.550185] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 98.552645] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 98.555862] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 98.596883] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 98.600879] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 98.603900] systemd[1]: Stopping Reactivate sysinit units... machine # [ 98.605580] systemd[1]: Reached target Reactivate sysinit units. machine # [ 98.610433] systemd[1]: Starting test.service... machine # [ 98.618093] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.619447] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 98.626338] systemd[1]: Reached target Remote File Systems. machine # [ 98.627184] systemd[1]: Reached target Local File Systems. machine # [ 98.630639] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 98.638176] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 98.639068] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 98.642456] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 98.645288] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 98.647327] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.649230] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.679483] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 98.681090] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 98.682970] systemd[1]: Failed to start test.service. machine # [ 98.987764] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 98.990272] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 98.995202] systemd[1]: Starting linger-users.service... machine # [ 99.061546] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 99.064553] systemd[1]: Finished linger-users.service. machine # [ 99.365670] nixos[4304]: switching to system configuration /nix/store/iz8bl4p3m71g63vnvl6zqy1084fhna3y-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 3.26 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 99.990535] nixos[4447]: switching to system configuration /nix/store/0asv451czl87jqz932gryjjxsqadvhk9-nixos-system-machine-test machine # [ 99.993619] systemd[1]: Stopped target Remote File Systems. machine # [ 99.995237] systemd[1]: Stopped target Local File Systems. machine # [ 100.511358] systemd[1]: Reload requested from client PID 4447 ('.switch-to-conf') (unit backdoor.service)... machine # [ 100.513592] systemd[1]: Reloading... machine # [ 101.184834] systemd[1]: Reloading finished in 668 ms. machine # [ 101.333489] systemd[576]: Reexecution requested from client PID 4516 ('switch-to-confi')... machine # [ 101.337520] systemd[576]: Reexecuting. machine # [ 101.390632] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.592319] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.600402] systemd[576]: Reload requested from client PID 4516 ('switch-to-confi')... machine # [ 101.602696] systemd[576]: Reloading... machine # [ 101.797781] systemd[576]: Reloading finished in 193 ms. machine # [ 101.812161] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.821338] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 101.823642] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 101.826765] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 101.874352] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 101.878416] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 101.881102] systemd[1]: Stopping Reactivate sysinit units... machine # [ 101.882348] systemd[1]: Reached target Reactivate sysinit units. machine # [ 101.886482] systemd[1]: Reached target Remote File Systems. machine # [ 101.892439] systemd[1]: Started autorestart.service. machine # [ 101.895111] systemd[1]: Starting linger-users.service... machine # [ 101.900623] systemd[1]: Reached target Local File Systems. machine # [ 101.901450] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 101.914693] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 101.915607] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 101.925821] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 101.930166] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 101.932738] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.935266] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.938294] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.940347] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 101.973388] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 102.007189] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 102.010418] systemd[1]: Finished linger-users.service. machine # [ 102.273325] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 102.276476] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 102.535878] nixos[4447]: finished switching to system configuration /nix/store/0asv451czl87jqz932gryjjxsqadvhk9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 3.17 seconds) machine # [ 102.611092] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 103.171495] nixos[4594]: switching to system configuration /nix/store/0asv451czl87jqz932gryjjxsqadvhk9-nixos-system-machine-test machine # [ 103.174452] systemd[1]: Stopped target Local File Systems. machine # [ 103.177128] systemd[1]: Stopped target Remote File Systems. machine # [ 103.622333] systemd[1]: Reload requested from client PID 4594 ('.switch-to-conf') (unit backdoor.service)... machine # [ 103.624303] systemd[1]: Reloading... machine # [ 104.213005] systemd[1]: Reloading finished in 586 ms. machine # [ 104.353973] systemd[576]: Reexecution requested from client PID 4662 ('switch-to-confi')... machine # [ 104.357514] systemd[576]: Reexecuting. machine # [ 104.409451] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 104.594381] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 104.601003] systemd[576]: Reload requested from client PID 4662 ('switch-to-confi')... machine # [ 104.603265] systemd[576]: Reloading... machine # [ 104.788715] systemd[576]: Reloading finished in 184 ms. machine # [ 104.800193] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 104.809006] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 104.811296] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 104.814026] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 104.859346] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 104.863701] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 104.865980] systemd[1]: Stopping Reactivate sysinit units... machine # [ 104.867826] systemd[1]: Reached target Reactivate sysinit units. machine # [ 104.872735] systemd[1]: Reached target Local File Systems. machine # [ 104.876316] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 104.880259] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 104.881122] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 104.882340] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 104.895161] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 104.898649] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 104.899947] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 104.901341] systemd[1]: Reached target Remote File Systems. machine # [ 104.902131] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 104.903362] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 105.225274] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 105.227457] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 105.232483] systemd[1]: Started autorestart.service. machine # [ 105.236662] systemd[1]: Starting linger-users.service... machine # [ 105.282500] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 105.310778] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 105.313788] systemd[1]: Finished linger-users.service. machine # [ 105.573517] nixos[4594]: finished switching to system configuration /nix/store/0asv451czl87jqz932gryjjxsqadvhk9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 2.97 seconds) machine # [ 105.662056] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 106.299635] nixos[4741]: switching to system configuration /nix/store/qiwr0cv2qj9pjmxlfnd38rp609kq9h8i-nixos-system-machine-test machine # [ 106.303243] systemd[1]: Stopped target Local File Systems. machine # [ 106.304526] systemd[1]: Stopped target Remote File Systems. machine # [ 106.814896] systemd[1]: Reload requested from client PID 4741 ('.switch-to-conf') (unit backdoor.service)... machine # [ 106.817060] systemd[1]: Reloading... machine # [ 107.495298] systemd[1]: Reloading finished in 675 ms. machine # [ 107.643016] systemd[576]: Reexecution requested from client PID 4810 ('switch-to-confi')... machine # [ 107.645262] systemd[576]: Reexecuting. machine # [ 107.701633] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.885986] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.892429] systemd[576]: Reload requested from client PID 4810 ('switch-to-confi')... machine # [ 107.895082] systemd[576]: Reloading... machine # [ 108.098816] systemd[576]: Reloading finished in 202 ms. machine # [ 108.113702] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 108.122072] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 108.124556] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 108.127588] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 108.175453] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 108.179814] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 108.183489] systemd[1]: Stopping Reactivate sysinit units... machine # [ 108.188168] systemd[1]: Reached target Reactivate sysinit units. machine # [ 108.189162] systemd[1]: Reached target Remote File Systems. machine # [ 108.192205] systemd[1]: Started autorestart.service. machine # [ 108.195966] systemd[1]: Starting linger-users.service... machine # [ 108.204639] systemd[1]: Reached target Local File Systems. machine # [ 108.214675] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 108.225860] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 108.226756] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 108.227960] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 108.232633] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 108.243478] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.245857] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.247607] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.250340] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 108.279664] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 108.282228] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 108.314835] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 108.317744] systemd[1]: Finished linger-users.service. machine # [ 108.603274] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 108.606511] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 108.921352] nixos[4741]: switching to system configuration /nix/store/qiwr0cv2qj9pjmxlfnd38rp609kq9h8i-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 3.26 seconds) (finished: subtest: failing units, in 15.93 seconds) subtest: unit file parser machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 109.525331] nixos[4884]: switching to system configuration /nix/store/9gkxac46y07mli01920h4isghs5ifx4y-nixos-system-machine-test machine # [ 109.527970] systemd[1]: Stopped autorestart.service. machine # [ 109.531072] systemd[1]: Stopped target Local File Systems. machine # [ 109.532246] systemd[1]: Stopped target Remote File Systems. machine # [ 109.980506] systemd[1]: Reload requested from client PID 4884 ('.switch-to-conf') (unit backdoor.service)... machine # [ 109.982453] systemd[1]: Reloading... machine # [ 110.581896] systemd[1]: Reloading finished in 597 ms. machine # [ 110.730486] systemd[576]: Reexecution requested from client PID 4953 ('switch-to-confi')... machine # [ 110.731920] systemd[576]: Reexecuting. machine # [ 110.794384] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 110.991502] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 110.998546] systemd[576]: Reload requested from client PID 4953 ('switch-to-confi')... machine # [ 111.001311] systemd[576]: Reloading... machine # [ 111.193072] systemd[576]: Reloading finished in 190 ms. machine # [ 111.208186] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 111.218632] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 111.221315] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 111.224583] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 111.274319] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 111.279157] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 111.281297] systemd[1]: Stopping Reactivate sysinit units... machine # [ 111.282731] systemd[1]: Reached target Reactivate sysinit units. machine # [ 111.286932] systemd[1]: Reached target Local File Systems. machine # [ 111.287860] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 111.293940] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 111.298044] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 111.304465] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 111.306776] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 111.313521] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 111.318330] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 111.319568] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 111.322126] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 111.323456] systemd[1]: Reached target Remote File Systems. machine # [ 111.640980] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 111.644437] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 111.649771] systemd[1]: Starting linger-users.service... machine # [ 111.653964] systemd[1]: Starting test.service... machine # [ 111.697497] systemd[1]: Finished test.service. machine # [ 111.726481] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 111.729405] systemd[1]: Finished linger-users.service. machine # [ 111.991249] nixos[4884]: finished switching to system configuration /nix/store/9gkxac46y07mli01920h4isghs5ifx4y-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.07 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 112.656485] nixos[5026]: switching to system configuration /nix/store/fyvfy5c4mahcndpr2vvzm500phhp2mmz-nixos-system-machine-test machine # [ 112.659986] systemd[1]: Stopped target Local File Systems. machine # [ 112.661445] systemd[1]: Stopped target Remote File Systems. machine # [ 113.178994] systemd[1]: Reload requested from client PID 5026 ('.switch-to-conf') (unit backdoor.service)... machine # [ 113.181353] systemd[1]: Reloading... machine # [ 113.866327] systemd[1]: Reloading finished in 682 ms. machine # [ 114.032101] systemd[576]: Reexecution requested from client PID 5095 ('switch-to-confi')... machine # [ 114.033520] systemd[576]: Reexecuting. machine # [ 114.094331] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 114.300464] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 114.308114] systemd[576]: Reload requested from client PID 5095 ('switch-to-confi')... machine # [ 114.310501] systemd[576]: Reloading... machine # [ 114.507015] systemd[576]: Reloading finished in 195 ms. machine # [ 114.524207] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 114.534869] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 114.537666] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 114.540872] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 114.590721] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 114.595041] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 114.596406] systemd[1]: Stopping Reactivate sysinit units... machine # [ 114.597216] systemd[1]: Reached target Reactivate sysinit units. machine # [ 114.599506] systemd[1]: test.service: Deactivated successfully. machine # [ 114.602807] systemd[1]: Stopped test.service. machine # [ 114.603553] systemd[1]: Stopping test.service... machine # [ 114.605998] systemd[1]: Starting test.service... machine # [ 114.644601] systemd[1]: Finished test.service. machine # [ 114.647519] systemd[1]: Reached target Local File Systems. machine # [ 114.650787] systemd[1]: Reached target Remote File Systems. machine # [ 114.653338] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 114.655727] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 114.661094] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 114.668215] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 114.669127] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 114.670396] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 114.675773] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 114.681783] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 114.683066] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 115.006449] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 115.010871] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 115.013359] systemd[1]: Starting linger-users.service... machine # [ 115.075804] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 115.078647] systemd[1]: Finished linger-users.service. machine # [ 115.337148] nixos[5026]: finished switching to system configuration /nix/store/fyvfy5c4mahcndpr2vvzm500phhp2mmz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 3.35 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 115.999875] nixos[5168]: switching to system configuration /nix/store/v82swqfawf9fakcy2wmx6pqncjynw5xi-nixos-system-machine-test machine # [ 116.003148] systemd[1]: Stopped target Local File Systems. machine # [ 116.004504] systemd[1]: Stopped target Remote File Systems. machine # [ 116.525708] systemd[1]: Reload requested from client PID 5168 ('.switch-to-conf') (unit backdoor.service)... machine # [ 116.527658] systemd[1]: Reloading... machine # [ 117.168520] systemd[1]: Reloading finished in 638 ms. machine # [ 117.329707] systemd[576]: Reexecution requested from client PID 5237 ('switch-to-confi')... machine # [ 117.333789] systemd[576]: Reexecuting. machine # [ 117.398356] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 117.599462] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 117.607210] systemd[576]: Reload requested from client PID 5237 ('switch-to-confi')... machine # [ 117.609872] systemd[576]: Reloading... machine # [ 117.798192] systemd[576]: Reloading finished in 187 ms. machine # [ 117.812145] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 117.822005] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 117.824359] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 117.827227] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 117.873176] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 117.877614] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 117.879547] systemd[1]: Stopping Reactivate sysinit units... machine # [ 117.881076] systemd[1]: Reached target Reactivate sysinit units. machine # [ 117.884388] systemd[1]: test.service: Deactivated successfully. machine # [ 117.885299] systemd[1]: Stopped test.service. machine # [ 117.885993] systemd[1]: Stopping test.service... machine # [ 117.888598] systemd[1]: Starting test.service... machine # [ 117.923573] systemd[1]: Finished test.service. machine # [ 117.927583] systemd[1]: Reached target Remote File Systems. machine # [ 117.932803] systemd[1]: Starting linger-users.service... machine # [ 117.936645] systemd[1]: Reached target Local File Systems. machine # [ 117.943311] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 117.950723] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 117.951637] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 117.957084] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 117.964450] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 117.966113] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 117.971400] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 117.974236] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 117.975831] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 118.037864] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 118.040969] systemd[1]: Finished linger-users.service. machine # [ 118.295095] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 118.298280] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 118.554880] nixos[5168]: finished switching to system configuration /nix/store/v82swqfawf9fakcy2wmx6pqncjynw5xi-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 3.22 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 119.130030] nixos[5310]: switching to system configuration /nix/store/9gkxac46y07mli01920h4isghs5ifx4y-nixos-system-machine-test machine # [ 119.133084] systemd[1]: Stopped target Local File Systems. machine # [ 119.135637] systemd[1]: Stopped target Remote File Systems. machine # [ 119.598502] systemd[1]: Reload requested from client PID 5310 ('.switch-to-conf') (unit backdoor.service)... machine # [ 119.600800] systemd[1]: Reloading... machine # [ 120.203978] systemd[1]: Reloading finished in 600 ms. machine # [ 120.356296] systemd[576]: Reexecution requested from client PID 5379 ('switch-to-confi')... machine # [ 120.357788] systemd[576]: Reexecuting. machine # [ 120.405902] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 120.598143] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 120.605331] systemd[576]: Reload requested from client PID 5379 ('switch-to-confi')... machine # [ 120.607972] systemd[576]: Reloading... machine # [ 120.800537] systemd[576]: Reloading finished in 191 ms. machine # [ 120.816167] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 120.825727] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 120.828076] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 120.832074] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 120.877448] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 120.881867] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 120.882846] systemd[1]: Stopping Reactivate sysinit units... machine # [ 120.883687] systemd[1]: Reached target Reactivate sysinit units. machine # [ 120.886387] systemd[1]: test.service: Deactivated successfully. machine # [ 120.889574] systemd[1]: Stopped test.service. machine # [ 120.890307] systemd[1]: Stopping test.service... machine # [ 120.892648] systemd[1]: Starting test.service... machine # [ 120.928005] systemd[1]: Finished test.service. machine # [ 120.932799] systemd[1]: Reached target Local File Systems. machine # [ 120.935846] systemd[1]: Reached target Remote File Systems. machine # [ 120.939176] systemd[1]: Starting linger-users.service... machine # [ 120.948710] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 120.954791] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 120.960957] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 120.963713] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 120.973102] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 120.975595] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 120.977803] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 120.979900] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 120.981884] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 121.044855] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 121.047949] systemd[1]: Finished linger-users.service. machine # [ 121.351078] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 121.354850] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 121.611900] nixos[5310]: finished switching to system configuration /nix/store/9gkxac46y07mli01920h4isghs5ifx4y-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.06 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 122.302757] nixos[5452]: switching to system configuration /nix/store/xiis9fgyhz467c40fwx73gjyv8qlp645-nixos-system-machine-test machine # [ 122.306225] systemd[1]: Stopped target Local File Systems. machine # [ 122.307678] systemd[1]: Stopped target Remote File Systems. machine # [ 122.832394] systemd[1]: Reload requested from client PID 5452 ('.switch-to-conf') (unit backdoor.service)... machine # [ 122.834396] systemd[1]: Reloading... machine # [ 123.498581] systemd[1]: Reloading finished in 662 ms. machine # [ 123.658606] systemd[576]: Reexecution requested from client PID 5521 ('switch-to-confi')... machine # [ 123.662356] systemd[576]: Reexecuting. machine # [ 123.718024] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 123.925701] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 123.931979] systemd[576]: Reload requested from client PID 5521 ('switch-to-confi')... machine # [ 123.934436] systemd[576]: Reloading... machine # [ 124.132098] systemd[576]: Reloading finished in 196 ms. machine # [ 124.148162] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 124.158264] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 124.159309] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 124.162271] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 124.209661] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 124.214105] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 124.217006] systemd[1]: Stopping Reactivate sysinit units... machine # [ 124.217919] systemd[1]: Reached target Reactivate sysinit units. machine # [ 124.222876] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 124.225708] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 124.229900] systemd[1]: Reached target Local File Systems. machine # [ 124.232865] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 124.238373] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 124.239261] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 124.242050] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 124.247743] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 124.249725] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 124.253446] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 124.254703] systemd[1]: Reached target Remote File Systems. machine # [ 124.569561] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 124.571733] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 124.576677] systemd[1]: Starting linger-users.service... machine # [ 124.633415] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 124.636349] systemd[1]: Finished linger-users.service. machine # [ 124.894694] nixos[5452]: finished switching to system configuration /nix/store/xiis9fgyhz467c40fwx73gjyv8qlp645-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 3.28 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 125.525139] nixos[5592]: switching to system configuration /nix/store/9k2qjvnf60d4dp1y4k9ymcb4y42j274h-nixos-system-machine-test machine # [ 125.528562] systemd[1]: Stopped target Local File Systems. machine # [ 125.530025] systemd[1]: Stopped target Remote File Systems. machine # [ 126.045851] systemd[1]: Reload requested from client PID 5592 ('.switch-to-conf') (unit backdoor.service)... machine # [ 126.047723] systemd[1]: Reloading... machine # [ 126.705602] systemd[1]: Reloading finished in 655 ms. machine # [ 126.848782] systemd[576]: Reexecution requested from client PID 5661 ('switch-to-confi')... machine # [ 126.852133] systemd[576]: Reexecuting. machine # [ 126.905468] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 127.092688] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 127.099835] systemd[576]: Reload requested from client PID 5661 ('switch-to-confi')... machine # [ 127.102584] systemd[576]: Reloading... machine # [ 127.292765] systemd[576]: Reloading finished in 189 ms. machine # [ 127.308184] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 127.317385] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 127.319798] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 127.322799] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 127.371801] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 127.376344] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 127.378376] systemd[1]: Stopping Reactivate sysinit units... machine # [ 127.379754] systemd[1]: Reached target Reactivate sysinit units. machine # [ 127.383570] systemd[1]: test.service: Deactivated successfully. machine # [ 127.384633] systemd[1]: Stopped test.service. machine # [ 127.385634] systemd[1]: Stopping test.service... machine # [ 127.387647] systemd[1]: Starting test.service... machine # [ 127.424122] systemd[1]: Finished test.service. machine # [ 127.428857] systemd[1]: Reached target Local File Systems. machine # [ 127.432615] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 127.436435] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 127.437337] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 127.438561] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 127.449107] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 127.450773] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 127.456251] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 127.457528] systemd[1]: Reached target Remote File Systems. machine # [ 127.458305] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 127.459562] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 127.796469] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 127.800209] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 127.805068] systemd[1]: Starting linger-users.service... machine # [ 127.869360] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 127.872592] systemd[1]: Finished linger-users.service. machine # [ 128.130921] nixos[5592]: finished switching to system configuration /nix/store/9k2qjvnf60d4dp1y4k9ymcb4y42j274h-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 3.24 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 128.782256] nixos[5734]: switching to system configuration /nix/store/zc8pmq6bxsaxq82zi3n17p8lbnai1kfy-nixos-system-machine-test machine # [ 128.784692] systemd[1]: Stopped target Remote File Systems. machine # [ 128.786748] systemd[1]: Stopped target Local File Systems. machine # [ 129.310568] systemd[1]: Reload requested from client PID 5734 ('.switch-to-conf') (unit backdoor.service)... machine # [ 129.312684] systemd[1]: Reloading... machine # [ 129.976592] systemd[1]: Reloading finished in 661 ms. machine # [ 130.117900] systemd[576]: Reexecution requested from client PID 5803 ('switch-to-confi')... machine # [ 130.121664] systemd[576]: Reexecuting. machine # [ 130.186016] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 130.379767] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 130.387387] systemd[576]: Reload requested from client PID 5803 ('switch-to-confi')... machine # [ 130.390594] systemd[576]: Reloading... machine # [ 130.578272] systemd[576]: Reloading finished in 188 ms. machine # [ 130.592212] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 130.603738] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 130.604893] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 130.608076] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 130.655096] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 130.659681] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 130.662171] systemd[1]: Stopping Reactivate sysinit units... machine # [ 130.663041] systemd[1]: Reached target Reactivate sysinit units. machine # [ 130.666541] systemd[1]: test.service: Deactivated successfully. machine # [ 130.667464] systemd[1]: Stopped test.service. machine # [ 130.668463] systemd[1]: Stopping test.service... machine # [ 130.670708] systemd[1]: Starting test.service... machine # [ 130.707131] systemd[1]: Finished test.service. machine # [ 130.712398] systemd[1]: Reached target Remote File Systems. machine # [ 130.716946] systemd[1]: Starting linger-users.service... machine # [ 130.727967] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 130.731970] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 130.733885] systemd[1]: Reached target Local File Systems. machine # [ 130.735800] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 130.744389] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 130.745304] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 130.746559] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 130.749156] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 130.751272] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 130.753399] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 130.814312] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 130.816079] systemd[1]: Finished linger-users.service. machine # [ 131.086091] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 131.089598] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 131.346676] nixos[5734]: finished switching to system configuration /nix/store/zc8pmq6bxsaxq82zi3n17p8lbnai1kfy-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 3.22 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 131.994679] nixos[5876]: switching to system configuration /nix/store/05db6mfpf162d1z392dxdf2nl0llgvnp-nixos-system-machine-test machine # [ 131.998228] systemd[1]: Stopped target Local File Systems. machine # [ 131.999684] systemd[1]: Stopped target Remote File Systems. machine # [ 132.530952] systemd[1]: Reload requested from client PID 5876 ('.switch-to-conf') (unit backdoor.service)... machine # [ 132.533203] systemd[1]: Reloading... machine # [ 133.214875] systemd[1]: Reloading finished in 679 ms. machine # [ 133.367880] systemd[576]: Reexecution requested from client PID 5945 ('switch-to-confi')... machine # [ 133.371832] systemd[576]: Reexecuting. machine # [ 133.425694] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 133.615921] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 133.622535] systemd[576]: Reload requested from client PID 5945 ('switch-to-confi')... machine # [ 133.624969] systemd[576]: Reloading... machine # [ 133.816519] systemd[576]: Reloading finished in 190 ms. machine # [ 133.832160] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 133.841353] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 133.843830] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 133.846787] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 133.898031] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 133.903119] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 133.905242] systemd[1]: Stopping Reactivate sysinit units... machine # [ 133.906142] systemd[1]: Reached target Reactivate sysinit units. machine # [ 133.908809] systemd[1]: test.service: Deactivated successfully. machine # [ 133.912347] systemd[1]: Stopped test.service. machine # [ 133.913563] systemd[1]: Stopping test.service... machine # [ 133.915703] systemd[1]: Starting test.service... machine # [ 133.952657] systemd[1]: Finished test.service. machine # [ 133.958235] systemd[1]: Reached target Remote File Systems. machine # [ 133.965484] systemd[1]: Starting linger-users.service... machine # [ 133.969398] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 133.980561] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 133.981978] systemd[1]: Reached target Local File Systems. machine # [ 133.982768] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 133.989167] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 133.998932] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 134.003232] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 134.007597] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 134.010476] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 134.012642] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 134.064099] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 134.066865] systemd[1]: Finished linger-users.service. machine # [ 134.324566] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 134.328005] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 134.582394] nixos[5876]: finished switching to system configuration /nix/store/05db6mfpf162d1z392dxdf2nl0llgvnp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 3.23 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 135.179640] nixos[6018]: switching to system configuration /nix/store/9gkxac46y07mli01920h4isghs5ifx4y-nixos-system-machine-test machine # [ 135.182194] systemd[1]: Stopped target Local File Systems. machine # [ 135.184572] systemd[1]: Stopped target Remote File Systems. machine # [ 135.642482] systemd[1]: Reload requested from client PID 6018 ('.switch-to-conf') (unit backdoor.service)... machine # [ 135.644530] systemd[1]: Reloading... machine # [ 136.248919] systemd[1]: Reloading finished in 602 ms. machine # [ 136.394824] systemd[576]: Reexecution requested from client PID 6087 ('switch-to-confi')... machine # [ 136.398569] systemd[576]: Reexecuting. machine # [ 136.453857] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 136.646733] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 136.653413] systemd[576]: Reload requested from client PID 6087 ('switch-to-confi')... machine # [ 136.655939] systemd[576]: Reloading... machine # [ 136.845960] systemd[576]: Reloading finished in 188 ms. machine # [ 136.860173] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 136.870705] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 136.871791] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 136.875517] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 136.922172] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 136.926589] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 136.928512] systemd[1]: Stopping Reactivate sysinit units... machine # [ 136.932820] systemd[1]: Reached target Reactivate sysinit units. machine # [ 136.934887] systemd[1]: test.service: Deactivated successfully. machine # [ 136.935763] systemd[1]: Stopped test.service. machine # [ 136.936696] systemd[1]: Stopping test.service... machine # [ 136.937700] systemd[1]: Starting test.service... machine # [ 136.972002] systemd[1]: Finished test.service. machine # [ 136.975658] systemd[1]: Reached target Remote File Systems. machine # [ 136.980753] systemd[1]: Starting linger-users.service... machine # [ 136.988720] systemd[1]: Reached target Local File Systems. machine # [ 136.991357] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 137.002035] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 137.002942] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 137.008812] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 137.016496] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 137.018112] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 137.019333] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 137.023633] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 137.025897] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 137.076751] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 137.079341] systemd[1]: Finished linger-users.service. machine # [ 137.355885] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 137.359474] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 137.618010] nixos[6018]: finished switching to system configuration /nix/store/9gkxac46y07mli01920h4isghs5ifx4y-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.04 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 138.287792] nixos[6160]: switching to system configuration /nix/store/caw4xcr60iavi3w6j9gc9k5hfkhx3ncv-nixos-system-machine-test machine # [ 138.291314] systemd[1]: Stopped target Local File Systems. machine # [ 138.292616] systemd[1]: Stopped target Remote File Systems. machine # [ 138.807342] systemd[1]: Reload requested from client PID 6160 ('.switch-to-conf') (unit backdoor.service)... machine # [ 138.809560] systemd[1]: Reloading... machine # [ 139.459144] systemd[1]: Reloading finished in 647 ms. machine # [ 139.606248] systemd[576]: Reexecution requested from client PID 6229 ('switch-to-confi')... machine # [ 139.610013] systemd[576]: Reexecuting. machine # [ 139.665476] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 139.854078] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 139.861275] systemd[576]: Reload requested from client PID 6229 ('switch-to-confi')... machine # [ 139.863795] systemd[576]: Reloading... machine # [ 140.053203] systemd[576]: Reloading finished in 188 ms. machine # [ 140.068159] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 140.078182] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 140.080569] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 140.083456] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 140.128894] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 140.133187] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 140.136261] systemd[1]: Stopping Reactivate sysinit units... machine # [ 140.137105] systemd[1]: Reached target Reactivate sysinit units. machine # [ 140.140877] systemd[1]: Reloading test.service... machine # [ 140.174492] systemd[1]: Reloaded test.service. machine # [ 140.178169] systemd[1]: Reached target Remote File Systems. machine # [ 140.180663] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 140.184868] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 140.186520] systemd[1]: Reached target Local File Systems. machine # [ 140.191907] systemd[1]: Starting linger-users.service... machine # [ 140.202202] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 140.215141] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 140.217522] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 140.219370] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 140.222484] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 140.224736] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 140.225976] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 140.285476] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 140.287064] systemd[1]: Finished linger-users.service. machine # [ 140.560133] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 140.563298] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 140.820293] nixos[6160]: finished switching to system configuration /nix/store/caw4xcr60iavi3w6j9gc9k5hfkhx3ncv-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 3.20 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 141.457564] nixos[6302]: switching to system configuration /nix/store/y3sclajmdwbgnp2di31z4aapphvzvcgk-nixos-system-machine-test machine # [ 141.460578] systemd[1]: Stopped target Local File Systems. machine # [ 141.463227] systemd[1]: Stopped target Remote File Systems. machine # [ 142.013195] systemd[1]: Reload requested from client PID 6302 ('.switch-to-conf') (unit backdoor.service)... machine # [ 142.015266] systemd[1]: Reloading... machine # [ 142.774223] systemd[1]: Reloading finished in 756 ms. machine # [ 142.944558] systemd[576]: Reexecution requested from client PID 6371 ('switch-to-confi')... machine # [ 142.946136] systemd[576]: Reexecuting. machine # [ 143.003667] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 143.227312] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 143.234525] systemd[576]: Reload requested from client PID 6371 ('switch-to-confi')... machine # [ 143.237514] systemd[576]: Reloading... machine # [ 143.451922] systemd[576]: Reloading finished in 213 ms. machine # [ 143.464194] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 143.475299] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 143.478387] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 143.482629] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 143.534592] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 143.539999] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 143.542074] systemd[1]: Stopping Reactivate sysinit units... machine # [ 143.542914] systemd[1]: Reached target Reactivate sysinit units. machine # [ 143.549168] systemd[1]: Reloading test.service... machine # [ 143.589530] systemd[1]: Reloaded test.service. machine # [ 143.593470] systemd[1]: Reached target Local File Systems. machine # [ 143.595678] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 143.598876] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 143.601785] systemd[1]: Reached target Remote File Systems. machine # [ 143.610366] systemd[1]: Starting linger-users.service... machine # [ 143.622264] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 143.627005] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 143.627938] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 143.629348] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 143.631907] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 143.639797] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 143.641567] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 143.705260] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 143.709398] systemd[1]: Finished linger-users.service. machine # [ 144.000087] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 144.002872] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 144.262374] nixos[6302]: finished switching to system configuration /nix/store/y3sclajmdwbgnp2di31z4aapphvzvcgk-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 3.44 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 144.906260] nixos[6444]: switching to system configuration /nix/store/564sp6k0d6y9csq3wm5wximvzn6rjffk-nixos-system-machine-test machine # [ 144.910283] systemd[1]: Stopped target Local File Systems. machine # [ 144.911866] systemd[1]: Stopped target Remote File Systems. machine # [ 145.453832] systemd[1]: Reload requested from client PID 6444 ('.switch-to-conf') (unit backdoor.service)... machine # [ 145.456304] systemd[1]: Reloading... machine # [ 146.166107] systemd[1]: Reloading finished in 707 ms. machine # [ 146.321378] systemd[576]: Reexecution requested from client PID 6513 ('switch-to-confi')... machine # [ 146.325587] systemd[576]: Reexecuting. machine # [ 146.374130] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 146.577587] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 146.586840] systemd[576]: Reload requested from client PID 6513 ('switch-to-confi')... machine # [ 146.589344] systemd[576]: Reloading... machine # [ 146.786156] systemd[576]: Reloading finished in 193 ms. machine # [ 146.801695] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 146.810616] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 146.813259] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 146.816392] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 146.865694] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 146.869919] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 146.871891] systemd[1]: Stopping Reactivate sysinit units... machine # [ 146.873406] systemd[1]: Reached target Reactivate sysinit units. machine # [ 146.876556] systemd[1]: test.service: Deactivated successfully. machine # [ 146.877513] systemd[1]: Stopped test.service. machine # [ 146.878143] systemd[1]: Stopping test.service... machine # [ 146.881401] systemd[1]: Starting test.service... machine # [ 146.915698] systemd[1]: Finished test.service. machine # [ 146.920997] systemd[1]: Reached target Local File Systems. machine # [ 146.924499] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 146.929131] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 146.930043] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 146.931261] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 146.934453] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 146.947604] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 146.952104] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 146.953335] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 146.954611] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 146.955860] systemd[1]: Reached target Remote File Systems. machine # [ 147.294252] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 147.299084] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 147.302320] systemd[1]: Starting linger-users.service... machine # [ 147.370830] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 147.373737] systemd[1]: Finished linger-users.service. machine # [ 147.628645] nixos[6444]: finished switching to system configuration /nix/store/564sp6k0d6y9csq3wm5wximvzn6rjffk-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 3.36 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 148.222663] nixos[6586]: switching to system configuration /nix/store/9k2qjvnf60d4dp1y4k9ymcb4y42j274h-nixos-system-machine-test machine # [ 148.225246] systemd[1]: Stopped target Remote File Systems. machine # [ 148.227679] systemd[1]: Stopped target Local File Systems. machine # [ 148.699600] systemd[1]: Reload requested from client PID 6586 ('.switch-to-conf') (unit backdoor.service)... machine # [ 148.701947] systemd[1]: Reloading... machine # [ 149.309373] systemd[1]: Reloading finished in 605 ms. machine # [ 149.459011] systemd[576]: Reexecution requested from client PID 6655 ('switch-to-confi')... machine # [ 149.461448] systemd[576]: Reexecuting. machine # [ 149.530396] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 149.736259] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 149.743062] systemd[576]: Reload requested from client PID 6655 ('switch-to-confi')... machine # [ 149.745739] systemd[576]: Reloading... machine # [ 149.933135] systemd[576]: Reloading finished in 186 ms. machine # [ 149.948180] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 149.957855] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 149.960145] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 149.963424] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 150.011750] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 150.016902] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 150.017883] systemd[1]: Stopping Reactivate sysinit units... machine # [ 150.018676] systemd[1]: Reached target Reactivate sysinit units. machine # [ 150.022145] systemd[1]: Reached target Remote File Systems. machine # [ 150.027855] systemd[1]: Starting linger-users.service... machine # [ 150.038987] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 150.043081] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 150.049946] systemd[1]: Reached target Local File Systems. machine # [ 150.050868] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 150.056812] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 150.057718] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 150.058906] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 150.068814] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 150.070984] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 150.072803] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 150.134349] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 150.137844] systemd[1]: Finished linger-users.service. machine # [ 150.422548] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 150.426256] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 150.683313] nixos[6586]: finished switching to system configuration /nix/store/9k2qjvnf60d4dp1y4k9ymcb4y42j274h-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 3.06 seconds) (finished: subtest: unit file parser, in 41.76 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 151.303030] nixos[6726]: switching to system configuration /nix/store/c3q2ln63wnh9sc1xkp6590g4lgrv1mnn-nixos-system-machine-test machine # [ 151.305923] systemd[1]: Stopped target Local File Systems. machine # [ 151.308319] systemd[1]: Stopped target Remote File Systems. machine # [ 151.761335] systemd[1]: Reload requested from client PID 6726 ('.switch-to-conf') (unit backdoor.service)... machine # [ 151.763266] systemd[1]: Reloading... machine # [ 152.361818] systemd[1]: Reloading finished in 596 ms. machine # [ 152.488428] systemd[576]: Reexecution requested from client PID 6795 ('switch-to-confi')... machine # [ 152.492122] systemd[576]: Reexecuting. machine # [ 152.550074] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 152.749650] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 152.756355] systemd[576]: Reload requested from client PID 6795 ('switch-to-confi')... machine # [ 152.758917] systemd[576]: Reloading... machine # [ 152.951265] systemd[576]: Reloading finished in 190 ms. machine # [ 152.964170] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 152.974359] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 152.977017] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 152.979967] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 153.026873] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 153.031447] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 153.032921] systemd[1]: Stopping Reactivate sysinit units... machine # [ 153.033812] systemd[1]: Reached target Reactivate sysinit units. machine # [ 153.037676] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 153.041399] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 153.045791] systemd[1]: Reached target Remote File Systems. machine # [ 153.051640] systemd[1]: Starting linger-users.service... machine # [ 153.055916] systemd[1]: Reached target Local File Systems. machine # [ 153.066452] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 153.074329] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 153.075240] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 153.078508] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 153.081606] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 153.088460] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 153.089867] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 153.156710] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 153.160278] systemd[1]: Finished linger-users.service. machine # [ 153.441530] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 153.445011] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 153.702027] nixos[6726]: finished switching to system configuration /nix/store/c3q2ln63wnh9sc1xkp6590g4lgrv1mnn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 3.02 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 154.380371] nixos[6866]: switching to system configuration /nix/store/y2nc7375x7m7c30zw3hy1r3cqbadl2nc-nixos-system-machine-test machine # [ 154.384392] systemd[1]: Stopped target Local File Systems. machine # [ 154.386979] systemd[1]: Stopped target Remote File Systems. machine # [ 154.388121] systemd[1]: test.service: Deactivated successfully. machine # [ 154.388976] systemd[1]: Stopped test.service. machine # [ 154.988779] systemd[1]: Reload requested from client PID 6866 ('.switch-to-conf') (unit backdoor.service)... machine # [ 154.990908] systemd[1]: Reloading... machine # [ 155.711805] systemd[1]: Reloading finished in 718 ms. machine # [ 155.858143] systemd[576]: Reexecution requested from client PID 6937 ('switch-to-confi')... machine # [ 155.862044] systemd[576]: Reexecuting. machine # [ 155.928744] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 156.128694] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 156.136289] systemd[576]: Reload requested from client PID 6937 ('switch-to-confi')... machine # [ 156.138759] systemd[576]: Reloading... machine # [ 156.336550] systemd[576]: Reloading finished in 196 ms. machine # [ 156.352170] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 156.361682] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 156.364127] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 156.367068] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 156.414293] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 156.419120] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 156.420645] systemd[1]: Stopping Reactivate sysinit units... machine # [ 156.421514] systemd[1]: Reached target Reactivate sysinit units. machine # [ 156.429997] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 156.432565] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 156.435961] systemd[1]: Reached target Remote File Systems. machine # [ 156.438580] systemd[1]: Starting linger-users.service... machine # [ 156.444419] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 156.448399] systemd[1]: Starting reload-triggers.service... machine # [ 156.455059] systemd[1]: Starting simple-restart-service.service... machine # [ 156.463363] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 156.478601] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 156.500642] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 156.512279] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 156.529981] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 156.548423] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 156.563740] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 156.584275] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 156.593405] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 156.619846] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 156.645775] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 156.668346] systemd[1]: Reached target Local File Systems. machine # [ 156.669407] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 156.670964] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 156.671752] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 156.693941] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 156.713070] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 156.734193] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 156.751896] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 156.762794] systemd[1]: Finished reload-triggers.service. machine # [ 156.766526] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 156.767444] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 156.772909] systemd[1]: Finished simple-restart-service.service. machine # [ 156.774295] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 156.776671] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 156.778180] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 156.780804] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 156.782601] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 156.787116] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 156.790544] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 156.793411] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 156.795562] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 156.805449] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 156.807125] systemd[1]: Finished linger-users.service. machine # [ 157.098387] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 157.103085] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 157.106862] systemd[1]: Starting no-restart-service.service... machine # [ 157.111024] systemd[1]: Starting simple-reload-service.service... machine # [ 157.115109] systemd[1]: Starting simple-service.service... machine # [ 157.122370] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 157.180097] systemd[1]: Finished no-restart-service.service. machine # [ 157.184293] systemd[1]: Finished simple-reload-service.service. machine # [ 157.185252] systemd[1]: Finished simple-service.service. machine # [ 157.185993] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 157.448667] nixos[6866]: finished switching to system configuration /nix/store/y2nc7375x7m7c30zw3hy1r3cqbadl2nc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.75 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 158.199038] nixos[7036]: switching to system configuration /nix/store/y2nc7375x7m7c30zw3hy1r3cqbadl2nc-nixos-system-machine-test machine # [ 158.203015] systemd[1]: Stopped target Local File Systems. machine # [ 158.204606] systemd[1]: Stopped target Remote File Systems. machine # [ 158.755916] systemd[1]: Reload requested from client PID 7036 ('.switch-to-conf') (unit backdoor.service)... machine # [ 158.758185] systemd[1]: Reloading... machine # [ 159.429708] systemd[1]: Reloading finished in 669 ms. machine # [ 159.572732] systemd[576]: Reexecution requested from client PID 7107 ('switch-to-confi')... machine # [ 159.577283] systemd[576]: Reexecuting. machine # [ 159.626640] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 159.832419] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 159.840399] systemd[576]: Reload requested from client PID 7107 ('switch-to-confi')... machine # [ 159.842909] systemd[576]: Reloading... machine # [ 160.047553] systemd[576]: Reloading finished in 203 ms. machine # [ 160.060341] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 160.071897] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 160.075258] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 160.078538] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 160.130754] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 160.135820] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 160.137965] systemd[1]: Stopping Reactivate sysinit units... machine # [ 160.138868] systemd[1]: Reached target Reactivate sysinit units. machine # [ 160.146885] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 160.159633] systemd[1]: Reloading reload-triggers.service... machine # [ 160.166187] systemd[1]: Reloading simple-reload-service.service... machine # [ 160.183532] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 160.200317] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 160.213100] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 160.261259] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 160.282161] systemd[1]: Reloaded simple-reload-service.service. machine # [ 160.291471] systemd[1]: Reloaded reload-triggers.service. machine # [ 160.304524] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 160.315819] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 160.319341] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 160.323183] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 160.327931] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 160.329644] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 160.332729] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 160.337262] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 160.339370] systemd[1]: Stopped simple-restart-service.service. machine # [ 160.345632] systemd[1]: Stopping simple-restart-service.service... machine # [ 160.347470] systemd[1]: Starting simple-restart-service.service... machine # [ 160.352760] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 160.363490] systemd[1]: Stopped simple-service.service. machine # [ 160.376807] systemd[1]: Stopping simple-service.service... machine # [ 160.377649] systemd[1]: Starting simple-service.service... machine # [ 160.378526] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 160.397846] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 160.399177] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 160.410318] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 160.411800] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 160.428786] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 160.440725] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 160.455745] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 160.466972] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 160.470705] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 160.478683] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 160.481657] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 160.497965] systemd[1]: Finished simple-service.service. machine # [ 160.505728] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 160.507926] systemd[1]: Finished simple-restart-service.service. machine # [ 160.510506] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 160.513991] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 160.521493] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 160.526471] systemd[1]: Reached target Local File Systems. machine # [ 160.533834] systemd[1]: Reached target Remote File Systems. machine # [ 160.540510] systemd[1]: Starting linger-users.service... machine # [ 160.543828] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 160.547151] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 160.555990] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 160.564745] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 160.567616] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 160.572271] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 160.574672] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 160.580901] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 160.583048] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 160.656682] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 160.661267] systemd[1]: Finished linger-users.service. machine # [ 160.936984] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 160.940373] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 161.198128] nixos[7036]: finished switching to system configuration /nix/store/y2nc7375x7m7c30zw3hy1r3cqbadl2nc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.75 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 162.058322] nixos[7202]: switching to system configuration /nix/store/jdl175bvka3fmb6gf949gvy3w9sj3sjf-nixos-system-machine-test machine # [ 162.061989] systemd[1]: Stopped target Local File Systems. machine # [ 162.063536] systemd[1]: Stopped target Remote File Systems. machine # [ 162.677206] systemd[1]: Reload requested from client PID 7202 ('.switch-to-conf') (unit backdoor.service)... machine # [ 162.679394] systemd[1]: Reloading... machine # [ 163.423102] systemd[1]: Reloading finished in 740 ms. machine # [ 163.580707] systemd[576]: Reexecution requested from client PID 7273 ('switch-to-confi')... machine # [ 163.584724] systemd[576]: Reexecuting. machine # [ 163.650236] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 163.850302] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 163.857949] systemd[576]: Reload requested from client PID 7273 ('switch-to-confi')... machine # [ 163.860814] systemd[576]: Reloading... machine # [ 164.054917] systemd[576]: Reloading finished in 193 ms. machine # [ 164.072191] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 164.082862] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 164.085469] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 164.088502] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 164.138864] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 164.143369] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 164.144884] systemd[1]: Stopping Reactivate sysinit units... machine # [ 164.145764] systemd[1]: Reached target Reactivate sysinit units. machine # [ 164.152201] systemd[1]: Reloading reload-triggers.service... machine # [ 164.162564] systemd[1]: Reloading simple-reload-service.service... machine # [ 164.176168] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 164.181415] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 164.221253] systemd[1]: Reloaded reload-triggers.service. machine # [ 164.228899] systemd[1]: Reloaded simple-reload-service.service. machine # [ 164.245550] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 164.251144] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 164.254550] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 164.258327] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 164.259573] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 164.262910] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 164.266938] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 164.270400] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 164.271353] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 164.275820] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 164.284609] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 164.296315] systemd[1]: Stopped simple-restart-service.service. machine # [ 164.298466] systemd[1]: Stopping simple-restart-service.service... machine # [ 164.308661] systemd[1]: Starting simple-restart-service.service... machine # [ 164.318928] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 164.334035] systemd[1]: Stopped simple-service.service. machine # [ 164.343395] systemd[1]: Stopping simple-service.service... machine # [ 164.355175] systemd[1]: Starting simple-service.service... machine # [ 164.366694] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 164.382217] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 164.391108] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 164.407358] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 164.429069] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 164.430499] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 164.431561] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 164.438674] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 164.442200] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 164.446173] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 164.449276] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 164.458497] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 164.462760] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 164.467065] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 164.471612] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 164.473806] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 164.474918] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 164.475914] systemd[1]: Finished simple-restart-service.service. machine # [ 164.479513] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 164.484322] systemd[1]: Finished simple-service.service. machine # [ 164.485176] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 164.486308] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 164.487355] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 164.488740] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 164.492882] systemd[1]: Reached target Remote File Systems. machine # [ 164.497668] systemd[1]: Starting linger-users.service... machine # [ 164.511561] systemd[1]: Reached target Local File Systems. machine # [ 164.513573] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 164.515407] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 164.520528] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 164.521821] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 164.523992] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 164.529819] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 164.531630] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 164.534469] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 164.536899] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 164.598451] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 164.599550] systemd[1]: Finished linger-users.service. machine # [ 164.874945] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 164.878617] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 165.136086] nixos[7202]: finished switching to system configuration /nix/store/jdl175bvka3fmb6gf949gvy3w9sj3sjf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 3.94 seconds) machine: must succeed: /nix/store/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-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/qb7gx9bcai5zmvmb8qms1jzvbvz1pq68-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.88 seconds) (finished: subtest: restart and reload by activation script, in 15.34 seconds) (finished: run the VM test script, in 166.84 seconds) test script finished in 166.89s 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.21 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