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: QEMU running (pid 45) machine # Disk image does not exist, creating the virtualisation disk image... machine # Formatting '/build/vm-state-machine/tmp.P8I0HaTdtP', 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: 14b8fb82-e745-4320-b3ba-f5c205811327 machine # Superblock backups stored on blocks: machine # 32768, 98304, 163840, 229376 machine # machine # Allocating group tables: 0/8 done machine # Writing inode tables: 0/8 done machine # Creating journal (8192 blocks): done machine # Writing superblocks and filesystem accounting information: 0/8 done machine # machine # Virtualisation disk image created. machine # Starting virtiofs daemons... machine # [2026-09-25T03:04:20Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-25T03:04:20Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-25T03:04:20Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-25T03:04:20Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-25T03:04:20Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-25T03:04:20Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-25T03:04:20Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-25T03:04:20Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-25T03:04:20Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-25T03:04:20Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-25T03:04:20Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-25T03:04:20Z INFO virtiofsd] Client connected, servicing requests machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.53 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 21 13:06:06 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 0x7fdee700-0x7fdf1e7f] 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 s186776 r8192 d116328 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/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/init regInfo=/nix/.ro-store/jq34bbcah7wvk6ld925llnhxlj80pgix-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/jq34bbcah7wvk6ld925llnhxlj80pgix-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 74963 entries in 294 pages machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups machine # [ 0.000000] rcu: Hierarchical RCU implementation. machine # [ 0.000000] rcu: RCU event tracing is enabled. machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. machine # [ 0.000000] Rude variant of Tasks RCU enabled. machine # [ 0.000000] Tracing variant of Tasks RCU enabled. machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 machine # [ 0.000000] GICv3: 256 SPIs implemented machine # [ 0.000000] GICv3: 0 Extended SPIs implemented machine # [ 0.000000] Root IRQ handler: gic_handle_irq machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1) machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1) machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000 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.000032] arm-pv: using stolen time PV machine # [ 0.000402] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000567] Console: colour dummy device 80x25 machine # [ 0.000574] printk: legacy console [tty0] enabled machine # [ 0.000779] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000786] pid_max: default: 32768 minimum: 301 machine # [ 0.000870] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.000999] landlock: Up and running. machine # [ 0.001002] Yama: becoming mindful. machine # [ 0.001462] LSM support for eBPF active machine # [ 0.001584] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.001603] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.003462] rcu: Hierarchical SRCU implementation. machine # [ 0.003468] rcu: Max phase no-delay instances is 1000. machine # [ 0.004709] fsl-mc MSI: its@8080000 domain created machine # [ 0.004832] EFI services will not be available. machine # [ 0.004899] smp: Bringing up secondary CPUs ... machine # [ 0.004907] smp: Brought up 1 node, 1 CPU machine # [ 0.004910] SMP: Total of 1 processors activated. machine # [ 0.004913] CPU: All CPU(s) started at EL1 machine # [ 0.004926] CPU features: detected: Branch Target Identification machine # [ 0.004930] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.004933] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.004936] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.004940] CPU features: detected: Common not Private translations machine # [ 0.004943] CPU features: detected: CRC32 instructions machine # [ 0.004946] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.004950] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.004952] CPU features: detected: Data independent timing control (DIT) machine # [ 0.004956] CPU features: detected: E0PD machine # [ 0.004958] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.004964] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.004967] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.004971] CPU features: detected: Fine Grained Traps machine # [ 0.004974] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.004979] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.004982] CPU features: detected: LSE atomic instructions machine # [ 0.004985] CPU features: detected: Privileged Access Never machine # [ 0.004988] CPU features: detected: PMUv3 machine # [ 0.004991] CPU features: detected: RAS Extension Support machine # [ 0.004994] CPU features: detected: RASv1p1 Extension Support machine # [ 0.004996] CPU features: detected: Random Number Generator machine # [ 0.004999] CPU features: detected: Speculation barrier (SB) machine # [ 0.005002] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.005004] CPU features: detected: TLB range maintenance instructions machine # [ 0.005009] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.005045] alternatives: applying system-wide alternatives machine # [ 0.008047] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.008280] Memory: 893760K/1048576K available (24448K kernel code, 7094K rwdata, 26592K rodata, 4736K init, 1107K bss, 113556K reserved, 32768K cma-reserved) machine # [ 0.008638] devtmpfs: initialized machine # [ 0.010443] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.010466] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.010652] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.010657] 0 pages in range for non-PLT usage machine # [ 0.010658] 508224 pages in range for PLT usage machine # [ 0.010774] pinctrl core: initialized pinctrl subsystem machine # [ 0.011598] DMI not present or invalid. machine # [ 0.014654] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.016873] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.017022] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.017184] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.017220] audit: initializing netlink subsys (disabled) machine # [ 0.017813] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.017815] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.017819] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.017822] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.017825] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.017853] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 machine # [ 0.017861] cpuidle: using governor ladder machine # [ 0.017867] cpuidle: using governor menu machine # [ 0.018079] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.018095] ASID allocator initialised with 65536 entries machine # [ 0.019315] Serial: AMBA PL011 UART driver machine # [ 0.025147] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.025281] printk: console [ttyAMA0] enabled machine # [ 0.149958] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.149968] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.149972] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.149974] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.149977] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.149980] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.149983] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.149986] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.151242] fbcon: Taking over console machine # [ 0.151251] ACPI: Interpreter disabled. machine # [ 0.152219] iommu: Default domain type: Translated machine # [ 0.152223] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.152576] SCSI subsystem initialized machine # [ 0.152767] usbcore: registered new interface driver usbfs machine # [ 0.152795] usbcore: registered new interface driver hub machine # [ 0.152811] usbcore: registered new device driver usb machine # [ 0.170001] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.170007] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.170016] PTP clock support registered machine # [ 0.170055] EDAC MC: Ver: 3.0.0 machine # [ 0.170252] scmi_core: SCMI protocol bus registered machine # [ 0.170633] FPGA manager framework machine # [ 0.171187] vgaarb: loaded machine # [ 0.171464] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.173635] VFS: Disk quotas dquot_6.6.0 machine # [ 0.173659] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.182298] netfs: FS-Cache loaded machine # [ 0.182425] pnp: PnP ACPI: disabled machine # [ 0.186569] NET: Registered PF_INET protocol family machine # [ 0.186716] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.216080] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.216117] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.216138] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.216181] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.216254] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.216341] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.216409] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.216457] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.216558] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.216603] NET: Registered PF_XDP protocol family machine # [ 0.216620] PCI: CLS 0 bytes, default 64 machine # [ 0.216995] Trying to unpack rootfs image as initramfs... machine # [ 0.229754] kvm [1]: HYP mode not available machine # [ 0.336100] Initialise system trusted keyrings machine # [ 0.336269] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.336665] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.336714] 9p: Installing v9fs 9p2000 file system support machine # [ 0.364751] Key type asymmetric registered machine # [ 0.364768] Asymmetric key parser 'x509' registered machine # [ 0.364844] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.364997] io scheduler mq-deadline registered machine # [ 0.365001] io scheduler kyber registered machine # [ 0.377369] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.377958] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.378320] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.378333] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.378343] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.378348] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.378385] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.378405] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.378482] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.378489] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.378493] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.378496] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.378499] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.378566] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.379002] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.379184] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.379195] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.379220] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.379232] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.403824] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.404020] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.404033] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.404058] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.404521] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.404700] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.404711] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.404736] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.405182] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.405382] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.405393] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.405417] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.405429] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.405884] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.406062] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.406087] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.406568] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.406749] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.406773] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.407156] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.407333] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.424728] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.424910] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.424936] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.425408] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.425585] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.425610] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.426057] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.426234] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.426259] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.426711] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.426998] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.427009] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.427034] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.443558] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.443752] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.443765] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.443789] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.444470] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.444476] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.444480] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.444526] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.444572] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.444616] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.444662] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.444711] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.444758] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.444801] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.444843] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.444887] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.444972] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.445072] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.445089] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.445108] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.445124] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.445141] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.445159] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.445176] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.445213] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.445237] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.445255] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.445272] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.445290] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.445307] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.445323] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.445340] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned machine # [ 0.445356] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned machine # [ 0.445376] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.445392] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.445417] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.445422] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.445425] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.446247] pci 0000:00:07.0: enabling device (0000 -> 0002) machine # [ 0.500283] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.502845] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.520985] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.522924] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.526738] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002) machine # [ 0.530153] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002) machine # [ 0.540566] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.542697] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.546226] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.556068] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.558629] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.572806] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.574777] msm_serial: driver initialized machine # [ 0.574924] SuperH (H)SCI(F) driver initialized machine # [ 0.574981] STM32 USART driver initialized machine # [ 0.613076] loop: module loaded machine # [ 0.613314] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 0.614188] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.624256] megasas: 07.734.00.00-rc1 machine # [ 0.625024] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.630077] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.630098] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.633860] Using buffer write method machine # [ 0.633904] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.643530] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.643558] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.645893] Using buffer write method machine # [ 0.645918] Concatenating MTD devices: machine # [ 0.645921] (0): "0.flash" machine # [ 0.645924] (1): "0.flash" machine # [ 0.645926] into device "0.flash" machine # [ 0.934888] Freeing initrd memory: 26444K machine # [ 0.941409] tun: Universal TUN/TAP device driver, 1.6 machine # [ 0.945543] thunder_xcv, ver 1.0 machine # [ 0.945576] thunder_bgx, ver 1.0 machine # [ 0.945594] nicpf, ver 1.0 machine # [ 0.946166] e1000: Intel(R) PRO/1000 Network Driver machine # [ 0.946171] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 0.946197] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 0.946206] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 0.946236] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 0.946239] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 0.946259] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 0.946262] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 0.946396] sky2: driver version 1.30 machine # [ 0.956259] ehci-pci 0000:00:07.0: EHCI Host Controller machine # [ 0.956284] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1 machine # [ 0.956503] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000 machine # [ 0.956584] usbcore: registered new interface driver usb-storage machine # [ 0.956644] usbcore: registered new interface driver usbserial_generic machine # [ 0.956657] usbserial: USB Serial support registered for generic machine # [ 0.957523] hv_vmbus: registering driver hyperv_keyboard machine # [ 0.958452] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 0.958475] rtc-pl031 9010000.pl031: setting system clock to 2026-09-25T03:04:22 UTC (1790305462) machine # [ 0.958790] i2c_dev: i2c /dev entries driver machine # [ 0.969727] sdhci: Secure Digital Host Controller Interface driver machine # [ 0.969736] sdhci: Copyright(c) Pierre Ossman machine # [ 0.970019] Synopsys Designware Multimedia Card Interface Driver machine # [ 0.970405] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 0.971633] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00 machine # [ 0.971997] hub 1-0:1.0: USB hub found machine # [ 0.972014] hub 1-0:1.0: 6 ports detected machine # [ 0.977810] hid: raw HID events driver (C) Jiri Kosina machine # [ 0.978082] usbcore: registered new interface driver usbhid machine # [ 0.978094] usbhid: USB HID core driver machine # [ 0.979292] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 0.980966] drop_monitor: Initializing network drop monitor service machine # [ 0.981118] NET: Registered PF_INET6 protocol family machine # [ 0.986214] Segment Routing with IPv6 machine # [ 0.986232] In-situ OAM (IOAM) with IPv6 machine # [ 0.986269] NET: Registered PF_PACKET protocol family machine # [ 0.986329] 9pnet: Installing 9P2000 support machine # [ 0.986371] Key type dns_resolver registered machine # [ 0.995264] registered taskstats version 1 machine # [ 0.995439] Loading compiled-in X.509 certificates machine # [ 1.004439] Demotion targets for Node 0: null machine # [ 1.004558] Key type .fscrypt registered machine # [ 1.004568] Key type fscrypt-provisioning registered machine # [ 1.004665] ima: No TPM chip found, activating TPM-bypass! machine # [ 1.004683] ima: Allocated hash algorithm: sha1 machine # [ 1.004706] ima: No architecture policies found machine # [ 1.005482] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 1.028027] clk: Disabling unused clocks machine # [ 1.028047] PM: genpd: Disabling unused power domains machine # [ 1.031146] Freeing unused kernel memory: 4736K machine # [ 1.031352] Run /init as init process machine # [ 1.050031] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.219610] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.372131] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1 machine # [ 1.383965] systemd[1]: systemd 263-f8dae4b 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.384010] systemd[1]: Detected virtualization qemu. machine # [ 1.384152] systemd[1]: Detected architecture arm64. machine # [ 1.384168] systemd[1]: Running in initrd. machine # [ 1.385215] systemd[1]: Initializing machine ID from random generator. machine # [ 1.385607] systemd[1]: Hostname set to . machine # [ 1.467710] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0 machine # [ 1.518842] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.573746] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.578585] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.578766] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.578791] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.578810] systemd[1]: Reached target Path Units. machine # [ 1.578822] systemd[1]: Reached target Slice Units. machine # [ 1.578835] systemd[1]: Reached target Swaps. machine # [ 1.578847] systemd[1]: Reached target Timer Units. machine # [ 1.578974] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.579117] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.579254] systemd[1]: Listening on Journal Sockets. machine # [ 1.579325] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.579338] systemd[1]: Reached target Socket Units. machine # [ 1.587696] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.589379] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.589448] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.595670] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.607636] systemd[1]: Starting Journal Service... machine # [ 1.627619] systemd[1]: Starting Load Kernel Modules... machine # [ 1.627734] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.650768] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.653421] systemd-journald[71]: Collecting audit messages is disabled. machine # [ 1.659750] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.660487] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.675926] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.733468] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.736547] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.743990] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.753988] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 machine # [ 1.754126] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0 machine # [ 1.759526] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.778187] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0 machine # [ 1.778425] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.778429] [drm] features: -context_init machine # [ 1.779183] [drm] number of scanouts: 1 machine # [ 1.779194] [drm] number of cap sets: 0 machine # [ 1.795896] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic machine # [ 1.795923] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0 machine # [ 1.811640] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.812064] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.812088] systemd[1]: Reached target Local File Systems. machine # [ 1.821152] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.831818] Console: switching to colour frame buffer device 160x50 machine # [ 1.839163] systemd-modules-load[73]: Inserted module 'dm_mod' machine # [ 1.851791] systemd[1]: Started Journal Service. machine # [ 1.840999] systemd-modules-load[73]: Module 'virtio_balloon' is built in machine # [ 1.842183] systemd-modules-load[73]: Module 'virtio_console' is built in machine # [ 1.864365] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.861633] systemd-modules-load[73]: Inserted module 'virtio_gpu' machine # [ 1.862744] systemd-modules-load[73]: Module 'virtio_rng' is built in machine # [ 1.864069] systemd[1]: Starting Create System Files and Directories... machine # [ 1.871033] systemd[1]: Finished Load Kernel Modules. machine # [ 1.908944] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.929285] systemd[1]: Finished Create System Files and Directories. machine # [ 1.937176] systemd-udevd[78]: Using default interface naming scheme 'v261'. machine # [ 1.947745] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.972937] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 2.060141] systemd[1]: Starting Virtual Console Setup... machine # [ 2.132612] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.136375] systemd[1]: Finished Virtual Console Setup. machine # [ 2.748464] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.752163] systemd[1]: Reached target System Initialization. machine # [ 2.753066] systemd[1]: Reached target Basic System. machine # [ 2.935204] (udev-worker)[91]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.942601] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line. machine # [ 3.016608] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 3.023121] systemd[1]: Reached target Initrd Root Device. machine # [ 3.028474] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 3.082732] systemd-fsck[109]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 3.099587] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 3.104194] systemd[1]: Mounting /sysroot... machine # [ 3.179014] EXT4-fs (vda): mounted filesystem 14b8fb82-e745-4320-b3ba-f5c205811327 r/w with ordered data mode. Quota mode: none. machine # [ 3.171431] systemd[1]: Mounted /sysroot. machine # [ 3.172657] systemd[1]: Reached target Initrd Root File System. machine # [ 3.176485] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 3.209012] systemd-sysroot-fstab-check[117]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 3.213146] systemd[1]: Reload requested from client PID 117 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 3.217292] systemd[1]: Reloading... machine # [ 3.417857] systemd[1]: Reloading finished in 202 ms. machine # [ 3.453091] systemd-sysroot-fstab-check[117]: Requesting initrd-fs.target/start/replace... machine # [ 3.457697] systemd-sysroot-fstab-check[117]: Requesting swap.target/start/replace... machine # [ 3.462476] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.466088] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.468499] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.642481] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.659995] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.669364] systemd[1]: Mounting /sysroot/run... machine # [ 3.699502] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.728842] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.751359] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.792158] fuse: init (API version 7.45) machine # [ 3.803633] virtiofs virtio6: discovered new tag: nix-store machine # [ 3.804469] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 3.797059] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.801365] systemd[1]: Mounted /sysroot/run. machine # [ 3.821342] virtiofs virtio7: discovered new tag: shared machine # [ 3.822141] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 3.833213] virtiofs virtio8: discovered new tag: xchg machine # [ 3.834002] virtiofs virtio8: virtio_fs_setup_dax: No cache capability machine # [ 3.846208] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.852117] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.855929] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.875889] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.877620] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.405105] (udev-worker)[96]: mtd0ro: Failed to find and pin callout binary "/nix/store/in96z2h242rj6x8kvabxm4x1jfd5ivfx-systemd-263-f8dae4b/lib/udev/mtd_probe": No such file or directory machine # [ 4.413027] (udev-worker)[96]: mtd0ro: /etc/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory machine # [ 4.450326] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.451945] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.456330] systemd[1]: Stopping Virtual Console Setup... machine # [ 4.457193] systemd[1]: Starting Virtual Console Setup... machine # [ 4.472855] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.475595] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.476975] systemd[1]: Starting Virtual Console Setup... machine # [ 4.500795] systemd-vconsole-setup[152]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 4.503988] systemd[1]: Finished Virtual Console Setup. machine # [ 4.640949] systemd[1]: Mounting /sysroot/nix/store... machine # [ 4.694345] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.695751] systemd[1]: Reached target Initrd File Systems. machine # [ 4.700213] systemd[1]: Starting Find NixOS closure... machine # [ 4.704948] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.744138] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.747227] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 4.759467] systemd[1]: Finished Find NixOS closure. machine # [ 4.760642] systemd[1]: Reached target Initrd Default Target. machine # [ 4.764254] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.790401] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.792564] systemd[1]: Stopped target Basic System. machine # [ 4.794420] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.796745] systemd[1]: Stopped target Path Units. machine # [ 4.799408] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.801775] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.808181] systemd[1]: Stopped target Slice Units. machine # [ 4.809155] systemd[1]: Stopped target Socket Units. machine # [ 4.810011] systemd[1]: Stopped target System Initialization. machine # [ 4.810953] systemd[1]: Stopped target Swaps. machine # [ 4.811698] systemd[1]: Stopped target Timer Units. machine # [ 4.814974] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.819879] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.823869] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.827361] systemd[1]: Stopped Find NixOS closure. machine # [ 4.831894] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.833252] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.834229] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.834978] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.836002] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.844795] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.848889] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.853792] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.855555] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.858504] systemd[1]: Stopped target Local File Systems. machine # [ 4.860300] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.864220] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.865344] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.866165] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.867917] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.870602] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.871391] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.872392] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.873310] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.874286] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.875277] systemd[1]: systemd-udevd.service: Consumed 1.568s CPU time over 3.041s wall clock time, 22.2M memory peak. machine # [ 4.880305] systemd[1]: Starting Cleanup udev Database... machine # [ 4.882457] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.884838] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.888229] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.889463] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.892201] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.896122] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.897050] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.898358] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.926749] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.930147] systemd[1]: Finished Cleanup udev Database. machine # [ 4.930980] systemd[1]: Reached target Switch Root. machine # [ 4.932217] systemd[1]: Starting NixOS Activation... machine # [ 5.020798] initrd-nixos-activation-start[175]: booting system configuration /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test machine # [ 5.055473] initrd-nixos-activation-start[175]: running activation script... machine # [ 5.290354] initrd-nixos-activation-start[198]: setting up /etc... machine # [ 5.411022] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 5.413977] systemd[1]: Finished NixOS Activation. machine # [ 5.415176] systemd[1]: Starting Switch Root... machine # [ 5.439766] systemd[1]: Switching root. machine # [ 5.626166] systemd-journald[71]: Received SIGTERM from PID 1 (systemd). machine # [ 6.124026] systemd[1]: systemd 263-f8dae4b running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 6.124166] systemd[1]: Detected virtualization qemu. machine # [ 6.124279] systemd[1]: Detected architecture arm64. machine # [ 6.124489] systemd[1]: Detected first boot. machine # [ 6.145368] systemd[1]: Initializing machine ID from random generator. machine # [ 6.316856] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 6.471763] systemd[1]: Applying preset policy. machine # [ 6.693810] systemd[1]: Populated /etc with preset unit settings. machine # [ 6.910197] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 6.910622] systemd[1]: Stopped initrd-switch-root.service. machine # [ 6.915146] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 6.918562] systemd[1]: Created slice Slice /system/getty. machine # [ 6.921056] systemd[1]: Created slice User and Session Slice. machine # [ 6.921673] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 6.922532] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 6.923279] systemd[1]: Expecting device /dev/hvc0... machine # [ 6.928278] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 6.928753] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 6.929655] systemd[1]: Stopped target initrd-fs.target. machine # [ 6.930457] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 6.931284] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 6.936642] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 6.937000] systemd[1]: Reached target Path Units. machine # [ 6.937279] systemd[1]: Reached target Remote File Systems. machine # [ 6.937539] systemd[1]: Reached target Slice Units. machine # [ 6.937792] systemd[1]: Reached target Swaps. machine # [ 6.943008] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 6.946355] systemd[1]: Listening on Process Core Dump Socket. machine # [ 6.948998] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 6.950515] systemd[1]: Listening on Factory Reset Management. machine # [ 6.951130] systemd[1]: Listening on Hostname Service Socket. machine # [ 6.957918] systemd[1]: Starting Journal Log Access Socket... machine # [ 6.960438] systemd[1]: Listening on Journal Audit Socket. machine # [ 6.962668] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 6.965959] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 6.967349] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.971367] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 6.977872] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 6.978616] systemd[1]: Listening on udev Varlink Socket. machine # [ 6.984112] systemd[1]: Mounting Huge Pages File System... machine # [ 6.987055] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 6.999888] systemd[1]: Mounting Kernel Debug File System... machine # [ 7.016145] systemd[1]: Mounting Kernel Trace File System... machine # [ 7.028389] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 7.035822] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 7.051756] systemd[1]: Mounting Kernel Configuration File System... machine # [ 7.052436] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 7.060229] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 7.068191] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 7.100294] systemd[1]: Mounting FUSE Control File System... machine # [ 7.100775] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 7.132465] systemd[1]: Starting Journal Service... machine # [ 7.151290] systemd[1]: Starting Load Kernel Modules... machine # [ 7.180424] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 7.201600] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 7.202058] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.214371] systemd[1]: Starting Coldplug All udev Devices... machine # [ 7.218571] systemd[1]: Listening on Journal Log Access Socket. machine # [ 7.219037] systemd[1]: Mounted Huge Pages File System. machine # [ 7.219444] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 7.231240] systemd[1]: Mounted Kernel Debug File System. machine # [ 7.242457] systemd[1]: Mounted Kernel Trace File System. machine # [ 7.247763] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 7.248409] systemd[1]: Mounted Kernel Configuration File System. machine # [ 7.255831] systemd-journald[269]: Collecting audit messages is enabled. machine # [ 7.262870] systemd[1]: Queued start job for default target Multi-User System. machine # [ 7.264344] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 7.283974] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 7.285365] systemd[1]: Started Journal Service. machine # [ 7.277219] systemd-modules-load[270]: Module 'atkbd' is built in machine # [ 7.278248] systemd-modules-load[270]: Module 'loop' is built in machine # [ 7.301648] systemd[1]: Mounted FUSE Control File System. machine # [ 7.303667] systemd[1]: Finished Load Kernel Modules. machine # [ 7.343408] systemd[1]: Starting Firewall...[ 7.355751] EXT4-fs (vda): re-mounted 14b8fb82-e745-4320-b3ba-f5c205811327. machine # machine # [ 7.349331] systemd-oomd[271]: No swap; memory pressure usage will be degraded machine # [ 7.357906] systemd[1]: Starting Apply Kernel Variables... machine # [ 7.362245] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 7.363272] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 7.373485] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 7.374710] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 7.397235] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 7.398207] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.399415] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 7.519168] systemd-journald[269]: Received client request to flush runtime journal. machine # [ 7.576666] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 7.577623] systemd[1]: Reached target First Boot Complete. machine # [ 7.578462] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 7.579453] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 7.586266] systemd[1]: Finished Apply Kernel Variables. machine # [ 7.593337] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 7.834554] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 7.835638] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 7.841478] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 7.904916] systemd[1]: Mounting /run/wrappers... machine # [ 7.984818] systemd[1]: Mounted /run/wrappers. machine # [ 7.985727] systemd[1]: Reached target Local File Systems. machine # [ 7.991210] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 8.002485] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 8.003438] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 8.007584] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 8.012630] systemd[1]: Starting Create System Files and Directories... machine # [ 8.032052] systemd-udevd[304]: Using default interface naming scheme 'v261'. machine # [ 8.208301] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 8.249159] systemd[1]: Finished Create System Files and Directories. machine # [ 8.267835] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 8.272776] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 8.273816] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 8.282440] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 8.418631] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 8.455494] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 8.468873] systemd[1]: Starting Update is Completed... machine # [ 8.585508] systemd[1]: Finished Update is Completed. machine # [ 8.817695] systemd[1]: Finished Coldplug All udev Devices. machine # [ 8.887856] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 8.920154] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 9.025888] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 9.029628] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 9.035041] systemd[1]: Reached target System Initialization. machine # [ 9.037288] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 9.041492] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 9.042591] systemd[1]: Reached target Timer Units. machine # [ 9.043327] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 9.052323] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 9.057170] systemd[1]: Reached target Socket Units. machine # [ 9.057992] systemd[1]: Reached target Basic System. machine # [ 9.058727] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 9.059731] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 9.070482] systemd[1]: Starting Post-Boot Actions... machine # [ 9.077630] systemd[1]: Started Reset console on configuration changes. machine # [ 9.115524] systemd[1]: Starting resolvconf update... machine # [ 9.165043] systemd[1]: Starting D-Bus System Message Bus... machine # [ 9.244151] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 9.245706] nsncd[423]: Sep 25 03:04:30.800 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 9.265406] systemd[1]: Finished Post-Boot Actions. machine # [ 9.296600] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 9.305790] systemd[1]: Reached target User and Group Name Lookups. machine # [ 9.328289] systemd[1]: Starting User Login Management... machine # [ 9.329239] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 9.355630] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 9.397570] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 9.410922] systemd[1]: Started backdoor.service. machine # [ 9.421730] dbus-broker-launch[430]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 9.439454] dbus-broker-launch[430]: NSS returned no entry for 'systemd-timesync' machine # [ 9.448344] dbus-broker-launch[430]: Invalid user-name in /nix/store/8srfshgrm5f1phyn1d9c41jm2d9gcbp8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 9.503090] systemd[1]: Started D-Bus System Message Bus. machine # [ 9.566684] dbus-broker-launch[430]: Ready machine # connecting to host... machine # [ 9.608258] systemd-logind[452]: New seat seat0. machine # [ 9.617449] systemd[1]: Started User Login Management. machine # [ 9.630738] systemd[1]: Starting linger-users.service... machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 9.97 seconds) machine: (finished: waiting for the VM to finish booting, in 10.50 seconds) machine # [ 9.677164] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 9.678287] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 9.679171] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 9.694359] systemd[1]: Stopping User and Group Name Lookups... machine # [ 9.695298] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 9.705388] systemd[1]: nscd.service: Deactivated successfully. machine # [ 9.706387] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 9.736168] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 9.767642] (udev-worker)[339]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 9.785382] (udev-worker)[339]: Network interface NamePolicy= disabled on kernel command line. machine # [ 9.859569] nsncd[520]: Sep 25 03:04:31.415 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 9.908713] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 9.939536] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 9.944667] systemd[1]: Finished linger-users.service. machine # [ 9.984198] systemd[1]: Created slice Slice /user/1001. machine # [ 9.985150] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 9.986086] systemd[1]: Reached target User and Group Name Lookups. machine # [ 9.986935] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 10.065788] systemd[1]: Finished resolvconf update. machine # [ 10.066768] systemd[1]: Starting DHCP Client... machine # [ 10.107609] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 10.196780] systemd-logind[452]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # [ 10.237616] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 10.238747] systemd[1]: Starting User Manager for UID 1001... machine # [ 10.333407] (systemd)[573]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 10.367981] systemd-logind[452]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 10.411444] mousedev: PS/2 mouse device common for all mice machine # [ 10.427252] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 10.703920] systemd-logind[452]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 10.740633] systemd[573]: Queued start job for default target Main User Target. machine # [ 10.780160] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 10.781845] systemd[573]: Created slice User Application Slice. machine # [ 10.782680] systemd[573]: Started Daily Cleanup of User's Temporary Directories. machine # [ 10.783724] systemd[573]: Reached target Paths. machine # [ 10.874617] systemd[573]: Reached target Timers. machine # [ 10.875435] systemd[573]: Starting D-Bus User Message Bus Socket... machine # [ 10.919836] systemd[573]: Starting Create User Files and Directories... machine # [ 10.942502] systemd[573]: Finished Create User Files and Directories. machine # [ 10.962582] systemd[573]: Listening on D-Bus User Message Bus Socket. machine # [ 10.963694] systemd[573]: Reached target Sockets. machine # [ 10.989068] systemd[573]: Reached target Basic System. machine # [ 10.990179] systemd[1]: Started User Manager for UID 1001. machine # [ 10.991033] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 10.991980] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 11.011355] systemd[573]: Reached target Main User Target. machine # [ 11.018467] systemd[573]: Startup finished in 512ms. machine # [ 11.081879] dhcpcd[587]: dhcpcd-10.3.2 starting machine # [ 11.092514] systemd[1]: Finished Firewall. machine # [ 11.093277] systemd[1]: Reached target Preparation for Network. machine # [ 11.096488] systemd[1]: Starting Address configuration of eth1... machine # [ 11.099724] systemd[1]: Starting Extra networking commands.... machine # [ 11.106531] dhcpcd[609]: dev: loaded udev machine # [ 11.189852] 8021q: 802.1Q VLAN Support v1.8 machine # [ 11.297708] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 11.402120] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 11.402639] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 11.406010] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 11.406330] cfg80211: failed to load regulatory.db machine # [ 11.669665] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 11.765693] dhcpcd[638]: /nix/store/1ki7bgdr0niilkg9jbkpcdaggbv0kb8a-openresolv-3.17.4/sbin/.resolvconf-wrapped: line 1250: kill: (635) - Operation not permitted machine # [ 11.767686] dhcpcd[638]: .resolvconf-wrapped: clearing stale lock pid 635 machine # [ 11.792548] network-addresses-eth1-start[611]: adding address 192.168.1.1/24... done machine # [ 11.864157] network-addresses-eth1-start[611]: adding address 2001:db8:1::1/64... done machine # [ 11.937403] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3 machine # [ 12.010818] systemd[1]: Finished Address configuration of eth1. machine # [ 12.129862] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 12.125091] dhcpcd[609]: eth0: waiting for carrier machine # [ 12.125945] dhcpcd[609]: eth0: carrier acquired machine # [ 12.197936] dhcpcd[609]: DUID 00:01:00:01:32:48:a1:41:52:54:00:12:34:56 machine # [ 12.198994] dhcpcd[609]: eth0: IAID 00:12:34:56 machine # [ 12.199676] dhcpcd[609]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 12.334126] systemd[1]: Starting Virtual Console Setup... machine # [ 12.335079] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 12.392758] systemd-logind[452]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 12.421426] systemd[1]: Finished Extra networking commands.. machine # [ 12.423756] systemd[1]: Reached target Network. machine # [ 12.427879] systemd[1]: Starting Permit User Sessions... machine # [ 12.466509] systemd[1]: Finished Permit User Sessions. machine # [ 12.477588] systemd[1]: Started Getty on tty1. machine # [ 12.478460] systemd[1]: Reached target Login Prompts. machine # [ 12.538395] systemd-vconsole-setup[693]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 12.542101] systemd[1]: Finished Virtual Console Setup. machine # [ 13.793920] dhcpcd[609]: eth0: soliciting a DHCP lease machine # [ 13.796801] dhcpcd[609]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 13.804366] dhcpcd[609]: eth0: probing address 10.0.2.15/24 machine # [ 14.457684] dhcpcd[609]: eth0: soliciting an IPv6 router machine # [ 14.461418] dhcpcd[609]: eth0: Router Advertisement from fe80::2 machine # [ 14.464308] dhcpcd[609]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 14.467165] dhcpcd[609]: eth0: adding route to fec0::/64 machine # [ 14.469969] dhcpcd[609]: eth0: adding default route via fe80::2 machine # [ 18.704928] dhcpcd[609]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 18.706447] dhcpcd[609]: eth0: adding route to 10.0.2.0/24 machine # [ 18.707267] dhcpcd[609]: eth0: adding default route via 10.0.2.2 machine # [ 18.804631] systemd[1]: Started DHCP Client. machine # [ 18.806821] systemd[1]: Reached target Multi-User System. machine # [ 18.807998] systemd[1]: Startup finished in 1.022s (kernel) + 4.661s (initrd) + 13.124s (userspace) = 18.807s. machine: (finished: waiting for unit multi-user.target, in 20.62 seconds) machine: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 20.041770] nixos[838]: switching to system configuration /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test machine # activating the configuration... machine # [ 20.047690] systemd[1]: Stopped target Remote File Systems. machine # [ 20.050005] systemd[1]: Stopped target Local File Systems. machine # setting up /etc... machine # [ 20.383863] systemd[1]: Reload requested from client PID 838 ('.switch-to-conf') (unit backdoor.service)... machine # [ 20.386514] systemd[1]: Reloading... machine # [ 20.773355] systemd[1]: Reloading finished in 384 ms. machine # reloading user units for usertest... machine # [ 20.824887] systemd[573]: Created slice User Core Session Slice. machine # [ 20.828287] systemd[573]: Starting D-Bus User Message Bus... machine # [ 20.862058] dbus-broker-launch[908]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/8srfshgrm5f1phyn1d9c41jm2d9gcbp8-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 20.865170] dbus-broker-launch[908]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/8srfshgrm5f1phyn1d9c41jm2d9gcbp8-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 20.868127] dbus-broker-launch[908]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/8srfshgrm5f1phyn1d9c41jm2d9gcbp8-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 20.871051] dbus-broker-launch[908]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/8srfshgrm5f1phyn1d9c41jm2d9gcbp8-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 20.875592] dbus-broker-launch[908]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 20.878624] dbus-broker-launch[908]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 20.880711] systemd[573]: Started D-Bus User Message Bus. machine # [ 20.883673] dbus-broker-launch[908]: Ready machine # [ 20.934417] systemd[573]: Reexecution requested from client PID 907 ('switch-to-confi')... machine # [ 20.935854] systemd[573]: Reexecuting. machine # [ 20.996317] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.129804] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.136974] systemd[573]: Reload requested from client PID 907 ('switch-to-confi')... machine # [ 21.138315] systemd[573]: Reloading... machine # [ 21.300146] systemd[573]: Reloading finished in 160 ms. machine # [ 21.316185] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 21.326930] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 21.329337] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 21.331588] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 21.366059] systemd[573]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 21.378617] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 21.476216] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 21.477505] systemd[1]: Reached target Reactivate sysinit units. machine # [ 21.482857] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.488714] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 21.490130] systemd[1]: Reached target Remote File Systems. machine # [ 21.492235] systemd[1]: Starting linger-users.service... machine # [ 21.503535] systemd[1]: Reached target Local File Systems. machine # [ 21.510585] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 21.517761] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 21.518712] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 21.519922] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 21.524231] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 21.525854] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.527144] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.586010] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 21.589289] systemd[1]: Finished linger-users.service. machine # [ 21.742243] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 21.745244] systemd[1]: Finished Create SUID/SGID Wrappers. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 22.008993] nixos[838]: finished switching to system configuration /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/bin/switch-to-configuration test, in 2.24 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.05 seconds) machine: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/66z3l03dj9nblw3xxb6y691bb0g1gpvl-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/66z3l03dj9nblw3xxb6y691bb0g1gpvl-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 22.390247] nixos[986]: switching to system configuration /nix/store/66z3l03dj9nblw3xxb6y691bb0g1gpvl-nixos-system-other-test machine # [ 22.393277] systemd[1]: Stopped target Remote File Systems. machine # [ 22.395095] systemd[1]: Stopped target Local File Systems. machine # activating the configuration... machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 22.708662] systemd[1]: Reload requested from client PID 986 ('.switch-to-conf') (unit backdoor.service)... machine # [ 22.710817] systemd[1]: Reloading... machine # [ 23.088676] systemd[1]: Reloading finished in 375 ms. machine # reloading user units for usertest... machine # [ 23.192464] systemd[573]: Reexecution requested from client PID 1057 ('switch-to-confi')... machine # [ 23.196327] systemd[573]: Reexecuting. machine # [ 23.265036] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.407034] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.413881] systemd[573]: Reload requested from client PID 1057 ('switch-to-confi')... machine # [ 23.416515] systemd[573]: Reloading... machine # [ 23.541702] systemd[573]: Reloading finished in 124 ms. machine # [ 23.556255] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 23.567946] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 23.570476] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 23.572371] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 23.606578] systemd[573]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 23.611805] systemd[1]: Stopped target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service machine # [ 23.617065] systemd[1]: Stopping Reactivate sysinit units... machine # [ 23.617949] systemd[1]: Reached target Reactivate sysinit units. machine # [ 23.619154] dbus-broker-launch[430]: Caught SIGHUP, trigger reload. machine # [ 23.621120] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 23.627857] dbus-broker-launch[430]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 23.630248] dbus-broker-launch[430]: NSS returned no entry for 'systemd-timesync' machine # [ 23.631511] dbus-broker-launch[430]: Invalid user-name in /nix/store/nyllvbg8912wqqjjli60yzwiwj24fyw7-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 23.647362] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 23.655624] systemd[1]: Stopping Address configuration of eth1... machine # [ 23.689499] network-addresses-eth1-pre-stop[1069]: deleting address 192.168.1.1/24... done machine # [ 23.696567] network-addresses-eth1-pre-stop[1069]: deleting address 2001:db8:1::1/64... done machine # [ 23.704152] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 23.706233] systemd[1]: Stopped Address configuration of eth1. machine # [ 23.710864] systemd[1]: Starting Address configuration of eth1... machine # [ 23.760529] network-addresses-eth1-start[1074]: adding address 192.168.1.2/24... done machine # [ 23.768594] network-addresses-eth1-start[1074]: adding address 2001:db8:1::2/64... done machine # [ 23.780390] systemd[1]: Finished Address configuration of eth1. machine # [ 23.789780] systemd[1]: Reached target Local File Systems. machine # [ 23.790748] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 23.804363] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 23.805325] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 23.806606] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 23.814671] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 23.819481] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.821629] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.824382] systemd[1]: Reached target Remote File Systems. machine # [ 23.825215] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.826578] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 24.034976] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 24.039812] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 24.044331] systemd[1]: Starting linger-users.service... machine # [ 24.077789] linger-users-start[1146]: id: ‘usertest’: no such user machine # [ 24.079925] linger-users-start[1144]: Removing linger for missing user usertest machine # [ 24.087468] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 24.089625] systemd[1]: Finished linger-users.service. machine # [ 24.350316] nixos[986]: finished switching to system configuration /nix/store/66z3l03dj9nblw3xxb6y691bb0g1gpvl-nixos-system-other-test machine: (finished: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/66z3l03dj9nblw3xxb6y691bb0g1gpvl-nixos-system-other-test/bin/switch-to-configuration test, in 2.29 seconds) subtest: services machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 24.712714] nixos[1152]: switching to system configuration /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test machine # [ 24.715773] systemd[1]: Stopped target Local File Systems. machine # [ 24.717712] systemd[1]: Stopped target Remote File Systems. machine # [ 25.011715] systemd[1]: Reload requested from client PID 1152 ('.switch-to-conf') (unit backdoor.service)... machine # [ 25.013984] systemd[1]: Reloading... machine # [ 25.376732] systemd[1]: Reloading finished in 361 ms. machine # [ 25.472339] systemd[573]: Reexecution requested from client PID 1222 ('switch-to-confi')... machine # [ 25.473805] systemd[573]: Reexecuting. machine # [ 25.531650] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.661601] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.668673] systemd[573]: Reload requested from client PID 1222 ('switch-to-confi')... machine # [ 25.670080] systemd[573]: Reloading... machine # [ 25.787141] systemd[573]: Reloading finished in 115 ms. machine # [ 25.800191] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.809758] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 25.812125] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 25.814359] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 25.844223] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 25.850247] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 25.851221] systemd[1]: Stopping Reactivate sysinit units... machine # [ 25.852573] systemd[1]: Reached target Reactivate sysinit units. machine # [ 25.855269] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 25.857939] dbus-broker-launch[430]: Caught SIGHUP, trigger reload. machine # [ 25.862422] dbus-broker-launch[430]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 25.864602] dbus-broker-launch[430]: NSS returned no entry for 'systemd-timesync' machine # [ 25.865704] dbus-broker-launch[430]: Invalid user-name in /nix/store/8srfshgrm5f1phyn1d9c41jm2d9gcbp8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 25.884457] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 25.889790] systemd[1]: Stopping Address configuration of eth1... machine # [ 25.923365] network-addresses-eth1-pre-stop[1234]: deleting address 192.168.1.2/24... done machine # [ 25.930121] network-addresses-eth1-pre-stop[1234]: deleting address 2001:db8:1::2/64... done machine # [ 25.936941] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 25.939860] systemd[1]: Stopped Address configuration of eth1. machine # [ 25.943571] systemd[1]: Starting Address configuration of eth1... machine # [ 25.987630] network-addresses-eth1-start[1239]: adding address 192.168.1.1/24... done machine # [ 25.995176] network-addresses-eth1-start[1239]: adding address 2001:db8:1::1/64... done machine # [ 26.004666] systemd[1]: Finished Address configuration of eth1. machine # [ 26.010251] systemd[1]: Reached target Remote File Systems. machine # [ 26.014834] systemd[1]: Starting linger-users.service... machine # [ 26.025374] systemd[1]: Reached target Local File Systems. machine # [ 26.030110] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.031575] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 26.033073] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 26.039699] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 26.046049] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 26.047356] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 26.057189] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 26.058880] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.063484] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.087667] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 26.090386] systemd[1]: Finished linger-users.service. machine # [ 26.242023] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 26.244822] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 26.502057] nixos[1152]: finished switching to system configuration /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.15 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 26.749689] nixos[1308]: switching to system configuration /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test machine # [ 26.752508] systemd[1]: Stopped target Local File Systems. machine # [ 26.755369] systemd[1]: Stopped target Remote File Systems. machine # [ 27.037446] systemd[1]: Reload requested from client PID 1308 ('.switch-to-conf') (unit backdoor.service)... machine # [ 27.039437] systemd[1]: Reloading... machine # [ 27.378351] systemd[1]: Reloading finished in 337 ms. machine # [ 27.474192] systemd[573]: Reexecution requested from client PID 1377 ('switch-to-confi')... machine # [ 27.475618] systemd[573]: Reexecuting. machine # [ 27.535652] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.656302] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.665193] systemd[573]: Reload requested from client PID 1377 ('switch-to-confi')... machine # [ 27.666646] systemd[573]: Reloading... machine # [ 27.788636] systemd[573]: Reloading finished in 120 ms. machine # [ 27.804276] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.815597] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 27.818365] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 27.820898] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 27.855460] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 27.860235] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 27.862754] systemd[1]: Stopping Reactivate sysinit units... machine # [ 27.863709] systemd[1]: Reached target Reactivate sysinit units. machine # [ 27.869420] systemd[1]: Reached target Remote File Systems. machine # [ 27.877790] systemd[1]: Starting linger-users.service... machine # [ 27.895485] systemd[1]: Reached target Local File Systems. machine # [ 27.902957] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 27.913872] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 27.914780] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 27.919497] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 27.929447] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 27.931151] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.943177] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.950115] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.951627] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 28.019080] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 28.025404] systemd[1]: Finished linger-users.service. machine # [ 28.202638] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 28.206677] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 28.462262] nixos[1308]: finished switching to system configuration /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.96 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 28.704797] nixos[1449]: switching to system configuration /nix/store/66dbaf8drh2qv8s77s8mh18j9kra7av5-nixos-system-machine-test machine # [ 28.709398] systemd[1]: Stopped target Remote File Systems. machine # [ 28.712133] systemd[1]: Stopped target Local File Systems. machine # [ 29.025265] systemd[1]: Reload requested from client PID 1449 ('.switch-to-conf') (unit backdoor.service)... machine # [ 29.027309] systemd[1]: Reloading... machine # [ 29.382757] systemd[1]: Reloading finished in 353 ms. machine # [ 29.475526] systemd[573]: Reexecution requested from client PID 1518 ('switch-to-confi')... machine # [ 29.478530] systemd[573]: Reexecuting. machine # [ 29.535625] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.657867] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.664890] systemd[573]: Reload requested from client PID 1518 ('switch-to-confi')... machine # [ 29.668900] systemd[573]: Reloading... machine # [ 29.782641] systemd[573]: Reloading finished in 114 ms. machine # [ 29.800190] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.809249] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 29.811651] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 29.813999] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 29.849449] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 29.853553] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 29.856518] systemd[1]: Stopping Reactivate sysinit units... machine # [ 29.857407] systemd[1]: Reached target Reactivate sysinit units. machine # [ 29.860460] systemd[1]: Reached target Remote File Systems. machine # [ 29.864195] systemd[1]: Starting linger-users.service... machine # [ 29.869070] systemd[1]: Starting test.service... machine # [ 29.886777] systemd[1]: Reached target Local File Systems. machine # [ 29.887764] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 29.900690] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 29.901650] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 29.909943] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 29.920527] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 29.927967] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.935066] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.942365] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.943880] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 29.952503] systemd[1]: Finished test.service. machine # [ 29.979221] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 29.983854] systemd[1]: Finished linger-users.service. machine # [ 30.125757] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 30.129022] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 30.389599] nixos[1449]: finished switching to system configuration /nix/store/66dbaf8drh2qv8s77s8mh18j9kra7av5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.93 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 30.667188] nixos[1591]: switching to system configuration /nix/store/66dbaf8drh2qv8s77s8mh18j9kra7av5-nixos-system-machine-test machine # [ 30.672734] systemd[1]: Stopped target Remote File Systems. machine # [ 30.673722] systemd[1]: Stopped target Local File Systems. machine # [ 30.956127] systemd[1]: Reload requested from client PID 1591 ('.switch-to-conf') (unit backdoor.service)... machine # [ 30.957871] systemd[1]: Reloading... machine # [ 31.311334] systemd[1]: Reloading finished in 351 ms. machine # [ 31.436508] systemd[573]: Reexecution requested from client PID 1660 ('switch-to-confi')... machine # [ 31.437985] systemd[573]: Reexecuting. machine # [ 31.499881] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.617347] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.624243] systemd[573]: Reload requested from client PID 1660 ('switch-to-confi')... machine # [ 31.626913] systemd[573]: Reloading... machine # [ 31.740848] systemd[573]: Reloading finished in 112 ms. machine # [ 31.756394] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.767474] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 31.770351] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 31.773011] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 31.809669] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 31.814658] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 31.817060] systemd[1]: Stopping Reactivate sysinit units... machine # [ 31.818043] systemd[1]: Reached target Reactivate sysinit units. machine # [ 31.825136] systemd[1]: Reached target Local File Systems. machine # [ 31.827965] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.830206] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 31.833118] systemd[1]: Reached target Remote File Systems. machine # [ 31.838322] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 31.847325] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 31.852447] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 31.853907] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 31.857495] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 31.859138] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.860701] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.036295] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 32.040260] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 32.043501] systemd[1]: Starting linger-users.service... machine # [ 32.085825] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 32.088447] systemd[1]: Finished linger-users.service. machine # [ 32.347092] nixos[1591]: finished switching to system configuration /nix/store/66dbaf8drh2qv8s77s8mh18j9kra7av5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.96 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 32.653072] nixos[1732]: switching to system configuration /nix/store/2fm46b0hjnbm592qv9ibcwifx4xmj0wg-nixos-system-machine-test machine # [ 32.656178] systemd[1]: Stopped target Local File Systems. machine # [ 32.658919] systemd[1]: Stopped target Remote File Systems. machine # [ 32.962078] systemd[1]: Reload requested from client PID 1732 ('.switch-to-conf') (unit backdoor.service)... machine # [ 32.964225] systemd[1]: Reloading... machine # [ 33.378051] systemd[1]: Reloading finished in 412 ms. machine # [ 33.471312] systemd[573]: Reexecution requested from client PID 1801 ('switch-to-confi')... machine # [ 33.475989] systemd[573]: Reexecuting. machine # [ 33.531212] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.647939] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.654438] systemd[573]: Reload requested from client PID 1801 ('switch-to-confi')... machine # [ 33.658610] systemd[573]: Reloading... machine # [ 33.771821] systemd[573]: Reloading finished in 114 ms. machine # [ 33.788206] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.798176] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 33.800609] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 33.803046] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 33.838604] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 33.842843] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 33.845811] systemd[1]: Stopping Reactivate sysinit units... machine # [ 33.846756] systemd[1]: Reached target Reactivate sysinit units. machine # [ 33.849350] systemd[1]: Reached target Local File Systems. machine # [ 33.852962] systemd[1]: Reached target Remote File Systems. machine # [ 33.856398] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.859865] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 33.866244] systemd[1]: Starting linger-users.service... machine # [ 33.879223] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 33.884245] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 33.885162] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 33.886483] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 33.896437] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 33.900973] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.908190] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.957085] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 33.958942] systemd[1]: Finished linger-users.service. machine # [ 34.114738] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 34.118517] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 34.375740] nixos[1732]: finished switching to system configuration /nix/store/2fm46b0hjnbm592qv9ibcwifx4xmj0wg-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 2.03 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 34.732258] nixos[1872]: switching to system configuration /nix/store/fbyc39dqamh37xihiajdl2q8sxb8bicn-nixos-system-machine-test machine # [ 34.735062] systemd[1]: test.service: Deactivated successfully. machine # [ 34.735987] systemd[1]: Stopped Test unit. machine # [ 34.738718] systemd[1]: Stopped target Local File Systems. machine # [ 34.739496] systemd[1]: Stopped target Remote File Systems. machine # [ 35.032846] systemd[1]: Reload requested from client PID 1872 ('.switch-to-conf') (unit backdoor.service)... machine # [ 35.034810] systemd[1]: Reloading... machine # [ 35.379838] systemd[1]: Reloading finished in 343 ms. machine # [ 35.475252] systemd[573]: Reexecution requested from client PID 1942 ('switch-to-confi')... machine # [ 35.479138] systemd[573]: Reexecuting. machine # [ 35.527913] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.649025] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.657320] systemd[573]: Reload requested from client PID 1942 ('switch-to-confi')... machine # [ 35.658897] systemd[573]: Reloading... machine # [ 35.781906] systemd[573]: Reloading finished in 120 ms. machine # [ 35.796306] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.807705] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 35.809074] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 35.811598] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 35.847594] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 35.852495] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 35.855827] systemd[1]: Stopping Reactivate sysinit units... machine # [ 35.857887] systemd[1]: Reached target Reactivate sysinit units. machine # [ 35.864122] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.871173] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 35.885787] systemd[1]: Starting test.service... machine # [ 35.886665] systemd[1]: Reached target Local File Systems. machine # [ 35.887483] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 35.901047] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 35.902061] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 35.903365] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 35.906755] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 35.915440] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.921751] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.926702] systemd[1]: Reached target Remote File Systems. machine # [ 35.939819] systemd[1]: Finished test.service. machine # [ 36.111579] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 36.116378] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 36.120909] systemd[1]: Starting linger-users.service... machine # [ 36.166654] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 36.169667] systemd[1]: Finished linger-users.service. machine # [ 36.428640] nixos[1872]: finished switching to system configuration /nix/store/fbyc39dqamh37xihiajdl2q8sxb8bicn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 2.05 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 36.750107] nixos[2015]: switching to system configuration /nix/store/hb6224q4069xw5wng9rddmckhna98vcz-nixos-system-machine-test machine # [ 36.752980] systemd[1]: Stopped target Local File Systems. machine # [ 36.755668] systemd[1]: Stopped target Remote File Systems. machine # [ 37.057819] systemd[1]: Reload requested from client PID 2015 ('.switch-to-conf') (unit backdoor.service)... machine # [ 37.059848] systemd[1]: Reloading... machine # [ 37.448950] systemd[1]: Reloading finished in 387 ms. machine # [ 37.537757] systemd[573]: Reexecution requested from client PID 2084 ('switch-to-confi')... machine # [ 37.542187] systemd[573]: Reexecuting. machine # [ 37.587687] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.708623] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.716549] systemd[573]: Reload requested from client PID 2084 ('switch-to-confi')... machine # [ 37.719351] systemd[573]: Reloading... machine # [ 37.836282] systemd[573]: Reloading finished in 115 ms. machine # [ 37.848263] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.863475] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 37.870313] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 37.871457] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 37.936315] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 37.945494] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 37.951278] systemd[1]: Stopping Reactivate sysinit units... machine # [ 37.954585] systemd[1]: Reached target Reactivate sysinit units. machine # [ 37.955582] systemd[1]: test.service: Deactivated successfully. machine # [ 37.961096] systemd[1]: Stopped test.service. machine # [ 37.963042] systemd[1]: Stopping test.service... machine # [ 37.967206] systemd[1]: Starting test.service... machine # [ 37.994501] systemd[1]: Finished test.service. machine # [ 38.000193] systemd[1]: Reached target Remote File Systems. machine # [ 38.006773] systemd[1]: Starting linger-users.service... machine # [ 38.007824] systemd[1]: Reached target Local File Systems. machine # [ 38.019448] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 38.028605] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 38.029607] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 38.030856] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 38.042705] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 38.047608] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.052297] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.058775] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.063659] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 38.111349] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 38.115382] systemd[1]: Finished linger-users.service. machine # [ 38.256099] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 38.259897] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.517180] nixos[2015]: finished switching to system configuration /nix/store/hb6224q4069xw5wng9rddmckhna98vcz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.09 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 38.814257] nixos[2158]: switching to system configuration /nix/store/vchdmyfrc15bic9b8q86lbv34b3yqczn-nixos-system-machine-test machine # [ 38.816783] systemd[1]: Stopped target Local File Systems. machine # [ 38.819177] systemd[1]: Stopped target Remote File Systems. machine # [ 39.109228] systemd[1]: Reload requested from client PID 2158 ('.switch-to-conf') (unit backdoor.service)... machine # [ 39.111239] systemd[1]: Reloading... machine # [ 39.455427] systemd[1]: Reloading finished in 342 ms. machine # [ 39.543808] systemd[573]: Reexecution requested from client PID 2227 ('switch-to-confi')... machine # [ 39.546635] systemd[573]: Reexecuting. machine # [ 39.599414] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.715623] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.722783] systemd[573]: Reload requested from client PID 2227 ('switch-to-confi')... machine # [ 39.725910] systemd[573]: Reloading... machine # [ 39.837088] systemd[573]: Reloading finished in 111 ms. machine # [ 39.852181] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.862718] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 39.863852] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 39.866607] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 39.902321] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 39.906613] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 39.908639] systemd[1]: Stopping Reactivate sysinit units... machine # [ 39.909636] systemd[1]: Reached target Reactivate sysinit units. machine # [ 39.915468] systemd[1]: Reloading test.service... machine # [ 39.945687] systemd[1]: Reloaded test.service. machine # [ 39.950803] systemd[1]: Reached target Local File Systems. machine # [ 39.953236] systemd[1]: Reached target Remote File Systems. machine # [ 39.958924] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 39.966279] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 39.967230] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 39.976842] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 39.979192] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 39.984947] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.986420] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.987630] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.989040] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 40.162798] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 40.167092] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 40.169428] systemd[1]: Starting linger-users.service... machine # [ 40.209420] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 40.212665] systemd[1]: Finished linger-users.service. machine # [ 40.471542] nixos[2158]: finished switching to system configuration /nix/store/vchdmyfrc15bic9b8q86lbv34b3yqczn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 1.95 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 40.777312] nixos[2300]: switching to system configuration /nix/store/k2l67iyjs5ln3zw4j84fhsvslw86awx2-nixos-system-machine-test machine # [ 40.780092] systemd[1]: Stopped target Local File Systems. machine # [ 40.783080] systemd[1]: Stopped target Remote File Systems. machine # [ 41.099277] systemd[1]: Reload requested from client PID 2300 ('.switch-to-conf') (unit backdoor.service)... machine # [ 41.101600] systemd[1]: Reloading... machine # [ 41.462389] systemd[1]: Reloading finished in 358 ms. machine # [ 41.588434] systemd[573]: Reexecution requested from client PID 2369 ('switch-to-confi')... machine # [ 41.591928] systemd[573]: Reexecuting. machine # [ 41.647490] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.765166] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.771406] systemd[573]: Reload requested from client PID 2369 ('switch-to-confi')... machine # [ 41.773793] systemd[573]: Reloading... machine # [ 41.882890] systemd[573]: Reloading finished in 108 ms. machine # [ 41.896169] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.905293] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 41.907621] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 41.909733] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 41.939643] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 41.943535] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 41.946070] systemd[1]: Stopping Reactivate sysinit units... machine # [ 41.946945] systemd[1]: Reached target Reactivate sysinit units. machine # [ 41.948601] systemd[1]: Reached target Local File Systems. machine # [ 41.952697] systemd[1]: Reached target Remote File Systems. machine # [ 41.956816] systemd[1]: Starting linger-users.service... machine # [ 41.961553] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 41.965307] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 41.966241] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 41.967457] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 41.984560] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 41.986237] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.987498] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.989070] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.990395] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 42.048678] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 42.050360] systemd[1]: Finished linger-users.service. machine # [ 42.190730] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 42.194156] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 42.452904] nixos[2300]: finished switching to system configuration /nix/store/k2l67iyjs5ln3zw4j84fhsvslw86awx2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.98 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.33 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 42.995213] nixos[2451]: switching to system configuration /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test machine # [ 42.998128] systemd[1]: Stopped target Remote File Systems. machine # [ 43.001567] systemd[1]: test.service: Deactivated successfully. machine # [ 43.003051] systemd[1]: Stopped test.service. machine # [ 43.003696] systemd[1]: Stopped target Local File Systems. machine # [ 43.259372] systemd[1]: Reload requested from client PID 2451 ('.switch-to-conf') (unit backdoor.service)... machine # [ 43.261417] systemd[1]: Reloading... machine # [ 43.583935] systemd[1]: Reloading finished in 321 ms. machine # [ 43.672224] systemd[573]: Reexecution requested from client PID 2520 ('switch-to-confi')... machine # [ 43.673630] systemd[573]: Reexecuting. machine # [ 43.727353] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.843804] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.851497] systemd[573]: Reload requested from client PID 2520 ('switch-to-confi')... machine # [ 43.854488] systemd[573]: Reloading... machine # [ 43.964089] systemd[573]: Reloading finished in 110 ms. machine # [ 43.976165] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.987212] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 43.988306] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 43.990488] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 44.023845] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 44.028532] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 44.029567] systemd[1]: Stopping Reactivate sysinit units... machine # [ 44.030375] systemd[1]: Reached target Reactivate sysinit units. machine # [ 44.034438] systemd[1]: Reached target Local File Systems. machine # [ 44.038081] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 44.042917] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 44.043871] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 44.052998] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 44.055260] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 44.063464] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.064954] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.066227] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.067535] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 44.069578] systemd[1]: Reached target Remote File Systems. machine # [ 44.229115] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 44.231389] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 44.236357] systemd[1]: Starting linger-users.service... machine # [ 44.278717] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 44.281493] systemd[1]: Finished linger-users.service. machine # [ 44.540000] nixos[2451]: finished switching to system configuration /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.76 seconds) machine: must succeed: /nix/store/vsm5222hf84gsamvgxhqv957gwq8qrmf-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 44.835768] nixos[2591]: switching to system configuration /nix/store/pkn25jh8avq4423rgi6gw91anclzg2qq-nixos-system-machine-test machine # [ 44.838443] systemd[1]: Stopped target Remote File Systems. machine # [ 44.840786] systemd[1]: Stopped target Local File Systems. machine # [ 45.163822] systemd[1]: Reload requested from client PID 2591 ('.switch-to-conf') (unit backdoor.service)... machine # [ 45.165972] systemd[1]: Reloading... machine # [ 45.510895] systemd[1]: Reloading finished in 343 ms. machine # [ 45.610360] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 45.614698] systemd[573]: Reexecution requested from client PID 2661 ('switch-to-confi')... machine # [ 45.617157] systemd[573]: Reexecuting. machine # [ 45.672715] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.801246] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.808582] systemd[573]: Reload requested from client PID 2661 ('switch-to-confi')... machine # [ 45.810031] systemd[573]: Reloading... machine # [ 45.930933] systemd[573]: Reloading finished in 119 ms. machine # [ 45.948210] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.959324] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 45.962572] systemd[1]: Stopping Reactivate sysinit units... machine # [ 45.963482] systemd[1]: Reached target Reactivate sysinit units. machine # [ 45.966013] systemd[1]: Reached target Local File Systems. machine # [ 45.966963] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.970135] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 45.974712] systemd[1]: Reached target Remote File Systems. machine # [ 45.981093] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 45.987428] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 45.989183] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 45.990496] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 45.992886] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 45.994514] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.995776] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.181680] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 46.186808] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 46.190451] systemd[1]: Starting linger-users.service... machine # [ 46.193392] systemd[1]: Starting test.service... machine # [ 46.235822] systemd[1]: Finished test.service. machine # [ 46.259890] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 46.262049] systemd[1]: Finished linger-users.service. machine # [ 46.523492] nixos[2591]: finished switching to system configuration /nix/store/pkn25jh8avq4423rgi6gw91anclzg2qq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vsm5222hf84gsamvgxhqv957gwq8qrmf-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.98 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/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 46.875717] nixos[2740]: switching to system configuration /nix/store/ixd7vkpscb2qn3a0mfn3wjgv6hc9mivq-nixos-system-machine-test machine # [ 46.878402] systemd[1]: Stopped target Remote File Systems. machine # [ 46.881002] systemd[1]: test.service: Deactivated successfully. machine # [ 46.881938] systemd[1]: Stopped test.service. machine # [ 46.883176] systemd[1]: Stopped target Local File Systems. machine # [ 47.181910] systemd[1]: Reload requested from client PID 2740 ('.switch-to-conf') (unit backdoor.service)... machine # [ 47.183894] systemd[1]: Reloading... machine # [ 47.519099] systemd[1]: Reloading finished in 333 ms. machine # [ 47.606946] systemd[573]: Reexecution requested from client PID 2809 ('switch-to-confi')... machine # [ 47.609744] systemd[573]: Reexecuting. machine # [ 47.667635] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.791554] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.798024] systemd[573]: Reload requested from client PID 2809 ('switch-to-confi')... machine # [ 47.800295] systemd[573]: Reloading... machine # [ 47.911261] systemd[573]: Reloading finished in 110 ms. machine # [ 47.928201] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.938169] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 47.972164] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 47.976168] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 47.977188] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 47.979738] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 47.985342] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 47.986338] systemd[1]: Stopping Reactivate sysinit units... machine # [ 47.987124] systemd[1]: Reached target Reactivate sysinit units. machine # [ 47.999228] systemd[1]: Started test.service. machine # [ 48.004169] systemd[1]: Reached target Local File Systems. machine # [ 48.008277] systemd[1]: Reached target Remote File Systems. machine # [ 48.025496] systemd[1]: Starting linger-users.service... machine # [ 48.046212] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 48.057267] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 48.058370] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 48.059193] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 48.066819] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 48.081178] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 48.082830] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.089975] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.091252] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.100158] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 48.101608] systemd[1]: test.service: Deactivated successfully. machine # [ 48.136956] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 48.140005] systemd[1]: Finished linger-users.service. machine # [ 48.283815] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 48.287100] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 48.543769] nixos[2740]: finished switching to system configuration /nix/store/ixd7vkpscb2qn3a0mfn3wjgv6hc9mivq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.93 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 48.845431] nixos[2885]: switching to system configuration /nix/store/ayl8qk2992flsw39izmpzm1wh92kn8sd-nixos-system-machine-test machine # [ 48.849080] systemd[1]: Stopped target Remote File Systems. machine # [ 48.851451] systemd[1]: Stopped target Local File Systems. machine # [ 49.142170] systemd[1]: Reload requested from client PID 2885 ('.switch-to-conf') (unit backdoor.service)... machine # [ 49.144246] systemd[1]: Reloading... machine # [ 49.487727] systemd[1]: Reloading finished in 341 ms. machine # [ 49.577147] systemd[573]: Reexecution requested from client PID 2954 ('switch-to-confi')... machine # [ 49.581091] systemd[573]: Reexecuting. machine # [ 49.639983] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.759310] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.766344] systemd[573]: Reload requested from client PID 2954 ('switch-to-confi')... machine # [ 49.770475] systemd[573]: Reloading... machine # [ 49.883950] systemd[573]: Reloading finished in 115 ms. machine # [ 49.900188] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.910553] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 49.913053] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 49.915418] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 49.949900] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 49.953589] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 49.956004] systemd[1]: Stopping Reactivate sysinit units... machine # [ 49.957409] systemd[1]: Reached target Reactivate sysinit units. machine # [ 49.960817] systemd[1]: Reached target Local File Systems. machine # [ 49.964788] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 49.970179] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 49.971125] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 49.981171] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 49.983493] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 49.989503] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.990855] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.992338] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.994312] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 49.995636] systemd[1]: Reached target Remote File Systems. machine # [ 50.159445] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 50.164973] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 50.168190] systemd[1]: Starting escaped\x2ddash.service... machine # [ 50.171426] systemd[1]: Starting linger-users.service... machine # [ 50.212920] systemd[1]: Finished escaped\x2ddash.service. machine # [ 50.232320] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 50.234830] systemd[1]: Finished linger-users.service. machine # [ 50.495578] nixos[2885]: finished switching to system configuration /nix/store/ayl8qk2992flsw39izmpzm1wh92kn8sd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 1.95 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 50.805501] nixos[3027]: switching to system configuration /nix/store/cqcc5nlr00vgv13yf6l8in2qykbj3yba-nixos-system-machine-test machine # [ 50.808400] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 50.812091] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 50.813895] systemd[1]: Stopped target Remote File Systems. machine # [ 50.815004] systemd[1]: Stopped target Local File Systems. machine # [ 51.113131] systemd[1]: Reload requested from client PID 3027 ('.switch-to-conf') (unit backdoor.service)... machine # [ 51.115138] systemd[1]: Reloading... machine # [ 51.469250] systemd[1]: Reloading finished in 351 ms. machine # [ 51.555585] systemd[573]: Reexecution requested from client PID 3096 ('switch-to-confi')... machine # [ 51.559318] systemd[573]: Reexecuting. machine # [ 51.607158] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.733082] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.739793] systemd[573]: Reload requested from client PID 3096 ('switch-to-confi')... machine # [ 51.743344] systemd[573]: Reloading... machine # [ 51.855698] systemd[573]: Reloading finished in 113 ms. machine # [ 51.872170] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.882423] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 51.883480] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 51.885995] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 51.916872] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 51.921167] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 51.923882] systemd[1]: Stopping Reactivate sysinit units... machine # [ 51.927502] systemd[1]: Reached target Reactivate sysinit units. machine # [ 51.928777] systemd[1]: Reached target Local File Systems. machine # [ 51.930800] systemd[1]: Starting escaped\x2ddash.service... machine # [ 51.942015] systemd[1]: Reached target Remote File Systems. machine # [ 51.945574] systemd[1]: Starting linger-users.service... machine # [ 51.952532] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.953919] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 51.966066] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 51.980555] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 51.983052] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 51.987525] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 51.996576] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 51.998249] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.999465] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.013595] systemd[1]: Finished escaped\x2ddash.service. machine # [ 52.044939] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 52.048120] systemd[1]: Finished linger-users.service. machine # [ 52.194042] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 52.197167] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 52.456499] nixos[3027]: finished switching to system configuration /nix/store/cqcc5nlr00vgv13yf6l8in2qykbj3yba-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 1.96 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 52.811527] nixos[3169]: switching to system configuration /nix/store/dcgf9h247w0f4fp9ciqbz5f9j6bxybzk-nixos-system-machine-test machine # [ 52.815056] systemd[1]: Stopped target Local File Systems. machine # [ 52.817105] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 52.820502] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 52.822302] systemd[1]: Stopped target Remote File Systems. machine # [ 53.119622] systemd[1]: Reload requested from client PID 3169 ('.switch-to-conf') (unit backdoor.service)... machine # [ 53.121771] systemd[1]: Reloading... machine # [ 53.462232] systemd[1]: Reloading finished in 339 ms. machine # [ 53.552106] systemd[573]: Reexecution requested from client PID 3238 ('switch-to-confi')... machine # [ 53.553529] systemd[573]: Reexecuting. machine # [ 53.615542] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.735162] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.741547] systemd[573]: Reload requested from client PID 3238 ('switch-to-confi')... machine # [ 53.745089] systemd[573]: Reloading... machine # [ 53.854387] systemd[573]: Reloading finished in 110 ms. machine # [ 53.868162] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.877036] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 53.879305] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 53.881443] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 53.912090] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 53.915506] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 53.917969] systemd[1]: Stopping Reactivate sysinit units... machine # [ 53.918845] systemd[1]: Reached target Reactivate sysinit units. machine # [ 53.921601] systemd[1]: Reached target Local File Systems. machine # [ 53.926345] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 53.929882] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 53.930796] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 53.937861] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 53.949965] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 53.951591] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.953135] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.954413] systemd[1]: Reached target Remote File Systems. machine # [ 53.955198] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.956510] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 54.144882] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 54.150376] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 54.154526] systemd[1]: Starting -.service... machine # [ 54.158167] systemd[1]: Starting linger-users.service... machine # [ 54.204190] systemd[1]: Finished -.service. machine # [ 54.226713] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 54.229847] systemd[1]: Finished linger-users.service. machine # [ 54.490416] nixos[3169]: finished switching to system configuration /nix/store/dcgf9h247w0f4fp9ciqbz5f9j6bxybzk-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 2.03 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 54.797809] nixos[3311]: switching to system configuration /nix/store/bl6bj35qmbnnvym6gm3495fifd2aq6yd-nixos-system-machine-test machine # [ 54.800790] systemd[1]: Stopped target Remote File Systems. machine # [ 54.802697] systemd[1]: Stopped target Local File Systems. machine # [ 55.098297] systemd[1]: Reload requested from client PID 3311 ('.switch-to-conf') (unit backdoor.service)... machine # [ 55.100359] systemd[1]: Reloading... machine # [ 55.446876] systemd[1]: Reloading finished in 344 ms. machine # [ 55.537650] systemd[573]: Reexecution requested from client PID 3380 ('switch-to-confi')... machine # [ 55.542034] systemd[573]: Reexecuting. machine # [ 55.587244] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.706701] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.713677] systemd[573]: Reload requested from client PID 3380 ('switch-to-confi')... machine # [ 55.717653] systemd[573]: Reloading... machine # [ 55.832140] systemd[573]: Reloading finished in 115 ms. machine # [ 55.848285] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.858701] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 55.861384] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 55.863829] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 55.899056] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 55.903556] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 55.906132] systemd[1]: Stopping Reactivate sysinit units... machine # [ 55.907058] systemd[1]: Reached target Reactivate sysinit units. machine # [ 55.911971] systemd[1]: Reloading -.service... machine # [ 55.940381] systemd[1]: Reloaded -.service. machine # [ 55.944675] systemd[1]: Reached target Remote File Systems. machine # [ 55.950095] systemd[1]: Starting linger-users.service... machine # [ 55.962747] systemd[1]: Reached target Local File Systems. machine # [ 55.963791] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 55.972759] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 55.973750] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 55.975047] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 55.992821] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 55.994644] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.004244] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.008674] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.010204] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 56.056675] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 56.061212] systemd[1]: Finished linger-users.service. machine # [ 56.216878] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 56.218861] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 56.479311] nixos[3311]: finished switching to system configuration /nix/store/bl6bj35qmbnnvym6gm3495fifd2aq6yd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.99 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 56.799162] nixos[3453]: switching to system configuration /nix/store/s884r6mlyc0vy9swb9k8dm5049xndy4y-nixos-system-machine-test machine # [ 56.802221] systemd[1]: Stopped target Local File Systems. machine # [ 56.804655] systemd[1]: -.service: Deactivated successfully. machine # [ 56.805578] systemd[1]: Stopped -.service. machine # [ 56.807307] systemd[1]: Stopped target Remote File Systems. machine # [ 57.096678] systemd[1]: Reload requested from client PID 3453 ('.switch-to-conf') (unit backdoor.service)... machine # [ 57.098616] systemd[1]: Reloading... machine # [ 57.447767] systemd[1]: Reloading finished in 347 ms. machine # [ 57.536110] systemd[573]: Reexecution requested from client PID 3522 ('switch-to-confi')... machine # [ 57.540328] systemd[573]: Reexecuting. machine # [ 57.595567] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.715278] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.723219] systemd[573]: Reload requested from client PID 3522 ('switch-to-confi')... machine # [ 57.726464] systemd[573]: Reloading... machine # [ 57.837640] systemd[573]: Reloading finished in 112 ms. machine # [ 57.852189] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.861833] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 57.864098] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 57.866493] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 57.900949] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 57.905447] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 57.907460] systemd[1]: Stopping Reactivate sysinit units... machine # [ 57.912773] systemd[1]: Reached target Reactivate sysinit units. machine # [ 57.913675] systemd[1]: Reached target Local File Systems. machine # [ 57.914447] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 57.918035] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 57.918972] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 57.926623] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 57.935928] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 57.941259] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.942518] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.943725] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.946734] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 57.948112] systemd[1]: Reached target Remote File Systems. machine # [ 58.103606] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 58.108211] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 58.111172] systemd[1]: Starting linger-users.service... machine # [ 58.114942] systemd[1]: Starting required-service.service... machine # [ 58.117874] systemd[1]: Starting test-service.service... machine # [ 58.167892] systemd[1]: Finished required-service.service. machine # [ 58.170533] systemd[1]: Finished test-service.service. machine # [ 58.188755] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 58.191528] systemd[1]: Finished linger-users.service. machine # [ 58.450959] nixos[3453]: finished switching to system configuration /nix/store/s884r6mlyc0vy9swb9k8dm5049xndy4y-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.97 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 58.746473] nixos[3597]: switching to system configuration /nix/store/b74p785c4xci5k45wrjf0kfbq2a6hi7i-nixos-system-machine-test machine # [ 58.748949] systemd[1]: Stopped target Remote File Systems. machine # [ 58.752742] systemd[1]: required-service.service: Deactivated successfully. machine # [ 58.754497] systemd[1]: Stopped required-service.service. machine # [ 58.755274] systemd[1]: test-service.service: Deactivated successfully. machine # [ 58.757008] systemd[1]: Stopped test-service.service. machine # [ 58.758159] systemd[1]: Stopped target Local File Systems. machine # [ 59.039195] systemd[1]: Reload requested from client PID 3597 ('.switch-to-conf') (unit backdoor.service)... machine # [ 59.041248] systemd[1]: Reloading... machine # [ 59.382918] systemd[1]: Reloading finished in 340 ms. machine # [ 59.472395] systemd[573]: Reexecution requested from client PID 3666 ('switch-to-confi')... machine # [ 59.476754] systemd[573]: Reexecuting. machine # [ 59.532231] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.653435] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.659965] systemd[573]: Reload requested from client PID 3666 ('switch-to-confi')... machine # [ 59.662440] systemd[573]: Reloading... machine # [ 59.777246] systemd[573]: Reloading finished in 113 ms. machine # [ 59.792186] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.801187] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 59.803552] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 59.805827] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 59.836649] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 59.840138] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 59.842015] systemd[1]: Stopping Reactivate sysinit units... machine # [ 59.843310] systemd[1]: Reached target Reactivate sysinit units. machine # [ 59.845846] systemd[1]: Reached target Remote File Systems. machine # [ 59.851542] systemd[1]: Starting linger-users.service... machine # [ 59.856181] systemd[1]: Starting required-service.service... machine # [ 59.864940] systemd[1]: Starting test-service.service... machine # [ 59.880120] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.881585] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 59.884729] systemd[1]: Reached target Local File Systems. machine # [ 59.895545] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 59.906624] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 59.912608] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 59.920164] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 59.931603] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 59.944435] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.950276] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.951594] systemd[1]: Finished test-service.service. machine # [ 59.956642] systemd[1]: Finished required-service.service. machine # [ 59.985280] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 59.986946] systemd[1]: Finished linger-users.service. machine # [ 60.128275] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 60.131610] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 60.389079] nixos[3597]: finished switching to system configuration /nix/store/b74p785c4xci5k45wrjf0kfbq2a6hi7i-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.94 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 60.702513] nixos[3741]: switching to system configuration /nix/store/a1dz9cpg95yb493hmrdwlf2v6pns567v-nixos-system-machine-test machine # [ 60.705316] systemd[1]: required-service.service: Deactivated successfully. machine # [ 60.709169] systemd[1]: Stopped required-service.service. machine # [ 60.710053] systemd[1]: test-service.service: Deactivated successfully. machine # [ 60.710994] systemd[1]: Stopped test-service.service. machine # [ 60.711738] systemd[1]: Stopped target Local File Systems. machine # [ 60.712820] systemd[1]: Stopped target Remote File Systems. machine # [ 61.015819] systemd[1]: Reload requested from client PID 3741 ('.switch-to-conf') (unit backdoor.service)... machine # [ 61.018252] systemd[1]: Reloading... machine # [ 61.394533] systemd[1]: Reloading finished in 374 ms. machine # [ 61.488484] systemd[573]: Reexecution requested from client PID 3810 ('switch-to-confi')... machine # [ 61.490012] systemd[573]: Reexecuting. machine # [ 61.547562] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.669152] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.675941] systemd[573]: Reload requested from client PID 3810 ('switch-to-confi')... machine # [ 61.678346] systemd[573]: Reloading... machine # [ 61.799351] systemd[573]: Reloading finished in 118 ms. machine # [ 61.814335] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.821875] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 61.824076] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 61.826520] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 61.862102] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 61.866248] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 61.869937] systemd[1]: Stopping Reactivate sysinit units... machine # [ 61.870873] systemd[1]: Reached target Reactivate sysinit units. machine # [ 61.873593] systemd[1]: Reached target Local File Systems. machine # [ 61.878593] systemd[1]: Starting required-service.service... machine # [ 61.887738] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 61.896479] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 61.897443] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 61.898688] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 61.916114] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 61.917941] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.924146] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.925553] systemd[1]: Reached target Remote File Systems. machine # [ 61.928652] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.935587] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 61.938087] systemd[1]: Finished required-service.service. machine # [ 62.103417] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 62.105682] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 62.112165] systemd[1]: Starting linger-users.service... machine # [ 62.114901] systemd[1]: Starting test-service.service... machine # [ 62.156760] systemd[1]: Finished test-service.service. machine # [ 62.176755] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 62.179470] systemd[1]: Finished linger-users.service. machine # [ 62.439207] nixos[3741]: finished switching to system configuration /nix/store/a1dz9cpg95yb493hmrdwlf2v6pns567v-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 2.05 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 62.753120] nixos[3885]: switching to system configuration /nix/store/lwqp7m90f076qn8a4m2nlbymvyh3ml1l-nixos-system-machine-test machine # [ 62.756145] systemd[1]: Stopped target Local File Systems. machine # [ 62.759911] systemd[1]: Stopped target Remote File Systems. machine # [ 62.761927] systemd[1]: required-service.service: Deactivated successfully. machine # [ 62.762974] systemd[1]: Stopped required-service.service. machine # [ 62.763758] systemd[1]: test-service.service: Deactivated successfully. machine # [ 62.764988] systemd[1]: Stopped test-service.service. machine # [ 63.070779] systemd[1]: Reload requested from client PID 3885 ('.switch-to-conf') (unit backdoor.service)... machine # [ 63.073028] systemd[1]: Reloading... machine # [ 63.431542] systemd[1]: Reloading finished in 357 ms. machine # [ 63.524732] systemd[573]: Reexecution requested from client PID 3954 ('switch-to-confi')... machine # [ 63.529142] systemd[573]: Reexecuting. machine # [ 63.588159] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.709914] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.716857] systemd[573]: Reload requested from client PID 3954 ('switch-to-confi')... machine # [ 63.720105] systemd[573]: Reloading... machine # [ 63.838298] systemd[573]: Reloading finished in 118 ms. machine # [ 63.852213] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.863109] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 63.865708] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 63.868134] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 63.904513] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 63.908792] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 63.911218] systemd[1]: Stopping Reactivate sysinit units... machine # [ 63.913074] systemd[1]: Reached target Reactivate sysinit units. machine # [ 63.915990] systemd[1]: Created slice Slice /system/instantiated. machine # [ 63.919605] systemd[1]: Reached target Remote File Systems. machine # [ 63.922949] systemd[1]: Starting instantiated@one.service... machine # [ 63.926496] systemd[1]: Starting instantiated@two.service... machine # [ 63.932961] systemd[1]: Starting linger-users.service... machine # [ 63.951164] systemd[1]: Reached target Local File Systems. machine # [ 63.956874] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 63.958471] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 63.959288] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 63.977968] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 63.988437] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 64.000095] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.008415] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.020634] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.022536] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 64.027197] systemd[1]: Finished instantiated@two.service. machine # [ 64.029835] systemd[1]: Finished instantiated@one.service. machine # [ 64.055387] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 64.059751] systemd[1]: Finished linger-users.service. machine # [ 64.201977] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 64.205163] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 64.466072] nixos[3885]: finished switching to system configuration /nix/store/lwqp7m90f076qn8a4m2nlbymvyh3ml1l-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 2.02 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 64.793741] nixos[4029]: switching to system configuration /nix/store/kysq67ha7ckh5dd7swpyg2k8cwq3zgm7-nixos-system-machine-test machine # [ 64.796356] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 64.800158] systemd[1]: Stopped instantiated@two.service. machine # [ 64.801063] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 64.802012] systemd[1]: Stopped instantiated@one.service. machine # [ 64.802772] systemd[1]: Stopped target Remote File Systems. machine # [ 64.804110] systemd[1]: Stopped target Local File Systems. machine # [ 65.106480] systemd[1]: Reload requested from client PID 4029 ('.switch-to-conf') (unit backdoor.service)... machine # [ 65.108553] systemd[1]: Reloading... machine # [ 65.471051] systemd[1]: Reloading finished in 359 ms. machine # [ 65.560450] systemd[573]: Reexecution requested from client PID 4098 ('switch-to-confi')... machine # [ 65.563724] systemd[573]: Reexecuting. machine # [ 65.619731] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.741141] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.747720] systemd[573]: Reload requested from client PID 4098 ('switch-to-confi')... machine # [ 65.751554] systemd[573]: Reloading... machine # [ 65.867492] systemd[573]: Reloading finished in 116 ms. machine # [ 65.884183] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.893523] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 65.896048] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 65.898268] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 65.934673] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 65.939122] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 65.940465] systemd[1]: Stopping Reactivate sysinit units... machine # [ 65.941348] systemd[1]: Reached target Reactivate sysinit units. machine # [ 65.947177] systemd[1]: Starting instantiated@one.service... machine # [ 65.956463] systemd[1]: Reached target Remote File Systems. machine # [ 65.960460] systemd[1]: Starting instantiated@two.service... machine # [ 65.965722] systemd[1]: Starting linger-users.service... machine # [ 65.981724] systemd[1]: Reached target Local File Systems. machine # [ 65.983876] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 65.995542] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 66.006119] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 66.007410] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 66.024268] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 66.025976] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.027234] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.043964] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.051249] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 66.057638] systemd[1]: Finished instantiated@two.service. machine # [ 66.058509] systemd[1]: Finished instantiated@one.service. machine # [ 66.091813] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 66.095988] systemd[1]: Finished linger-users.service. machine # [ 66.243366] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 66.246797] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 66.503634] nixos[4029]: finished switching to system configuration /nix/store/kysq67ha7ckh5dd7swpyg2k8cwq3zgm7-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 2.04 seconds) (finished: subtest: services, in 42.15 seconds) subtest: failing units machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 66.789449] nixos[4173]: switching to system configuration /nix/store/fbyc39dqamh37xihiajdl2q8sxb8bicn-nixos-system-machine-test machine # [ 66.792093] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 66.795375] systemd[1]: Stopped instantiated@one.service. machine # [ 66.798290] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 66.799342] systemd[1]: Stopped instantiated@two.service. machine # [ 66.800742] systemd[1]: Stopped target Remote File Systems. machine # [ 66.801603] systemd[1]: Stopped target Local File Systems. machine # [ 67.090228] systemd[1]: Reload requested from client PID 4173 ('.switch-to-conf') (unit backdoor.service)... machine # [ 67.092256] systemd[1]: Reloading... machine # [ 67.423512] systemd[1]: Reloading finished in 329 ms. machine # [ 67.514480] systemd[573]: Reexecution requested from client PID 4242 ('switch-to-confi')... machine # [ 67.518473] systemd[573]: Reexecuting. machine # [ 67.571403] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.692156] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.699334] systemd[573]: Reload requested from client PID 4242 ('switch-to-confi')... machine # [ 67.701960] systemd[573]: Reloading... machine # [ 67.821243] systemd[573]: Reloading finished in 118 ms. machine # [ 67.836191] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.845674] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 67.848156] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 67.850498] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 67.881822] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 67.885613] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 67.888694] systemd[1]: Stopping Reactivate sysinit units... machine # [ 67.889630] systemd[1]: Reached target Reactivate sysinit units. machine # [ 67.890522] systemd[1]: Reached target Remote File Systems. machine # [ 67.892653] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.894041] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 67.897800] systemd[1]: Reached target Local File Systems. machine # [ 67.903189] systemd[1]: Starting linger-users.service... machine # [ 67.907756] systemd[1]: Starting test.service... machine # [ 67.925053] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 67.936994] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 67.938031] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 67.939299] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 67.948810] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 67.950535] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.962501] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.983316] systemd[1]: Finished test.service. machine # [ 68.017678] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 68.022115] systemd[1]: Finished linger-users.service. machine # [ 68.164395] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 68.167881] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 68.430118] nixos[4173]: finished switching to system configuration /nix/store/fbyc39dqamh37xihiajdl2q8sxb8bicn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.92 seconds) machine: must fail: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 68.739477] nixos[4315]: switching to system configuration /nix/store/5z903alfz8whjpxvjjgy0v4g14cnv0xi-nixos-system-machine-test machine # [ 68.742675] systemd[1]: test.service: Deactivated successfully. machine # [ 68.746596] systemd[1]: Stopped test.service. machine # [ 68.748205] systemd[1]: Stopped target Remote File Systems. machine # [ 68.749066] systemd[1]: Stopped target Local File Systems. machine # [ 69.050088] systemd[1]: Reload requested from client PID 4315 ('.switch-to-conf') (unit backdoor.service)... machine # [ 69.052191] systemd[1]: Reloading... machine # [ 69.403787] systemd[1]: Reloading finished in 350 ms. machine # [ 69.492092] systemd[573]: Reexecution requested from client PID 4384 ('switch-to-confi')... machine # [ 69.496538] systemd[573]: Reexecuting. machine # [ 69.543470] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.662030] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.668563] systemd[573]: Reload requested from client PID 4384 ('switch-to-confi')... machine # [ 69.671136] systemd[573]: Reloading... machine # [ 69.782954] systemd[573]: Reloading finished in 110 ms. machine # [ 69.800189] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.810524] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 69.812853] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 69.815060] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 69.851470] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 69.856776] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 69.858019] systemd[1]: Stopping Reactivate sysinit units... machine # [ 69.858908] systemd[1]: Reached target Reactivate sysinit units. machine # [ 69.867060] systemd[1]: Starting test.service... machine # [ 69.877329] systemd[1]: Reached target Local File Systems. machine # [ 69.882423] systemd[1]: Reached target Remote File Systems. machine # [ 69.885080] systemd[1]: Starting linger-users.service... machine # [ 69.902420] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 69.912597] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 69.913634] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 69.914870] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 69.932184] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 69.934022] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.943449] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.951457] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.958145] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 69.959531] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 69.967235] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 69.972642] systemd[1]: Failed to start test.service. machine # [ 70.009801] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 70.014844] systemd[1]: Finished linger-users.service. machine # [ 70.163563] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 70.166686] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.467465] nixos[4315]: switching to system configuration /nix/store/5z903alfz8whjpxvjjgy0v4g14cnv0xi-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 2.04 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 70.760003] nixos[4458]: switching to system configuration /nix/store/sv89b4pay1wkwwyl0vvlc8fxn8zl2vsn-nixos-system-machine-test machine # [ 70.762812] systemd[1]: Stopped target Remote File Systems. machine # [ 70.764906] systemd[1]: Stopped target Local File Systems. machine # [ 71.065532] systemd[1]: Reload requested from client PID 4458 ('.switch-to-conf') (unit backdoor.service)... machine # [ 71.067443] systemd[1]: Reloading... machine # [ 71.417644] systemd[1]: Reloading finished in 348 ms. machine # [ 71.500748] systemd[573]: Reexecution requested from client PID 4527 ('switch-to-confi')... machine # [ 71.504304] systemd[573]: Reexecuting. machine # [ 71.559684] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.681041] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.687754] systemd[573]: Reload requested from client PID 4527 ('switch-to-confi')... machine # [ 71.691713] systemd[573]: Reloading... machine # [ 71.804990] systemd[573]: Reloading finished in 113 ms. machine # [ 71.816225] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.825946] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 71.828544] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 71.830943] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 71.866857] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 71.871208] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 71.874045] systemd[1]: Stopping Reactivate sysinit units... machine # [ 71.874983] systemd[1]: Reached target Reactivate sysinit units. machine # [ 71.878463] systemd[1]: Reached target Local File Systems. machine # [ 71.882895] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 71.886706] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 71.887744] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 71.896526] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 71.898989] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 71.911900] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.913502] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.914783] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.916543] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 71.917994] systemd[1]: Reached target Remote File Systems. machine # [ 72.082280] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 72.087470] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 72.091631] systemd[1]: Started autorestart.service. machine # [ 72.095366] systemd[1]: Starting linger-users.service... machine # [ 72.137976] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 72.163729] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 72.165870] systemd[1]: Finished linger-users.service. machine # [ 72.423481] nixos[4458]: finished switching to system configuration /nix/store/sv89b4pay1wkwwyl0vvlc8fxn8zl2vsn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.95 seconds) machine # [ 72.469195] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 72.695728] nixos[4605]: switching to system configuration /nix/store/sv89b4pay1wkwwyl0vvlc8fxn8zl2vsn-nixos-system-machine-test machine # [ 72.698514] systemd[1]: Stopped target Remote File Systems. machine # [ 72.701221] systemd[1]: Stopped target Local File Systems. machine # [ 72.991395] systemd[1]: Reload requested from client PID 4605 ('.switch-to-conf') (unit backdoor.service)... machine # [ 72.993757] systemd[1]: Reloading... machine # [ 73.330940] systemd[1]: Reloading finished in 335 ms. machine # [ 73.422467] systemd[573]: Reexecution requested from client PID 4674 ('switch-to-confi')... machine # [ 73.427208] systemd[573]: Reexecuting. machine # [ 73.471661] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.591828] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.599198] systemd[573]: Reload requested from client PID 4674 ('switch-to-confi')... machine # [ 73.602849] systemd[573]: Reloading... machine # [ 73.720622] systemd[573]: Reloading finished in 118 ms. machine # [ 73.736225] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.745894] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 73.748510] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 73.750874] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 73.787266] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 73.791482] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 73.794981] systemd[1]: Stopping Reactivate sysinit units... machine # [ 73.795918] systemd[1]: Reached target Reactivate sysinit units. machine # [ 73.797843] systemd[1]: Reached target Local File Systems. machine # [ 73.801077] systemd[1]: Reached target Remote File Systems. machine # [ 73.808442] systemd[1]: Started autorestart.service. machine # [ 73.812582] systemd[1]: Starting linger-users.service... machine # [ 73.822019] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 73.823685] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 73.840075] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 73.841527] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 73.843712] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 73.851235] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.852683] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.853928] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.855254] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 73.893311] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 73.930091] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 73.932427] systemd[1]: Finished linger-users.service. machine # [ 74.081556] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 74.083505] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 74.345223] nixos[4605]: finished switching to system configuration /nix/store/sv89b4pay1wkwwyl0vvlc8fxn8zl2vsn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.88 seconds) machine # [ 74.417027] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 74.693996] nixos[4752]: switching to system configuration /nix/store/25filfwx0pc8278ccxkncciqz80v3j2k-nixos-system-machine-test machine # [ 74.696597] systemd[1]: Stopped target Local File Systems. machine # [ 74.698911] systemd[1]: Stopped target Remote File Systems. machine # [ 75.003588] systemd[1]: Reload requested from client PID 4752 ('.switch-to-conf') (unit backdoor.service)... machine # [ 75.005812] systemd[1]: Reloading... machine # [ 75.357818] systemd[1]: Reloading finished in 350 ms. machine # [ 75.447857] systemd[573]: Reexecution requested from client PID 4821 ('switch-to-confi')... machine # [ 75.450140] systemd[573]: Reexecuting. machine # [ 75.499854] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.619644] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.626619] systemd[573]: Reload requested from client PID 4821 ('switch-to-confi')... machine # [ 75.629190] systemd[573]: Reloading... machine # [ 75.747186] systemd[573]: Reloading finished in 117 ms. machine # [ 75.764187] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.775588] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 75.778266] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 75.780816] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 75.813621] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 75.818129] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 75.820934] systemd[1]: Stopping Reactivate sysinit units... machine # [ 75.821887] systemd[1]: Reached target Reactivate sysinit units. machine # [ 75.825119] systemd[1]: Reached target Remote File Systems. machine # [ 75.831730] systemd[1]: Started autorestart.service. machine # [ 75.837251] systemd[1]: Starting linger-users.service... machine # [ 75.856868] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.858447] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 75.859747] systemd[1]: Reached target Local File Systems. machine # [ 75.873901] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 75.879261] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 75.884488] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 75.885974] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 75.895858] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 75.905633] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.907225] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.914872] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 75.921327] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 75.947946] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 75.951450] systemd[1]: Finished linger-users.service. machine # [ 76.107698] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 76.110716] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 76.410706] nixos[4752]: switching to system configuration /nix/store/25filfwx0pc8278ccxkncciqz80v3j2k-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.99 seconds) (finished: subtest: failing units, in 9.91 seconds) subtest: unit file parser machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 76.684342] nixos[4895]: switching to system configuration /nix/store/hb6224q4069xw5wng9rddmckhna98vcz-nixos-system-machine-test machine # [ 76.687059] systemd[1]: Stopped target Local File Systems. machine # [ 76.689518] systemd[1]: Stopped target Remote File Systems. machine # [ 76.691193] systemd[1]: Stopped autorestart.service. machine # [ 76.974068] systemd[1]: Reload requested from client PID 4895 ('.switch-to-conf') (unit backdoor.service)... machine # [ 76.975677] systemd[1]: Reloading... machine # [ 77.337447] systemd[1]: Reloading finished in 360 ms. machine # [ 77.430457] systemd[573]: Reexecution requested from client PID 4964 ('switch-to-confi')... machine # [ 77.431914] systemd[573]: Reexecuting. machine # [ 77.487386] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.606500] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.612956] systemd[573]: Reload requested from client PID 4964 ('switch-to-confi')... machine # [ 77.615295] systemd[573]: Reloading... machine # [ 77.730247] systemd[573]: Reloading finished in 114 ms. machine # [ 77.744197] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.754213] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 77.755324] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 77.757931] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 77.788906] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 77.792659] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 77.795997] systemd[1]: Stopping Reactivate sysinit units... machine # [ 77.796988] systemd[1]: Reached target Reactivate sysinit units. machine # [ 77.800501] systemd[1]: Reached target Remote File Systems. machine # [ 77.804130] systemd[1]: Starting linger-users.service... machine # [ 77.807539] systemd[1]: Starting test.service... machine # [ 77.822211] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.823678] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 77.839165] systemd[1]: Reached target Local File Systems. machine # [ 77.845641] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 77.854605] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 77.859772] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 77.863638] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 77.870625] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 77.876342] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.879108] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.883559] systemd[1]: Finished test.service. machine # [ 77.921440] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 77.923896] systemd[1]: Finished linger-users.service. machine # [ 78.071274] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 78.074020] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 78.332913] nixos[4895]: finished switching to system configuration /nix/store/hb6224q4069xw5wng9rddmckhna98vcz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.92 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 78.602995] nixos[5037]: switching to system configuration /nix/store/sxw072v3x7jpdc1cxf6n7m6sx2bwlahs-nixos-system-machine-test machine # [ 78.606176] systemd[1]: Stopped target Remote File Systems. machine # [ 78.608830] systemd[1]: Stopped target Local File Systems. machine # [ 78.925691] systemd[1]: Reload requested from client PID 5037 ('.switch-to-conf') (unit backdoor.service)... machine # [ 78.927745] systemd[1]: Reloading... machine # [ 79.276293] systemd[1]: Reloading finished in 346 ms. machine # [ 79.371289] systemd[573]: Reexecution requested from client PID 5106 ('switch-to-confi')... machine # [ 79.373467] systemd[573]: Reexecuting. machine # [ 79.427192] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.547397] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.554024] systemd[573]: Reload requested from client PID 5106 ('switch-to-confi')... machine # [ 79.556545] systemd[573]: Reloading... machine # [ 79.664797] systemd[573]: Reloading finished in 107 ms. machine # [ 79.680179] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.689567] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 79.691973] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 79.694304] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 79.725175] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 79.728709] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 79.730744] systemd[1]: Stopping Reactivate sysinit units... machine # [ 79.731602] systemd[1]: Reached target Reactivate sysinit units. machine # [ 79.735303] systemd[1]: test.service: Deactivated successfully. machine # [ 79.738895] systemd[1]: Stopped test.service. machine # [ 79.739675] systemd[1]: Stopping test.service... machine # [ 79.740880] systemd[1]: Starting test.service... machine # [ 79.765532] systemd[1]: Finished test.service. machine # [ 79.768719] systemd[1]: Reached target Local File Systems. machine # [ 79.773645] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.777753] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 79.780188] systemd[1]: Reached target Remote File Systems. machine # [ 79.784492] systemd[1]: Starting linger-users.service... machine # [ 79.795881] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 79.804222] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 79.805222] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 79.806427] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 79.814292] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 79.815913] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.823989] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.864899] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 79.868421] systemd[1]: Finished linger-users.service. machine # [ 80.011741] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 80.013799] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 80.274219] nixos[5037]: finished switching to system configuration /nix/store/sxw072v3x7jpdc1cxf6n7m6sx2bwlahs-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.95 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 80.578508] nixos[5179]: switching to system configuration /nix/store/dhvyzl1xmvl6c9yk49rhj87mlh6klb0b-nixos-system-machine-test machine # [ 80.583941] systemd[1]: Stopped target Local File Systems. machine # [ 80.586332] systemd[1]: Stopped target Remote File Systems. machine # [ 80.879862] systemd[1]: Reload requested from client PID 5179 ('.switch-to-conf') (unit backdoor.service)... machine # [ 80.882035] systemd[1]: Reloading... machine # [ 81.233170] systemd[1]: Reloading finished in 349 ms. machine # [ 81.329817] systemd[573]: Reexecution requested from client PID 5248 ('switch-to-confi')... machine # [ 81.333648] systemd[573]: Reexecuting. machine # [ 81.391431] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.516176] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.522999] systemd[573]: Reload requested from client PID 5248 ('switch-to-confi')... machine # [ 81.526979] systemd[573]: Reloading... machine # [ 81.639967] systemd[573]: Reloading finished in 114 ms. machine # [ 81.656188] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.666095] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 81.668541] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 81.670812] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 81.704622] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 81.708987] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 81.710955] systemd[1]: Stopping Reactivate sysinit units... machine # [ 81.711834] systemd[1]: Reached target Reactivate sysinit units. machine # [ 81.716282] systemd[1]: test.service: Deactivated successfully. machine # [ 81.717213] systemd[1]: Stopped test.service. machine # [ 81.717898] systemd[1]: Stopping test.service... machine # [ 81.720439] systemd[1]: Starting test.service... machine # [ 81.745987] systemd[1]: Finished test.service. machine # [ 81.748745] systemd[1]: Reached target Local File Systems. machine # [ 81.751983] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.753890] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 81.759488] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 81.765804] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 81.766718] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 81.767944] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 81.779604] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 81.782457] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.783755] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.785082] systemd[1]: Reached target Remote File Systems. machine # [ 81.941798] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 81.946755] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 81.949236] systemd[1]: Starting linger-users.service... machine # [ 81.990588] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 81.992589] systemd[1]: Finished linger-users.service. machine # [ 82.249608] nixos[5179]: finished switching to system configuration /nix/store/dhvyzl1xmvl6c9yk49rhj87mlh6klb0b-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.97 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 82.481182] nixos[5321]: switching to system configuration /nix/store/hb6224q4069xw5wng9rddmckhna98vcz-nixos-system-machine-test machine # [ 82.484967] systemd[1]: Stopped target Local File Systems. machine # [ 82.487174] systemd[1]: Stopped target Remote File Systems. machine # [ 82.749955] systemd[1]: Reload requested from client PID 5321 ('.switch-to-conf') (unit backdoor.service)... machine # [ 82.751833] systemd[1]: Reloading... machine # [ 83.076916] systemd[1]: Reloading finished in 323 ms. machine # [ 83.166943] systemd[573]: Reexecution requested from client PID 5390 ('switch-to-confi')... machine # [ 83.170524] systemd[573]: Reexecuting. machine # [ 83.231678] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.355891] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.362606] systemd[573]: Reload requested from client PID 5390 ('switch-to-confi')... machine # [ 83.365143] systemd[573]: Reloading... machine # [ 83.477766] systemd[573]: Reloading finished in 111 ms. machine # [ 83.492180] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.502110] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 83.504441] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 83.506579] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 83.537036] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 83.540640] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 83.542946] systemd[1]: Stopping Reactivate sysinit units... machine # [ 83.543858] systemd[1]: Reached target Reactivate sysinit units. machine # [ 83.548764] systemd[1]: test.service: Deactivated successfully. machine # [ 83.549703] systemd[1]: Stopped test.service. machine # [ 83.550360] systemd[1]: Stopping test.service... machine # [ 83.551058] systemd[1]: Starting test.service... machine # [ 83.577836] systemd[1]: Finished test.service. machine # [ 83.582161] systemd[1]: Reached target Remote File Systems. machine # [ 83.587796] systemd[1]: Reached target Local File Systems. machine # [ 83.591213] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 83.595490] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 83.600576] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 83.601932] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 83.612378] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 83.614435] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.615825] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.617227] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.618753] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 83.805164] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 83.811009] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 83.813800] systemd[1]: Starting linger-users.service... machine # [ 83.863113] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 83.865143] systemd[1]: Finished linger-users.service. machine # [ 84.124966] nixos[5321]: finished switching to system configuration /nix/store/hb6224q4069xw5wng9rddmckhna98vcz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.88 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 84.441751] nixos[5463]: switching to system configuration /nix/store/mhn5p1ikhahp6bdaahb43753g74g2yqn-nixos-system-machine-test machine # [ 84.444356] systemd[1]: Stopped target Local File Systems. machine # [ 84.446834] systemd[1]: Stopped target Remote File Systems. machine # [ 84.745275] systemd[1]: Reload requested from client PID 5463 ('.switch-to-conf') (unit backdoor.service)... machine # [ 84.747266] systemd[1]: Reloading... machine # [ 85.095842] systemd[1]: Reloading finished in 346 ms. machine # [ 85.185753] systemd[573]: Reexecution requested from client PID 5532 ('switch-to-confi')... machine # [ 85.189942] systemd[573]: Reexecuting. machine # [ 85.248087] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.377433] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.384653] systemd[573]: Reload requested from client PID 5532 ('switch-to-confi')... machine # [ 85.387460] systemd[573]: Reloading... machine # [ 85.505363] systemd[573]: Reloading finished in 116 ms. machine # [ 85.520390] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.531774] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 85.534349] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 85.536554] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 85.570658] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 85.574429] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 85.577646] systemd[1]: Stopping Reactivate sysinit units... machine # [ 85.578568] systemd[1]: Reached target Reactivate sysinit units. machine # [ 85.580952] systemd[1]: Reached target Remote File Systems. machine # [ 85.585580] systemd[1]: Starting linger-users.service... machine # [ 85.595729] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.599012] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 85.601745] systemd[1]: Reached target Local File Systems. machine # [ 85.603876] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 85.611877] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 85.617355] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 85.624404] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 85.628689] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 85.630320] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.631558] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.677437] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 85.681853] systemd[1]: Finished linger-users.service. machine # [ 85.861338] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 85.864419] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 86.123172] nixos[5463]: finished switching to system configuration /nix/store/mhn5p1ikhahp6bdaahb43753g74g2yqn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 2.00 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 86.436557] nixos[5603]: switching to system configuration /nix/store/chh5b3q4zwljq0yp7yv8ia415kn90fkv-nixos-system-machine-test machine # [ 86.439483] systemd[1]: Stopped target Remote File Systems. machine # [ 86.442003] systemd[1]: Stopped target Local File Systems. machine # [ 86.738564] systemd[1]: Reload requested from client PID 5603 ('.switch-to-conf') (unit backdoor.service)... machine # [ 86.740601] systemd[1]: Reloading... machine # [ 87.081265] systemd[1]: Reloading finished in 339 ms. machine # [ 87.167581] systemd[573]: Reexecution requested from client PID 5672 ('switch-to-confi')... machine # [ 87.171242] systemd[573]: Reexecuting. machine # [ 87.227361] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.346658] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.353296] systemd[573]: Reload requested from client PID 5672 ('switch-to-confi')... machine # [ 87.355783] systemd[573]: Reloading... machine # [ 87.468956] systemd[573]: Reloading finished in 112 ms. machine # [ 87.484176] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.493085] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 87.495432] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 87.497618] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 87.528547] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 87.532826] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 87.533843] systemd[1]: Stopping Reactivate sysinit units... machine # [ 87.534621] systemd[1]: Reached target Reactivate sysinit units. machine # [ 87.539133] systemd[1]: test.service: Deactivated successfully. machine # [ 87.540459] systemd[1]: Stopped test.service. machine # [ 87.541155] systemd[1]: Stopping test.service... machine # [ 87.542892] systemd[1]: Starting test.service... machine # [ 87.572126] systemd[1]: Finished test.service. machine # [ 87.577660] systemd[1]: Reached target Remote File Systems. machine # [ 87.581081] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.584451] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 87.589962] systemd[1]: Starting linger-users.service... machine # [ 87.593210] systemd[1]: Reached target Local File Systems. machine # [ 87.602010] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 87.603632] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 87.610739] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 87.614973] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 87.617470] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 87.619028] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.623083] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.675013] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 87.677094] systemd[1]: Finished linger-users.service. machine # [ 87.814873] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 87.818312] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 88.076679] nixos[5603]: finished switching to system configuration /nix/store/chh5b3q4zwljq0yp7yv8ia415kn90fkv-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.95 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 88.387774] nixos[5745]: switching to system configuration /nix/store/jngl5b5bp2bs3zqwzz9qklxdzcwv0p1b-nixos-system-machine-test machine # [ 88.390307] systemd[1]: Stopped target Remote File Systems. machine # [ 88.392639] systemd[1]: Stopped target Local File Systems. machine # [ 88.695611] systemd[1]: Reload requested from client PID 5745 ('.switch-to-conf') (unit backdoor.service)... machine # [ 88.697883] systemd[1]: Reloading... machine # [ 89.094401] systemd[1]: Reloading finished in 394 ms. machine # [ 89.192536] systemd[573]: Reexecution requested from client PID 5814 ('switch-to-confi')... machine # [ 89.197129] systemd[573]: Reexecuting. machine # [ 89.256527] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.380197] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.387310] systemd[573]: Reload requested from client PID 5814 ('switch-to-confi')... machine # [ 89.391732] systemd[573]: Reloading... machine # [ 89.515509] systemd[573]: Reloading finished in 125 ms. machine # [ 89.532247] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.543786] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 89.545107] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 89.547644] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 89.583964] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 89.588610] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 89.590805] systemd[1]: Stopping Reactivate sysinit units... machine # [ 89.591779] systemd[1]: Reached target Reactivate sysinit units. machine # [ 89.596855] systemd[1]: test.service: Deactivated successfully. machine # [ 89.597806] systemd[1]: Stopped test.service. machine # [ 89.598440] systemd[1]: Stopping test.service... machine # [ 89.600419] systemd[1]: Starting test.service... machine # [ 89.629497] systemd[1]: Finished test.service. machine # [ 89.633288] systemd[1]: Reached target Local File Systems. machine # [ 89.637396] systemd[1]: Reached target Remote File Systems. machine # [ 89.639989] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.642350] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 89.651135] systemd[1]: Starting linger-users.service... machine # [ 89.660180] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 89.667748] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 89.673126] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 89.674470] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 89.681670] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 89.683474] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.685052] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.756685] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 89.759926] systemd[1]: Finished linger-users.service. machine # [ 89.901872] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 89.904703] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 90.163566] nixos[5745]: finished switching to system configuration /nix/store/jngl5b5bp2bs3zqwzz9qklxdzcwv0p1b-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 2.09 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 90.535723] nixos[5887]: switching to system configuration /nix/store/xkhxvbvxgj4w9dbg9w8zifvakzlx2zhx-nixos-system-machine-test machine # [ 90.538988] systemd[1]: Stopped target Local File Systems. machine # [ 90.542047] systemd[1]: Stopped target Remote File Systems. machine # [ 90.843302] systemd[1]: Reload requested from client PID 5887 ('.switch-to-conf') (unit backdoor.service)... machine # [ 90.845351] systemd[1]: Reloading... machine # [ 91.181587] systemd[1]: Reloading finished in 334 ms. machine # [ 91.269860] systemd[573]: Reexecution requested from client PID 5956 ('switch-to-confi')... machine # [ 91.274226] systemd[573]: Reexecuting. machine # [ 91.327524] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.443345] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.450033] systemd[573]: Reload requested from client PID 5956 ('switch-to-confi')... machine # [ 91.452538] systemd[573]: Reloading... machine # [ 91.564178] systemd[573]: Reloading finished in 110 ms. machine # [ 91.580185] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.590415] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 91.591484] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 91.594299] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 91.624101] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 91.627855] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 91.629699] systemd[1]: Stopping Reactivate sysinit units... machine # [ 91.630520] systemd[1]: Reached target Reactivate sysinit units. machine # [ 91.634410] systemd[1]: test.service: Deactivated successfully. machine # [ 91.635343] systemd[1]: Stopped test.service. machine # [ 91.635984] systemd[1]: Stopping test.service... machine # [ 91.638361] systemd[1]: Starting test.service... machine # [ 91.661465] systemd[1]: Finished test.service. machine # [ 91.667736] systemd[1]: Reached target Remote File Systems. machine # [ 91.673466] systemd[1]: Starting linger-users.service... machine # [ 91.682590] systemd[1]: Reached target Local File Systems. machine # [ 91.684770] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 91.692568] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 91.693485] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 91.694719] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 91.712242] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 91.713904] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.715176] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.723121] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.727086] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 91.758273] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 91.761540] systemd[1]: Finished linger-users.service. machine # [ 91.906685] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 91.909960] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 92.166801] nixos[5887]: finished switching to system configuration /nix/store/xkhxvbvxgj4w9dbg9w8zifvakzlx2zhx-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 2.00 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 92.442557] nixos[6029]: switching to system configuration /nix/store/hb6224q4069xw5wng9rddmckhna98vcz-nixos-system-machine-test machine # [ 92.445106] systemd[1]: Stopped target Remote File Systems. machine # [ 92.447507] systemd[1]: Stopped target Local File Systems. machine # [ 92.720908] systemd[1]: Reload requested from client PID 6029 ('.switch-to-conf') (unit backdoor.service)... machine # [ 92.722875] systemd[1]: Reloading... machine # [ 93.051466] systemd[1]: Reloading finished in 326 ms. machine # [ 93.140441] systemd[573]: Reexecution requested from client PID 6098 ('switch-to-confi')... machine # [ 93.144002] systemd[573]: Reexecuting. machine # [ 93.208905] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.331215] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.338062] systemd[573]: Reload requested from client PID 6098 ('switch-to-confi')... machine # [ 93.342059] systemd[573]: Reloading... machine # [ 93.460831] systemd[573]: Reloading finished in 119 ms. machine # [ 93.476175] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.487327] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 93.488456] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 93.490736] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 93.525179] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 93.529913] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 93.531250] systemd[1]: Stopping Reactivate sysinit units... machine # [ 93.533373] systemd[1]: Reached target Reactivate sysinit units. machine # [ 93.536485] systemd[1]: test.service: Deactivated successfully. machine # [ 93.537466] systemd[1]: Stopped test.service. machine # [ 93.538116] systemd[1]: Stopping test.service... machine # [ 93.541055] systemd[1]: Starting test.service... machine # [ 93.566501] systemd[1]: Finished test.service. machine # [ 93.571894] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.575969] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 93.579858] systemd[1]: Reached target Local File Systems. machine # [ 93.583051] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 93.590686] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 93.591584] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 93.596825] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 93.599120] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 93.604902] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.606292] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.607470] systemd[1]: Reached target Remote File Systems. machine # [ 93.779210] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 93.784515] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 93.786762] systemd[1]: Starting linger-users.service... machine # [ 93.830048] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 93.832844] systemd[1]: Finished linger-users.service. machine # [ 94.090840] nixos[6029]: finished switching to system configuration /nix/store/hb6224q4069xw5wng9rddmckhna98vcz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.92 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 94.383938] nixos[6171]: switching to system configuration /nix/store/9k7lm208rl7abm0wbdzlg61nr0ls67mi-nixos-system-machine-test machine # [ 94.386798] systemd[1]: Stopped target Remote File Systems. machine # [ 94.389121] systemd[1]: Stopped target Local File Systems. machine # [ 94.670918] systemd[1]: Reload requested from client PID 6171 ('.switch-to-conf') (unit backdoor.service)... machine # [ 94.672960] systemd[1]: Reloading... machine # [ 95.006713] systemd[1]: Reloading finished in 332 ms. machine # [ 95.103260] systemd[573]: Reexecution requested from client PID 6240 ('switch-to-confi')... machine # [ 95.106032] systemd[573]: Reexecuting. machine # [ 95.167585] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.285094] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.291730] systemd[573]: Reload requested from client PID 6240 ('switch-to-confi')... machine # [ 95.295247] systemd[573]: Reloading... machine # [ 95.409150] systemd[573]: Reloading finished in 115 ms. machine # [ 95.424169] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.432993] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 95.435268] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 95.437411] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 95.468590] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 95.472490] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 95.476443] systemd[1]: Stopping Reactivate sysinit units... machine # [ 95.477351] systemd[1]: Reached target Reactivate sysinit units. machine # [ 95.479692] systemd[1]: Reloading test.service... machine # [ 95.505748] systemd[1]: Reloaded test.service. machine # [ 95.510960] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.513968] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 95.518656] systemd[1]: Reached target Local File Systems. machine # [ 95.519533] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 95.528420] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 95.529347] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 95.530576] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 95.541948] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 95.543615] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.545076] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.546287] systemd[1]: Reached target Remote File Systems. machine # [ 95.704135] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 95.706944] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 95.711304] systemd[1]: Starting linger-users.service... machine # [ 95.757658] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 95.760933] systemd[1]: Finished linger-users.service. machine # [ 96.019608] nixos[6171]: finished switching to system configuration /nix/store/9k7lm208rl7abm0wbdzlg61nr0ls67mi-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.93 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 96.327707] nixos[6313]: switching to system configuration /nix/store/dw1zfwzay77jfmmd0y85dcrxsbqyxw0c-nixos-system-machine-test machine # [ 96.330584] systemd[1]: Stopped target Remote File Systems. machine # [ 96.333422] systemd[1]: Stopped target Local File Systems. machine # [ 96.657662] systemd[1]: Reload requested from client PID 6313 ('.switch-to-conf') (unit backdoor.service)... machine # [ 96.659637] systemd[1]: Reloading... machine # [ 97.006046] systemd[1]: Reloading finished in 344 ms. machine # [ 97.106451] systemd[573]: Reexecution requested from client PID 6382 ('switch-to-confi')... machine # [ 97.107901] systemd[573]: Reexecuting. machine # [ 97.163579] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 97.282076] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 97.288827] systemd[573]: Reload requested from client PID 6382 ('switch-to-confi')... machine # [ 97.292259] systemd[573]: Reloading... machine # [ 97.405054] systemd[573]: Reloading finished in 113 ms. machine # [ 97.420173] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 97.430575] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 97.433177] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 97.435441] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 97.468949] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 97.473011] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 97.476355] systemd[1]: Stopping Reactivate sysinit units... machine # [ 97.477274] systemd[1]: Reached target Reactivate sysinit units. machine # [ 97.480590] systemd[1]: Reloading test.service... machine # [ 97.506488] systemd[1]: Reloaded test.service. machine # [ 97.513450] systemd[1]: Reached target Remote File Systems. machine # [ 97.518260] systemd[1]: Starting linger-users.service... machine # [ 97.528533] systemd[1]: Reached target Local File Systems. machine # [ 97.529550] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 97.534930] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 97.535850] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 97.545046] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 97.547317] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 97.560818] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 97.562676] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 97.563862] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 97.573028] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 97.606815] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 97.610989] systemd[1]: Finished linger-users.service. machine # [ 97.754897] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 97.758486] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 98.015176] nixos[6313]: finished switching to system configuration /nix/store/dw1zfwzay77jfmmd0y85dcrxsbqyxw0c-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.99 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 98.316647] nixos[6455]: switching to system configuration /nix/store/a828i3w2bw0d7nfrvgsnzxbg7dvy21n8-nixos-system-machine-test machine # [ 98.319097] systemd[1]: Stopped target Local File Systems. machine # [ 98.321297] systemd[1]: Stopped target Remote File Systems. machine # [ 98.620491] systemd[1]: Reload requested from client PID 6455 ('.switch-to-conf') (unit backdoor.service)... machine # [ 98.622554] systemd[1]: Reloading... machine # [ 98.971432] systemd[1]: Reloading finished in 347 ms. machine # [ 99.061532] systemd[573]: Reexecution requested from client PID 6524 ('switch-to-confi')... machine # [ 99.065759] systemd[573]: Reexecuting. machine # [ 99.123605] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.243285] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.250347] systemd[573]: Reload requested from client PID 6524 ('switch-to-confi')... machine # [ 99.253875] systemd[573]: Reloading... machine # [ 99.365372] systemd[573]: Reloading finished in 112 ms. machine # [ 99.380168] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.390846] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 99.393112] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 99.395184] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 99.428666] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 99.432407] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 99.433721] systemd[1]: Stopping Reactivate sysinit units... machine # [ 99.434555] systemd[1]: Reached target Reactivate sysinit units. machine # [ 99.437266] systemd[1]: test.service: Deactivated successfully. machine # [ 99.440476] systemd[1]: Stopped test.service. machine # [ 99.441293] systemd[1]: Stopping test.service... machine # [ 99.444249] systemd[1]: Starting test.service... machine # [ 99.469320] systemd[1]: Finished test.service. machine # [ 99.474239] systemd[1]: Reached target Remote File Systems. machine # [ 99.477007] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.480693] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 99.484231] systemd[1]: Reached target Local File Systems. machine # [ 99.485094] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 99.496333] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 99.497328] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 99.498575] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 99.504262] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 99.505868] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.507179] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.672173] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 99.676304] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 99.679168] systemd[1]: Starting linger-users.service... machine # [ 99.722692] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 99.725772] systemd[1]: Finished linger-users.service. machine # [ 99.982935] nixos[6455]: finished switching to system configuration /nix/store/a828i3w2bw0d7nfrvgsnzxbg7dvy21n8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.97 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 100.261915] nixos[6597]: switching to system configuration /nix/store/chh5b3q4zwljq0yp7yv8ia415kn90fkv-nixos-system-machine-test machine # [ 100.264963] systemd[1]: Stopped target Local File Systems. machine # [ 100.267406] systemd[1]: Stopped target Remote File Systems. machine # [ 100.533025] systemd[1]: Reload requested from client PID 6597 ('.switch-to-conf') (unit backdoor.service)... machine # [ 100.535132] systemd[1]: Reloading... machine # [ 100.931195] systemd[1]: Reloading finished in 394 ms. machine # [ 101.020436] systemd[573]: Reexecution requested from client PID 6666 ('switch-to-confi')... machine # [ 101.021864] systemd[573]: Reexecuting. machine # [ 101.067254] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.181128] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.187617] systemd[573]: Reload requested from client PID 6666 ('switch-to-confi')... machine # [ 101.191480] systemd[573]: Reloading... machine # [ 101.301409] systemd[573]: Reloading finished in 111 ms. machine # [ 101.316188] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.325904] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 101.328124] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 101.330539] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 101.364627] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 101.368485] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 101.370654] systemd[1]: Stopping Reactivate sysinit units... machine # [ 101.371551] systemd[1]: Reached target Reactivate sysinit units. machine # [ 101.375331] systemd[1]: Reached target Remote File Systems. machine # [ 101.378569] systemd[1]: Starting linger-users.service... machine # [ 101.384411] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.385864] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 101.394935] systemd[1]: Reached target Local File Systems. machine # [ 101.395898] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 101.405992] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 101.406911] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 101.415020] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 101.421727] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 101.427324] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.432276] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.471430] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 101.474494] systemd[1]: Finished linger-users.service. machine # [ 101.613134] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 101.616483] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 101.875171] nixos[6597]: finished switching to system configuration /nix/store/chh5b3q4zwljq0yp7yv8ia415kn90fkv-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.89 seconds) (finished: subtest: unit file parser, in 25.47 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 102.158994] nixos[6737]: switching to system configuration /nix/store/k2l67iyjs5ln3zw4j84fhsvslw86awx2-nixos-system-machine-test machine # [ 102.161456] systemd[1]: Stopped target Remote File Systems. machine # [ 102.163940] systemd[1]: Stopped target Local File Systems. machine # [ 102.435334] systemd[1]: Reload requested from client PID 6737 ('.switch-to-conf') (unit backdoor.service)... machine # [ 102.437579] systemd[1]: Reloading... machine # [ 102.791663] systemd[1]: Reloading finished in 352 ms. machine # [ 102.881557] systemd[573]: Reexecution requested from client PID 6806 ('switch-to-confi')... machine # [ 102.885959] systemd[573]: Reexecuting. machine # [ 102.943392] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.061538] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.068164] systemd[573]: Reload requested from client PID 6806 ('switch-to-confi')... machine # [ 103.070609] systemd[573]: Reloading... machine # [ 103.181972] systemd[573]: Reloading finished in 110 ms. machine # [ 103.196169] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.207998] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 103.209092] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 103.211600] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 103.244966] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 103.248852] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 103.251865] systemd[1]: Stopping Reactivate sysinit units... machine # [ 103.253797] systemd[1]: Reached target Reactivate sysinit units. machine # [ 103.255400] systemd[1]: Reached target Remote File Systems. machine # [ 103.260813] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.263889] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 103.270226] systemd[1]: Starting linger-users.service... machine # [ 103.274509] systemd[1]: Reached target Local File Systems. machine # [ 103.282341] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 103.294559] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 103.295511] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 103.301215] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 103.303431] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 103.312370] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.313712] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.355462] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 103.359966] systemd[1]: Finished linger-users.service. machine # [ 103.515108] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 103.518606] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 103.773582] nixos[6737]: finished switching to system configuration /nix/store/k2l67iyjs5ln3zw4j84fhsvslw86awx2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.89 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 104.073853] nixos[6877]: switching to system configuration /nix/store/zci0jdhzkvn3k6lhx29la1g26l6l2bgd-nixos-system-machine-test machine # [ 104.077054] systemd[1]: test.service: Deactivated successfully. machine # [ 104.080843] systemd[1]: Stopped test.service. machine # [ 104.082072] systemd[1]: Stopped target Local File Systems. machine # [ 104.082873] systemd[1]: Stopped target Remote File Systems. machine # [ 104.381235] systemd[1]: Reload requested from client PID 6877 ('.switch-to-conf') (unit backdoor.service)... machine # [ 104.383166] systemd[1]: Reloading... machine # [ 104.743088] systemd[1]: Reloading finished in 358 ms. machine # [ 104.826433] systemd[573]: Reexecution requested from client PID 6948 ('switch-to-confi')... machine # [ 104.830131] systemd[573]: Reexecuting. machine # [ 104.875250] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 104.991461] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 104.999074] systemd[573]: Reload requested from client PID 6948 ('switch-to-confi')... machine # [ 105.002173] systemd[573]: Reloading... machine # [ 105.110286] systemd[573]: Reloading finished in 109 ms. machine # [ 105.124159] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.133963] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 105.136297] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 105.138452] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 105.172309] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 105.176490] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 105.178528] systemd[1]: Stopping Reactivate sysinit units... machine # [ 105.179414] systemd[1]: Reached target Reactivate sysinit units. machine # [ 105.185026] systemd[1]: Reached target Local File Systems. machine # [ 105.185885] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 105.194009] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 105.194934] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 105.198621] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 105.205064] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 105.206687] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 105.207930] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 105.212311] systemd[1]: Reached target Remote File Systems. machine # [ 105.213228] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 105.214730] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 105.231948] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 105.241660] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 105.251163] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 105.260763] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 105.270786] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 105.274003] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 105.284637] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 105.450859] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 105.454225] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 105.459179] systemd[1]: Starting linger-users.service... machine # [ 105.464664] systemd[1]: Starting no-restart-service.service... machine # [ 105.475918] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 105.496273] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 105.497377] systemd[1]: Starting reload-triggers.service... machine # [ 105.498196] systemd[1]: Starting simple-reload-service.service... machine # [ 105.514824] systemd[1]: Starting simple-restart-service.service... machine # [ 105.528163] systemd[1]: Starting simple-service.service... machine # [ 105.563068] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 105.584930] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 105.586243] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 105.587535] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 105.647638] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 105.668413] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 105.669642] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 105.718502] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 105.735843] systemd[1]: Finished no-restart-service.service. machine # [ 105.753198] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 105.772783] systemd[1]: Finished simple-reload-service.service. machine # [ 105.787843] systemd[1]: Finished reload-triggers.service. machine # [ 105.803992] systemd[1]: Finished simple-restart-service.service. machine # [ 105.806081] systemd[1]: Finished simple-service.service. machine # [ 105.806952] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 105.807955] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 105.816316] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 105.817545] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 105.818493] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 105.819520] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 105.821810] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 105.832388] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 105.834791] systemd[1]: Finished linger-users.service. machine # [ 106.096415] nixos[6877]: finished switching to system configuration /nix/store/zci0jdhzkvn3k6lhx29la1g26l6l2bgd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.33 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 106.427456] nixos[7047]: switching to system configuration /nix/store/zci0jdhzkvn3k6lhx29la1g26l6l2bgd-nixos-system-machine-test machine # [ 106.430022] systemd[1]: Stopped target Local File Systems. machine # [ 106.432446] systemd[1]: Stopped target Remote File Systems. machine # [ 106.728502] systemd[1]: Reload requested from client PID 7047 ('.switch-to-conf') (unit backdoor.service)... machine # [ 106.730184] systemd[1]: Reloading... machine # [ 107.079619] systemd[1]: Reloading finished in 347 ms. machine # [ 107.172562] systemd[573]: Reexecution requested from client PID 7118 ('switch-to-confi')... machine # [ 107.176316] systemd[573]: Reexecuting. machine # [ 107.236050] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.361199] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.368142] systemd[573]: Reload requested from client PID 7118 ('switch-to-confi')... machine # [ 107.372456] systemd[573]: Reloading... machine # [ 107.486002] systemd[573]: Reloading finished in 115 ms. machine # [ 107.500193] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.509912] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 107.512539] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 107.514722] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 107.549351] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 107.554198] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 107.557632] systemd[1]: Stopping Reactivate sysinit units... machine # [ 107.558587] systemd[1]: Reached target Reactivate sysinit units. machine # [ 107.565340] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 107.576275] systemd[1]: Reloading reload-triggers.service... machine # [ 107.591570] systemd[1]: Reloading simple-reload-service.service... machine # [ 107.594435] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 107.611721] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 107.614294] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 107.666290] systemd[1]: Reloaded simple-reload-service.service. machine # [ 107.672583] systemd[1]: Reloaded reload-triggers.service. machine # [ 107.673500] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 107.682176] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 107.698137] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 107.700718] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 107.704288] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 107.711950] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 107.713354] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 107.714315] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 107.715250] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 107.728441] systemd[1]: Stopped simple-restart-service.service. machine # [ 107.729390] systemd[1]: Stopping simple-restart-service.service... machine # [ 107.730221] systemd[1]: Starting simple-restart-service.service... machine # [ 107.731056] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 107.756201] systemd[1]: Stopped simple-service.service. machine # [ 107.757159] systemd[1]: Stopping simple-service.service... machine # [ 107.758126] systemd[1]: Starting simple-service.service... machine # [ 107.759013] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 107.781504] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 107.782780] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 107.802048] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 107.813783] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 107.831696] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 107.842212] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 107.846675] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 107.847828] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 107.856830] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 107.857999] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 107.859017] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 107.859994] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 107.861343] systemd[1]: Finished simple-restart-service.service. machine # [ 107.862359] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 107.863678] systemd[1]: Finished simple-service.service. machine # [ 107.864936] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 107.870533] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 107.873444] systemd[1]: Reached target Remote File Systems. machine # [ 107.885977] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 107.893526] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 107.898761] systemd[1]: Starting linger-users.service... machine # [ 107.899553] systemd[1]: Reached target Local File Systems. machine # [ 107.909295] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 107.910857] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 107.911650] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 107.922674] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 107.925645] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 107.927238] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 107.928559] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 107.989458] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 107.992115] systemd[1]: Finished linger-users.service. machine # [ 108.132465] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 108.136285] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 108.394937] nixos[7047]: finished switching to system configuration /nix/store/zci0jdhzkvn3k6lhx29la1g26l6l2bgd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.30 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 108.753586] nixos[7213]: switching to system configuration /nix/store/vxd2f8xf28c4qydpnxczsr52p9pmc70x-nixos-system-machine-test machine # [ 108.756232] systemd[1]: Stopped target Local File Systems. machine # [ 108.758776] systemd[1]: Stopped target Remote File Systems. machine # [ 109.073064] systemd[1]: Reload requested from client PID 7213 ('.switch-to-conf') (unit backdoor.service)... machine # [ 109.074998] systemd[1]: Reloading... machine # [ 109.439023] systemd[1]: Reloading finished in 361 ms. machine # [ 109.530806] systemd[573]: Reexecution requested from client PID 7284 ('switch-to-confi')... machine # [ 109.534450] systemd[573]: Reexecuting. machine # [ 109.595436] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 109.717169] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 109.724096] systemd[573]: Reload requested from client PID 7284 ('switch-to-confi')... machine # [ 109.726345] systemd[573]: Reloading... machine # [ 109.839935] systemd[573]: Reloading finished in 112 ms. machine # [ 109.856189] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 109.867911] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 109.870672] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 109.873339] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 109.905862] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 109.910083] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 109.912897] systemd[1]: Stopping Reactivate sysinit units... machine # [ 109.913795] systemd[1]: Reached target Reactivate sysinit units. machine # [ 109.919011] systemd[1]: Reloading reload-triggers.service... machine # [ 109.925142] systemd[1]: Reloading simple-reload-service.service... machine # [ 109.941026] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 109.951954] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 110.004434] systemd[1]: Reloaded reload-triggers.service. machine # [ 110.008965] systemd[1]: Reloaded simple-reload-service.service. machine # [ 110.009998] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 110.010982] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 110.016489] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 110.017803] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 110.018804] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 110.022141] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 110.026607] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 110.027813] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 110.041346] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 110.042362] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 110.043291] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 110.064610] systemd[1]: Stopped simple-restart-service.service. machine # [ 110.065598] systemd[1]: Stopping simple-restart-service.service... machine # [ 110.066483] systemd[1]: Starting simple-restart-service.service... machine # [ 110.067392] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 110.112992] systemd[1]: Stopped simple-service.service. machine # [ 110.113902] systemd[1]: Stopping simple-service.service... machine # [ 110.127378] systemd[1]: Starting simple-service.service... machine # [ 110.134067] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 110.150745] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 110.176509] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 110.187245] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 110.196539] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 110.198099] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 110.199347] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 110.214349] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 110.215747] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 110.222561] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 110.223683] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 110.226732] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 110.227863] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 110.231851] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 110.237120] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 110.238232] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 110.239230] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 110.241162] systemd[1]: Finished simple-restart-service.service. machine # [ 110.242099] systemd[1]: Finished simple-service.service. machine # [ 110.242873] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 110.243825] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 110.257127] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 110.258347] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 110.259377] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 110.264364] systemd[1]: Reached target Local File Systems. machine # [ 110.265307] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 110.266813] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 110.267627] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 110.268968] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 110.271129] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 110.272754] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 110.274020] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 110.275215] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 110.277266] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 110.278621] systemd[1]: Reached target Remote File Systems. machine # [ 110.461830] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 110.466971] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 110.469565] systemd[1]: Starting linger-users.service... machine # [ 110.513150] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 110.516593] systemd[1]: Finished linger-users.service. machine # [ 110.773979] nixos[7213]: finished switching to system configuration /nix/store/vxd2f8xf28c4qydpnxczsr52p9pmc70x-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.38 seconds) machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-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/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.40 seconds) (finished: subtest: restart and reload by activation script, in 9.31 seconds) (finished: run the VM test script, in 112.04 seconds) test script finished in 112.66s cleanup kill QemuMachine (pid 45) machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14) machine # [2026-09-25T03:06:13Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-25T03:06:13Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-25T03:06:13Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.16 seconds) additionally exposed symbols: machine, other, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh