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.vs9FKwBEZS', 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: e79f2dd6-3c0c-4ad7-a1a2-fe2781ba378d machine # Superblock backups stored on blocks: machine # 32768, 98304, 163840, 229376 machine # machine # Allocating group tables: 0/8 done machine # Writing inode tables: 0/8 done machine # Creating journal (8192 blocks): done machine # Writing superblocks and filesystem accounting information: 0/8 done machine # machine # Virtualisation disk image created. machine # Starting virtiofs daemons... machine # [2026-10-12T21:35:38Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-12T21:35:38Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-12T21:35:38Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-12T21:35:38Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-12T21:35:38Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-12T21:35:38Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-12T21:35:38Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-12T21:35:38Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-12T21:35:38Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-12T21:35:38Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-12T21:35:38Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-12T21:35:38Z INFO virtiofsd] Client connected, servicing requests machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.55 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Sat Oct 3 10:39:03 UTC 2026 machine # [ 0.000000] KASLR enabled machine # [ 0.000000] random: crng init done machine # [ 0.000000] Machine model: linux,dummy-virt machine # [ 0.000000] efi: UEFI not found. machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f] machine # [ 0.000000] Zone ranges: machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] DMA32 empty machine # [ 0.000000] Normal empty machine # [ 0.000000] Device empty machine # [ 0.000000] Movable zone start for each node machine # [ 0.000000] Early memory node ranges machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000 machine # [ 0.000000] psci: probing for conduit method from DT. machine # [ 0.000000] psci: PSCIv1.3 detected in firmware. machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs machine # [ 0.000000] psci: Trusted OS migration not required machine # [ 0.000000] psci: SMC Calling Convention v1.1 machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186840 r8192 d116264 u311296 machine # [ 0.000000] Detected PIPT I-cache on CPU0 machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) machine # [ 0.000000] CPU features: detected: GICv3 CPU interface machine # [ 0.000000] CPU features: detected: Spectre-v4 machine # [ 0.000000] CPU features: detected: Spectre-BHB machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 machine # [ 0.000000] alternatives: applying boot alternatives machine # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/init regInfo=/nix/.ro-store/ix05my2ppvzlzicdr5w9k6nww2lk2911-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/ix05my2ppvzlzicdr5w9k6nww2lk2911-closure-info/registration", will be passed to user space. machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB machine # [ 0.000000] software IO TLB: area num 1. machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB) machine # [ 0.000000] Fallback order for Node 0: 0 machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 machine # [ 0.000000] Policy zone: DMA machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.000000] allocated 2097152 bytes of page_ext machine # [ 0.000000] ftrace: allocating 75039 entries in 294 pages machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups machine # [ 0.000000] rcu: Hierarchical RCU implementation. machine # [ 0.000000] rcu: RCU event tracing is enabled. machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. machine # [ 0.000000] Rude variant of Tasks RCU enabled. machine # [ 0.000000] Tracing variant of Tasks RCU enabled. machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 machine # [ 0.000000] GICv3: 256 SPIs implemented machine # [ 0.000000] GICv3: 0 Extended SPIs implemented machine # [ 0.000000] Root IRQ handler: gic_handle_irq machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @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.000460] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000641] Console: colour dummy device 80x25 machine # [ 0.000650] printk: legacy console [tty0] enabled machine # [ 0.000845] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000852] pid_max: default: 32768 minimum: 301 machine # [ 0.000955] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.001093] landlock: Up and running. machine # [ 0.001096] Yama: becoming mindful. machine # [ 0.001613] LSM support for eBPF active machine # [ 0.001748] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.001767] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.003746] rcu: Hierarchical SRCU implementation. machine # [ 0.003752] rcu: Max phase no-delay instances is 1000. machine # [ 0.005131] fsl-mc MSI: its@8080000 domain created machine # [ 0.005257] EFI services will not be available. machine # [ 0.005380] smp: Bringing up secondary CPUs ... machine # [ 0.005389] smp: Brought up 1 node, 1 CPU machine # [ 0.005393] SMP: Total of 1 processors activated. machine # [ 0.005396] CPU: All CPU(s) started at EL1 machine # [ 0.005407] CPU features: detected: Branch Target Identification machine # [ 0.005414] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.005418] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.005421] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.005425] CPU features: detected: Common not Private translations machine # [ 0.005428] CPU features: detected: CRC32 instructions machine # [ 0.005431] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.005434] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.005437] CPU features: detected: Data independent timing control (DIT) machine # [ 0.005440] CPU features: detected: E0PD machine # [ 0.005443] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.005446] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.005449] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.005452] CPU features: detected: Fine Grained Traps machine # [ 0.005456] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.005461] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.005464] CPU features: detected: LSE atomic instructions machine # [ 0.005467] CPU features: detected: Privileged Access Never machine # [ 0.005469] CPU features: detected: PMUv3 machine # [ 0.005472] CPU features: detected: RAS Extension Support machine # [ 0.005475] CPU features: detected: RASv1p1 Extension Support machine # [ 0.005477] CPU features: detected: Random Number Generator machine # [ 0.005480] CPU features: detected: Speculation barrier (SB) machine # [ 0.005483] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.005486] CPU features: detected: TLB range maintenance instructions machine # [ 0.005491] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.005528] alternatives: applying system-wide alternatives machine # [ 0.008486] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.008668] Memory: 892912K/1048576K available (24576K kernel code, 7094K rwdata, 26568K rodata, 4736K init, 1106K bss, 114372K reserved, 32768K cma-reserved) machine # [ 0.009006] devtmpfs: initialized machine # [ 0.010735] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.010766] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.010958] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.010966] 0 pages in range for non-PLT usage machine # [ 0.010968] 508192 pages in range for PLT usage machine # [ 0.011071] pinctrl core: initialized pinctrl subsystem machine # [ 0.011891] DMI not present or invalid. machine # [ 0.015150] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.017475] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.017640] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.017796] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.017817] audit: initializing netlink subsys (disabled) machine # [ 0.018420] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.018422] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.018425] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.018428] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.018430] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.018459] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 machine # [ 0.018467] cpuidle: using governor ladder machine # [ 0.018473] cpuidle: using governor menu machine # [ 0.018662] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.018678] ASID allocator initialised with 65536 entries machine # [ 0.020010] Serial: AMBA PL011 UART driver machine # [ 0.025665] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.025793] printk: console [ttyAMA0] enabled machine # [ 0.157441] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.157452] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.157455] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.157458] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.157461] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.157463] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.157466] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.157469] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.158643] fbcon: Taking over console machine # [ 0.158652] ACPI: Interpreter disabled. machine # [ 0.168060] iommu: Default domain type: Translated machine # [ 0.168066] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.168523] SCSI subsystem initialized machine # [ 0.170653] usbcore: registered new interface driver usbfs machine # [ 0.170689] usbcore: registered new interface driver hub machine # [ 0.170711] usbcore: registered new device driver usb machine # [ 0.171005] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.171009] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.171017] PTP clock support registered machine # [ 0.171061] EDAC MC: Ver: 3.0.0 machine # [ 0.177433] scmi_core: SCMI protocol bus registered machine # [ 0.177818] FPGA manager framework machine # [ 0.180969] vgaarb: loaded machine # [ 0.182675] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.187569] VFS: Disk quotas dquot_6.6.0 machine # [ 0.187593] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.189783] netfs: FS-Cache loaded machine # [ 0.189897] pnp: PnP ACPI: disabled machine # [ 0.195586] NET: Registered PF_INET protocol family machine # [ 0.195736] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.226081] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.226116] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.226140] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.226181] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.226253] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.226333] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.226361] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.226380] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.226456] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.226474] NET: Registered PF_XDP protocol family machine # [ 0.226490] PCI: CLS 0 bytes, default 64 machine # [ 0.226776] Trying to unpack rootfs image as initramfs... machine # [ 0.244966] kvm [1]: HYP mode not available machine # [ 0.339194] Initialise system trusted keyrings machine # [ 0.339337] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.339747] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.339796] 9p: Installing v9fs 9p2000 file system support machine # [ 0.362709] Key type asymmetric registered machine # [ 0.362725] Asymmetric key parser 'x509' registered machine # [ 0.362790] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.368861] io scheduler mq-deadline registered machine # [ 0.368872] io scheduler kyber registered machine # [ 0.378816] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.379467] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.379846] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.379860] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.379882] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.379889] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.379911] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.379934] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.380084] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.380091] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.380096] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.380099] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.380102] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.380187] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.380653] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.380843] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.380858] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.380885] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.380897] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.381366] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.381552] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.381564] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.381590] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.382054] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.382245] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.382257] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.382283] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.414864] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.415068] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.415081] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.415107] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.415119] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.415643] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.415838] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.415863] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.416406] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.416596] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.416621] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.417021] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.417207] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.417469] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.417660] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.417686] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.418151] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.418343] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.418369] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.435681] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.435872] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.435897] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.436393] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.436674] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.436688] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.436716] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.437185] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.437371] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.437383] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.437409] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.438043] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.438050] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.438053] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.438098] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.438142] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.438187] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.438231] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.438275] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.438318] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.438360] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.438403] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.438446] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.438513] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.438556] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.438573] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.438591] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.438609] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.438626] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.438644] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.438661] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.474774] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.474834] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.474858] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.474877] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.474897] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.474916] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.474934] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.474954] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned machine # [ 0.474973] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned machine # [ 0.474992] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.475011] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.475037] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.475043] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.475046] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.475918] pci 0000:00:07.0: enabling device (0000 -> 0002) machine # [ 0.508938] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.520085] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.522070] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.525724] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.535786] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002) machine # [ 0.537846] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002) machine # [ 0.541278] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.543917] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.545757] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.556374] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.566811] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.579541] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.581346] msm_serial: driver initialized machine # [ 0.581492] SuperH (H)SCI(F) driver initialized machine # [ 0.581551] STM32 USART driver initialized machine # [ 0.615623] loop: module loaded machine # [ 0.615778] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 0.616680] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.623368] megasas: 07.734.00.00-rc1 machine # [ 0.624192] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.626069] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.626084] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.639711] Using buffer write method machine # [ 0.639745] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.641542] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.641556] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.646564] Using buffer write method machine # [ 0.646578] Concatenating MTD devices: machine # [ 0.646581] (0): "0.flash" machine # [ 0.646583] (1): "0.flash" machine # [ 0.646585] into device "0.flash" machine # [ 0.929791] Freeing initrd memory: 27128K machine # [ 0.936460] tun: Universal TUN/TAP device driver, 1.6 machine # [ 0.940325] thunder_xcv, ver 1.0 machine # [ 0.940352] thunder_bgx, ver 1.0 machine # [ 0.940371] nicpf, ver 1.0 machine # [ 0.940929] e1000: Intel(R) PRO/1000 Network Driver machine # [ 0.940933] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 0.940959] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 0.940969] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 0.940993] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 0.940996] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 0.941016] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 0.941020] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 0.941152] sky2: driver version 1.30 machine # [ 0.950902] ehci-pci 0000:00:07.0: EHCI Host Controller machine # [ 0.950921] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1 machine # [ 0.951094] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000 machine # [ 0.951349] usbcore: registered new interface driver usb-storage machine # [ 0.951399] usbcore: registered new interface driver usbserial_generic machine # [ 0.951410] usbserial: USB Serial support registered for generic machine # [ 0.952076] hv_vmbus: registering driver hyperv_keyboard machine # [ 0.952967] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 0.952989] rtc-pl031 9010000.pl031: setting system clock to 2026-10-12T21:35:40 UTC (1791840940) machine # [ 0.953332] i2c_dev: i2c /dev entries driver machine # [ 0.956713] sdhci: Secure Digital Host Controller Interface driver machine # [ 0.956718] sdhci: Copyright(c) Pierre Ossman machine # [ 0.957019] Synopsys Designware Multimedia Card Interface Driver machine # [ 0.957415] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 0.969454] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00 machine # [ 0.969829] hub 1-0:1.0: USB hub found machine # [ 0.969846] hub 1-0:1.0: 6 ports detected machine # [ 0.970585] hid: raw HID events driver (C) Jiri Kosina machine # [ 0.973414] usbcore: registered new interface driver usbhid machine # [ 0.973418] usbhid: USB HID core driver machine # [ 0.974622] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 0.978635] drop_monitor: Initializing network drop monitor service machine # [ 0.979651] NET: Registered PF_INET6 protocol family machine # [ 0.980289] Segment Routing with IPv6 machine # [ 0.980300] In-situ OAM (IOAM) with IPv6 machine # [ 0.980325] NET: Registered PF_PACKET protocol family machine # [ 0.980383] 9pnet: Installing 9P2000 support machine # [ 0.980422] Key type dns_resolver registered machine # [ 0.989926] registered taskstats version 1 machine # [ 0.990087] Loading compiled-in X.509 certificates machine # [ 0.998953] Demotion targets for Node 0: null machine # [ 0.999064] Key type .fscrypt registered machine # [ 0.999068] Key type fscrypt-provisioning registered machine # [ 0.999177] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.999193] ima: Allocated hash algorithm: sha1 machine # [ 0.999213] ima: No architecture policies found machine # [ 0.999843] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 1.021149] clk: Disabling unused clocks machine # [ 1.021163] PM: genpd: Disabling unused power domains machine # [ 1.025311] Freeing unused kernel memory: 4736K machine # [ 1.025582] Run /init as init process machine # [ 1.041058] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.041479] systemd[1]: systemd 263-37fcd01 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR) machine # [ 1.041493] systemd[1]: Detected virtualization qemu. machine # [ 1.041539] systemd[1]: Detected architecture arm64. machine # [ 1.041545] systemd[1]: Running in initrd. machine # [ 1.041812] systemd[1]: Initializing machine ID from random generator. machine # [ 1.041902] systemd[1]: Hostname set to . machine # [ 1.138118] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.191711] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.200655] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.200832] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.200856] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.200875] systemd[1]: Reached target Path Units. machine # [ 1.200886] systemd[1]: Reached target Slice Units. machine # [ 1.200899] systemd[1]: Reached target Swaps. machine # [ 1.200911] systemd[1]: Reached target Timer Units. machine # [ 1.201032] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.201154] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.201309] systemd[1]: Listening on Journal Sockets. machine # [ 1.201379] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.201392] systemd[1]: Reached target Socket Units. machine # [ 1.202648] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.207193] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.214733] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.222842] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.225251] systemd[1]: Starting Journal Service... machine # [ 1.234912] systemd[1]: Starting Load Kernel Modules... machine # [ 1.235010] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.259138] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.279086] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.293777] systemd-journald[71]: Collecting audit messages is disabled. machine # [ 1.302229] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.305180] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.305821] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.314775] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.337863] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0 machine # [ 1.338108] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.338111] [drm] features: -context_init machine # [ 1.353084] [drm] number of scanouts: 1 machine # [ 1.353101] [drm] number of cap sets: 0 machine # [ 1.353675] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic machine # [ 1.353685] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0 machine # [ 1.358290] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.366967] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.379009] Console: switching to colour frame buffer device 160x50 machine # [ 1.384204] 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.399382] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.415250] systemd[1]: Finished Load Kernel Modules. machine # [ 1.416941] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.451480] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.451682] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.451712] systemd[1]: Reached target Local File Systems. machine # [ 1.453546] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.471022] 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.486896] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.476402] systemd-modules-load[72]: Inserted module 'dm_mod' machine # [ 1.496407] systemd[1]: Started Journal Service. machine # [ 1.488231] systemd-modules-load[72]: Module 'virtio_balloon' is built in machine # [ 1.489652] systemd-modules-load[72]: Module 'virtio_console' is built in machine # [ 1.492381] systemd-modules-load[72]: Inserted module 'virtio_gpu' machine # [ 1.497567] systemd-modules-load[72]: Module 'virtio_rng' is built in machine # [ 1.504308] systemd[1]: Starting Create System Files and Directories... machine # [ 1.548991] systemd[1]: Finished Create System Files and Directories. machine # [ 1.551732] systemd-udevd[80]: Using default interface naming scheme 'v261'. machine # [ 1.590734] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.583458] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.680218] systemd[1]: Starting Virtual Console Setup... machine # [ 1.750594] 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.753639] 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.752485] systemd-vconsole-setup[99]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 1.780071] systemd[1]: Finished Virtual Console Setup. machine # [ 2.473402] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.480760] systemd[1]: Reached target Initrd Root Device. machine # [ 2.484515] (udev-worker)[95]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.492198] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.494868] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 2.498622] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.502852] systemd[1]: Reached target System Initialization. machine # [ 2.505219] systemd[1]: Reached target Basic System. machine # [ 2.545182] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 2.549914] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.556216] systemd[1]: Mounting /sysroot... machine # [ 2.610036] EXT4-fs (vda): mounted filesystem e79f2dd6-3c0c-4ad7-a1a2-fe2781ba378d r/w with ordered data mode. Quota mode: none. machine # [ 2.597452] systemd[1]: Mounted /sysroot. machine # [ 2.604141] systemd[1]: Reached target Initrd Root File System. machine # [ 2.608136] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.632219] systemd-sysroot-fstab-check[119]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.640121] systemd[1]: Reload requested from client PID 119 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.641857] systemd[1]: Reloading... machine # [ 2.828005] systemd[1]: Reloading finished in 184 ms. machine # [ 2.861251] systemd-sysroot-fstab-check[119]: Requesting initrd-fs.target/start/replace... machine # [ 2.865662] systemd-sysroot-fstab-check[119]: Requesting swap.target/start/replace... machine # [ 2.870333] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 2.874414] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 2.876672] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.247232] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.263312] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.267458] systemd[1]: Mounting /sysroot/run... machine # [ 3.282858] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.353391] fuse: init (API version 7.45) machine # [ 3.345399] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.367810] virtiofs virtio6: discovered new tag: nix-store machine # [ 3.368608] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 3.384646] virtiofs virtio7: discovered new tag: shared machine # [ 3.385421] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 3.392389] virtiofs virtio8: discovered new tag: xchg machine # [ 3.393210] virtiofs virtio8: virtio_fs_setup_dax: No cache capability machine # [ 3.396143] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.405520] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.408154] systemd[1]: Mounted /sysroot/run. machine # [ 3.409241] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.427425] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.433529] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.462996] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.464574] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.739170] (udev-worker)[95]: mtd0ro: Failed to find and pin callout binary "/nix/store/xxw3b32sg8fj87yn2wafvjhhypsmcha2-systemd-263-37fcd01/lib/udev/mtd_probe": No such file or directory machine # [ 3.746060] (udev-worker)[95]: 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 # [ 3.774092] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 3.778613] systemd[1]: Stopped Virtual Console Setup. machine # [ 3.779479] systemd[1]: Stopping Virtual Console Setup... machine # [ 3.780452] systemd[1]: Starting Virtual Console Setup... machine # [ 3.793095] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 3.795542] systemd[1]: Stopped Virtual Console Setup. machine # [ 3.796849] systemd[1]: Starting Virtual Console Setup... machine # [ 3.820234] systemd-vconsole-setup[152]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 3.823813] systemd[1]: Finished Virtual Console Setup. machine # [ 4.245310] systemd[1]: Mounting /sysroot/nix/store... machine # [ 4.287303] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.289821] systemd[1]: Reached target Initrd File Systems. machine # [ 4.293813] systemd[1]: Starting Find NixOS closure... machine # [ 4.301252] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.346488] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.352625] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 4.359622] systemd[1]: Finished Find NixOS closure. machine # [ 4.362472] systemd[1]: Reached target Initrd Default Target. machine # [ 4.363943] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.391616] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.396722] systemd[1]: Stopped target Basic System. machine # [ 4.397729] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.398767] systemd[1]: Stopped target Path Units. machine # [ 4.400111] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.404179] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.406194] systemd[1]: Stopped target Slice Units. machine # [ 4.408296] systemd[1]: Stopped target Socket Units. machine # [ 4.412188] systemd[1]: Stopped target System Initialization. machine # [ 4.413225] systemd[1]: Stopped target Swaps. machine # [ 4.413985] systemd[1]: Stopped target Timer Units. machine # [ 4.415650] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.421333] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.424538] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.429827] systemd[1]: Stopped Find NixOS closure. machine # [ 4.431982] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.433085] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.434177] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.434987] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.447823] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.451502] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.453108] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.455404] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.460437] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.461401] systemd[1]: Stopped target Local File Systems. machine # [ 4.462194] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.463161] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.465650] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.466484] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.467560] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.472217] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.473050] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.476345] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.480286] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.481394] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.482434] systemd[1]: systemd-udevd.service: Consumed 1.282s CPU time over 3.012s wall clock time, 25.4M memory peak. machine # [ 4.488135] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.489205] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.490134] systemd[1]: Starting Cleanup udev Database... machine # [ 4.492129] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.496413] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.497444] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.498600] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.504342] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.505468] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.523897] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.526120] systemd[1]: Finished Cleanup udev Database. machine # [ 4.528606] systemd[1]: Reached target Switch Root. machine # [ 4.530965] systemd[1]: Starting NixOS Activation... machine # [ 4.610428] initrd-nixos-activation-start[175]: booting system configuration /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test machine # [ 4.642277] initrd-nixos-activation-start[175]: running activation script... machine # [ 4.854293] initrd-nixos-activation-start[198]: setting up /etc... machine # [ 4.966404] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 4.969229] systemd[1]: Finished NixOS Activation. machine # [ 4.970504] systemd[1]: Starting Switch Root... machine # [ 4.991413] systemd[1]: Switching root. machine # [ 5.179830] systemd-journald[71]: Received SIGTERM from PID 1 (systemd). machine # [ 5.333068] systemd[1]: systemd 263-37fcd01 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR) machine # [ 5.334114] systemd[1]: Detected virtualization qemu. machine # [ 5.343085] systemd[1]: Detected architecture arm64. machine # [ 5.343748] systemd[1]: Detected first boot. machine # [ 5.345664] systemd[1]: Initializing machine ID from random generator. machine # [ 5.465134] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 5.620998] systemd[1]: Applying preset policy. machine # [ 5.816154] systemd[1]: Populated /etc with preset unit settings. machine # [ 6.004532] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 6.005331] systemd[1]: Stopped initrd-switch-root.service. machine # [ 6.009642] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 6.013071] systemd[1]: Created slice Slice /system/getty. machine # [ 6.014279] systemd[1]: Created slice User and Session Slice. machine # [ 6.016905] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 6.017391] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 6.017910] systemd[1]: Expecting device /dev/hvc0... machine # [ 6.018424] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 6.022799] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 6.023207] systemd[1]: Stopped target initrd-fs.target. machine # [ 6.023741] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 6.024293] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 6.024832] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 6.025357] systemd[1]: Reached target Path Units. machine # [ 6.025878] systemd[1]: Reached target Remote File Systems. machine # [ 6.026396] systemd[1]: Reached target Slice Units. machine # [ 6.033209] systemd[1]: Reached target Swaps. machine # [ 6.035363] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 6.037148] systemd[1]: Listening on Process Core Dump Socket. machine # [ 6.038397] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 6.042242] systemd[1]: Listening on Factory Reset Management. machine # [ 6.044081] systemd[1]: Listening on Hostname Service Socket. machine # [ 6.048119] systemd[1]: Starting Journal Log Access Socket... machine # [ 6.048994] systemd[1]: Listening on Journal Audit Socket. machine # [ 6.052419] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 6.053052] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 6.053377] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.053636] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 6.062762] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 6.063217] systemd[1]: Listening on udev Varlink Socket. machine # [ 6.065451] systemd[1]: Mounting Huge Pages File System... machine # [ 6.070128] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 6.083591] systemd[1]: Mounting Kernel Debug File System... machine # [ 6.093609] systemd[1]: Mounting Kernel Trace File System... machine # [ 6.106720] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 6.107183] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 6.120755] systemd[1]: Mounting Kernel Configuration File System... machine # [ 6.122583] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 6.127797] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.132486] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 6.152164] systemd[1]: Mounting FUSE Control File System... machine # [ 6.152537] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.187218] systemd[1]: Starting Journal Service... machine # [ 6.211681] systemd[1]: Starting Load Kernel Modules... machine # [ 6.237886] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 6.254839] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 6.255240] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.284999] systemd-journald[269]: Collecting audit messages is enabled. machine # [ 6.288164] systemd[1]: Starting Coldplug All udev Devices... machine # [ 6.282905] systemd[1]: Queued start job for default target Multi-User System. machine # [ 6.290668] systemd[1]: Unnecessary job was removed for /sys/devices/platform/9000000.pl011/9000000.pl011:0/9000000.pl011:0.0/tty/ttyAMA0. machine # [ 6.297176] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0. machine # [ 6.298639] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 6.315186] systemd[1]: Started Journal Service. machine # [ 6.308169] systemd-modules-load[270]: Module 'atkbd' is built in machine # [ 6.309537] systemd-modules-load[270]: Module 'loop' is built in machine # [ 6.310580] systemd[1]: Listening on Journal Log Access Socket. machine # [ 6.311567] systemd[1]: Mounted Huge Pages File System. machine # [ 6.322620] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 6.323643] systemd[1]: Mounted Kernel Debug File System. machine # [ 6.326726] systemd[1]: Mounted Kernel Trace File System. machine # [ 6.327553] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 6.338720] systemd[1]: Finished Load Kernel Modules. machine # [ 6.359557] systemd[1]: Starting Firewall...[ 6.377033] EXT4-fs (vda): re-mounted e79f2dd6-3c0c-4ad7-a1a2-fe2781ba378d. machine # machine # [ 6.368356] systemd[1]: Starting Apply Kernel Variables... machine # [ 6.381573] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 6.397646] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 6.398905] systemd[1]: Mounted Kernel Configuration File System. machine # [ 6.411538] systemd-oomd[271]: No swap; memory pressure usage will be degraded machine # [ 6.426425] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 6.432183] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 6.446669] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 6.447773] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 6.463710] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 6.469010] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.507157] systemd[1]: Mounted FUSE Control File System. machine # [ 6.574616] systemd-journald[269]: Received client request to flush runtime journal. machine # [ 6.628873] systemd[1]: Finished Apply Kernel Variables. machine # [ 6.629893] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 6.630712] systemd[1]: Reached target First Boot Complete. machine # [ 6.652912] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 6.656099] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 6.668698] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 6.826370] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 6.827523] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 6.830248] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 6.985117] systemd-udevd[309]: Using default interface naming scheme 'v261'. machine # [ 6.995497] systemd[1]: Mounting /run/wrappers... machine # [ 7.063285] systemd[1]: Mounted /run/wrappers. machine # [ 7.064154] systemd[1]: Reached target Local File Systems. machine # [ 7.068442] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 7.077732] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 7.078702] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 7.086690] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 7.093306] systemd[1]: Starting Create System Files and Directories... machine # [ 7.154826] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 7.243821] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 7.254184] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 7.316100] systemd[1]: Finished Create System Files and Directories. machine # [ 7.324404] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 7.336224] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 7.460188] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 7.482177] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 7.493514] systemd[1]: Starting Update is Completed... machine # [ 7.560475] systemd[1]: Finished Update is Completed. machine # [ 7.711398] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 7.782978] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 7.893653] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 7.897743] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 8.054656] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 8.096887] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 8.102231] systemd[1]: Finished Coldplug All udev Devices. machine # [ 8.103197] systemd[1]: Reached target System Initialization. machine # [ 8.108319] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 8.109463] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 8.110446] systemd[1]: Reached target Timer Units. machine # [ 8.111178] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 8.123067] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 8.126013] systemd[1]: Reached target Socket Units. machine # [ 8.126799] systemd[1]: Reached target Basic System. machine # [ 8.127557] systemd[1]: Started backdoor.service. machine # [ 8.140821] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 8.142127] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 8.147591] systemd[1]: Starting Post-Boot Actions... machine # [ 8.203696] systemd[1]: Started Reset console on configuration changes. machine # [ 8.237471] systemd[1]: Starting resolvconf update... machine # connecting to host... machine: Guest shell says: b'Spawning backdoor root shell...\n' machine # [ 8.332696] systemd[1]: Started Name Service Cache Daemon (nsncd). machine: connected to guest root shell machine: (connecting took 8.65 seconds) machine: (finished: waiting for the VM to finish booting, in 9.03 seconds) machine # [ 8.344704] nsncd[434]: Oct 12 21:35:47.894 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 8.347252] (udev-worker)[410]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 8.371001] (udev-worker)[410]: Network interface NamePolicy= disabled on kernel command line. machine # [ 8.377848] systemd[1]: Finished Post-Boot Actions. machine # [ 8.378641] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 8.379587] systemd[1]: Reached target User and Group Name Lookups. machine # [ 8.412215] systemd[1]: Starting D-Bus System Message Bus... machine # [ 8.432910] systemd[1]: Starting User Login Management... machine # [ 8.450155] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 8.665971] dbus-broker-launch[465]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 8.676675] dbus-broker-launch[465]: NSS returned no entry for 'systemd-timesync' machine # [ 8.677831] dbus-broker-launch[465]: Invalid user-name in /nix/store/yvgw3s9zm3mgcxkvcnqz6bkmy838l1p9-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 8.717715] systemd[1]: Started D-Bus System Message Bus. machine # [ 8.737501] systemd-logind[468]: New seat seat0. machine # [ 8.751917] systemd[1]: Started User Login Management. machine # [ 8.763360] systemd[1]: Starting linger-users.service... machine # [ 8.792212] dbus-broker-launch[465]: Ready machine # [ 8.857121] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 8.863261] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 8.868451] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 8.869455] systemd[1]: Stopping User and Group Name Lookups... machine # [ 8.870299] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 8.887371] systemd[1]: nscd.service: Deactivated successfully. machine # [ 8.891097] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 8.935012] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 9.007641] systemd[1]: Created slice Slice /user/1001. machine # [ 9.039028] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 9.064686] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 9.088114] systemd[1]: Finished linger-users.service. machine # [ 9.089001] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 9.090253] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 9.156259] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 9.157417] systemd[1]: Starting User Manager for UID 1001... machine # [ 9.205288] systemd-logind[468]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # [ 9.235905] (systemd)[573]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 9.266990] nsncd[554]: Oct 12 21:35:48.786 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 9.319876] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 9.344706] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 9.345780] systemd[1]: Reached target User and Group Name Lookups. machine # [ 9.346671] systemd[1]: Finished resolvconf update. machine # [ 9.347418] systemd-logind[468]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 9.368804] mousedev: PS/2 mouse device common for all mice machine # [ 9.432271] systemd[1]: Starting DHCP Client... machine # [ 9.433477] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 9.784171] systemd[1]: Finished Firewall. machine # [ 9.816169] systemd[1]: Reached target Preparation for Network. machine # [ 9.843063] systemd[1]: Starting Address configuration of eth1... machine # [ 9.867211] systemd[1]: Starting Extra networking commands.... machine # [ 9.888276] systemd-logind[468]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 9.921667] systemd[573]: Queued start job for default target Main User Target. machine # [ 9.922985] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 9.962335] systemd[573]: Created slice User Application Slice. machine # [ 9.963350] systemd[573]: Started Daily Cleanup of User's Temporary Directories. machine # [ 9.976315] systemd[573]: Reached target Paths. machine # [ 9.977150] systemd[573]: Reached target Timers. machine # [ 9.977919] systemd[573]: Starting D-Bus User Message Bus Socket... machine # [ 9.978839] systemd[573]: Starting Create User Files and Directories... machine # [ 9.979762] systemd[573]: Finished Create User Files and Directories. machine # [ 10.015815] systemd[573]: Listening on D-Bus User Message Bus Socket. machine # [ 10.022270] systemd[573]: Reached target Sockets. machine # [ 10.023056] systemd[573]: Reached target Basic System. machine # [ 10.023789] systemd[1]: Started User Manager for UID 1001. machine # [ 10.042230] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 10.043281] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 10.059454] systemd[573]: Reached target Main User Target. machine # [ 10.065157] systemd[573]: Startup finished in 545ms. machine # [ 10.076917] network-addresses-eth1-start[595]: adding address 192.168.1.1/24... done machine # [ 10.100805] network-addresses-eth1-start[595]: adding address 2001:db8:1::1/64... done machine # [ 10.153014] systemd[1]: Finished Address configuration of eth1. machine # [ 10.404659] dhcpcd[614]: dhcpcd-10.3.2 starting machine # [ 10.440462] dhcpcd[677]: dev: loaded udev machine # [ 10.488244] 8021q: 802.1Q VLAN Support v1.8 machine # [ 10.488598] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 10.602595] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 10.650008] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 10.650497] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 10.653283] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 10.653590] cfg80211: failed to load regulatory.db machine # [ 10.729281] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3 machine # [ 10.764389] systemd[1]: Finished Extra networking commands.. machine # [ 10.765354] systemd[1]: Reached target Network. machine # [ 10.808186] systemd[1]: Starting Permit User Sessions... machine # [ 11.007169] systemd[1]: Finished Permit User Sessions. machine # [ 11.015159] systemd[1]: Started Getty on tty1. machine # [ 11.015933] systemd[1]: Reached target Login Prompts. machine # [ 11.110402] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 11.132712] systemd[1]: Starting Virtual Console Setup... machine # [ 11.179034] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 11.175257] dhcpcd[677]: libudev: received NULL device machine # [ 11.183324] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 11.189564] dhcpcd[677]: eth0: waiting for carrier machine # [ 11.190336] systemd[1]: Stopped Virtual Console Setup. machine # [ 11.191132] dhcpcd[677]: libudev: received NULL device machine # [ 11.192001] systemd[1]: Starting Virtual Console Setup... machine # [ 11.206778] dhcpcd[677]: eth0: carrier acquired machine # [ 11.207762] systemd-logind[468]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 11.215875] dhcpcd[677]: DUID 00:01:00:01:32:60:0f:36:52:54:00:12:34:56 machine # [ 11.222535] dhcpcd[677]: eth0: IAID 00:12:34:56 machine # [ 11.223305] dhcpcd[677]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 11.355556] systemd-vconsole-setup[710]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 11.362541] systemd[1]: Finished Virtual Console Setup. machine # [ 11.839873] dhcpcd[677]: eth0: soliciting a DHCP lease machine # [ 11.842101] dhcpcd[677]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 11.848293] dhcpcd[677]: eth0: probing address 10.0.2.15/24 machine # [ 12.711011] dhcpcd[677]: eth0: soliciting an IPv6 router machine # [ 12.713446] dhcpcd[677]: eth0: Router Advertisement from fe80::2 machine # [ 12.716136] dhcpcd[677]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 12.717845] dhcpcd[677]: eth0: adding route to fec0::/64 machine # [ 12.719078] dhcpcd[677]: eth0: adding default route via fe80::2 machine # [ 16.650089] dhcpcd[677]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 16.650401] dhcpcd[677]: eth0: adding route to 10.0.2.0/24 machine # [ 16.650480] dhcpcd[677]: eth0: adding default route via 10.0.2.2 machine # [ 16.828258] systemd[1]: Started DHCP Client. machine # [ 16.830574] systemd[1]: Reached target Multi-User System. machine # [ 16.832482] systemd[1]: Startup finished in 1.011s (kernel) + 4.221s (initrd) + 11.598s (userspace) = 16.831s. machine: (finished: waiting for unit multi-user.target, in 18.50 seconds) machine: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 18.060805] nixos[835]: switching to system configuration /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test machine # activating the configuration... machine # [ 18.067486] systemd[1]: Stopped target Remote File Systems. machine # [ 18.070128] systemd[1]: Stopped target Local File Systems. machine # setting up /etc... machine # [ 18.421099] systemd[1]: Reload requested from client PID 835 ('.switch-to-conf') (unit backdoor.service)... machine # [ 18.423551] systemd[1]: Reloading... machine # [ 18.860873] systemd[1]: Reloading finished in 435 ms. machine # reloading user units for usertest... machine # [ 18.919373] systemd[573]: Created slice User Core Session Slice. machine # [ 18.923158] systemd[573]: Starting D-Bus User Message Bus... machine # [ 18.956942] dbus-broker-launch[905]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/yvgw3s9zm3mgcxkvcnqz6bkmy838l1p9-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 18.960184] dbus-broker-launch[905]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/yvgw3s9zm3mgcxkvcnqz6bkmy838l1p9-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 18.963265] dbus-broker-launch[905]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/yvgw3s9zm3mgcxkvcnqz6bkmy838l1p9-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 18.966409] dbus-broker-launch[905]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/yvgw3s9zm3mgcxkvcnqz6bkmy838l1p9-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 18.971104] dbus-broker-launch[905]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 18.974360] dbus-broker-launch[905]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 18.976535] systemd[573]: Started D-Bus User Message Bus. machine # [ 18.979056] dbus-broker-launch[905]: Ready machine # [ 19.021321] systemd[573]: Reexecution requested from client PID 904 ('switch-to-confi')... machine # [ 19.024908] systemd[573]: Reexecuting. machine # [ 19.071259] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.181023] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.187679] systemd[573]: Reload requested from client PID 904 ('switch-to-confi')... machine # [ 19.190395] systemd[573]: Reloading... machine # [ 19.300155] systemd[573]: Reloading finished in 108 ms. machine # [ 19.316224] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 19.326747] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 19.329319] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 19.331598] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 19.364694] systemd[573]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 19.376752] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 19.464305] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 19.467648] systemd[1]: Reached target Reactivate sysinit units. machine # [ 19.472957] systemd[1]: Reached target Local File Systems. machine # [ 19.476450] systemd[1]: Reached target Remote File Systems. machine # [ 19.480829] systemd[1]: Starting linger-users.service... machine # [ 19.486719] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 19.496482] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 19.497602] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 19.498861] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 19.510954] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 19.512797] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.514223] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.515420] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.518629] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 19.572977] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 19.576318] systemd[1]: Finished linger-users.service. machine # [ 19.731717] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 19.735905] systemd[1]: Finished Create SUID/SGID Wrappers. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 19.992242] nixos[835]: finished switching to system configuration /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/bin/switch-to-configuration test, in 2.19 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.03 seconds) machine: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/9j9hvnblw2rwp5xacd3i61zrrw2ibzj6-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/9j9hvnblw2rwp5xacd3i61zrrw2ibzj6-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 20.253270] nixos[982]: switching to system configuration /nix/store/9j9hvnblw2rwp5xacd3i61zrrw2ibzj6-nixos-system-other-test machine # [ 20.255726] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # [ 20.259165] systemd[1]: Stopped target Local File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 20.572730] systemd[1]: Reload requested from client PID 982 ('.switch-to-conf') (unit backdoor.service)... machine # [ 20.574646] systemd[1]: Reloading... machine # [ 20.891869] systemd[1]: Reloading finished in 315 ms. machine # reloading user units for usertest... machine # [ 20.979343] systemd[573]: Reexecution requested from client PID 1054 ('switch-to-confi')... machine # [ 20.982276] systemd[573]: Reexecuting. machine # [ 21.039861] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.157537] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.164922] systemd[573]: Reload requested from client PID 1054 ('switch-to-confi')... machine # [ 21.166314] systemd[573]: Reloading... machine # [ 21.273658] systemd[573]: Reloading finished in 105 ms. machine # [ 21.288165] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 21.299556] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 21.301903] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 21.303878] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 21.334716] systemd[573]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 21.339294] systemd[1]: Stopped target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service machine # [ 21.342795] systemd[1]: Stopping Reactivate sysinit units... machine # [ 21.343704] systemd[1]: Reached target Reactivate sysinit units. machine # [ 21.346998] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 21.348416] dbus-broker-launch[465]: Caught SIGHUP, trigger reload. machine # [ 21.353885] dbus-broker-launch[465]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 21.355964] dbus-broker-launch[465]: NSS returned no entry for 'systemd-timesync' machine # [ 21.357322] dbus-broker-launch[465]: Invalid user-name in /nix/store/vi59l556c24ijik2l2vx5vm04fwwkvn9-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 21.373170] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 21.379604] systemd[1]: Stopping Address configuration of eth1... machine # [ 21.409856] network-addresses-eth1-pre-stop[1066]: deleting address 192.168.1.1/24... done machine # [ 21.415768] network-addresses-eth1-pre-stop[1066]: deleting address 2001:db8:1::1/64... done machine # [ 21.422301] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 21.424549] systemd[1]: Stopped Address configuration of eth1. machine # [ 21.428797] systemd[1]: Starting Address configuration of eth1... machine # [ 21.467696] network-addresses-eth1-start[1071]: adding address 192.168.1.2/24... done machine # [ 21.474342] network-addresses-eth1-start[1071]: adding address 2001:db8:1::2/64... done machine # [ 21.482855] systemd[1]: Finished Address configuration of eth1. machine # [ 21.487806] systemd[1]: Reached target Remote File Systems. machine # [ 21.493422] systemd[1]: Starting linger-users.service... machine # [ 21.494248] systemd[1]: Reached target Local File Systems. machine # [ 21.503905] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 21.510670] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 21.511562] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 21.522536] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 21.528395] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 21.535669] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.539933] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.545099] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.546553] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 21.563921] linger-users-start[1085]: id: ‘usertest’: no such user machine # [ 21.566316] linger-users-start[1082]: Removing linger for missing user usertest machine # [ 21.576064] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 21.579387] systemd[1]: Finished linger-users.service. machine # [ 21.729529] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 21.732521] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 21.987873] nixos[982]: finished switching to system configuration /nix/store/9j9hvnblw2rwp5xacd3i61zrrw2ibzj6-nixos-system-other-test machine: (finished: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/9j9hvnblw2rwp5xacd3i61zrrw2ibzj6-nixos-system-other-test/bin/switch-to-configuration test, in 1.97 seconds) subtest: services machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 22.214205] nixos[1149]: switching to system configuration /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test machine # [ 22.217006] systemd[1]: Stopped target Local File Systems. machine # [ 22.220415] systemd[1]: Stopped target Remote File Systems. machine # [ 22.494557] systemd[1]: Reload requested from client PID 1149 ('.switch-to-conf') (unit backdoor.service)... machine # [ 22.497282] systemd[1]: Reloading... machine # [ 22.804528] systemd[1]: Reloading finished in 305 ms. machine # [ 22.888226] systemd[573]: Reexecution requested from client PID 1218 ('switch-to-confi')... machine # [ 22.889711] systemd[573]: Reexecuting. machine # [ 22.951456] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.064743] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.071402] systemd[573]: Reload requested from client PID 1218 ('switch-to-confi')... machine # [ 23.073679] systemd[573]: Reloading... machine # [ 23.174634] systemd[573]: Reloading finished in 100 ms. machine # [ 23.192190] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.203537] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 23.204747] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 23.206954] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 23.238365] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 23.242633] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 23.243884] systemd[1]: Stopping Reactivate sysinit units... machine # [ 23.247724] systemd[1]: Reached target Reactivate sysinit units. machine # [ 23.249696] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 23.251445] dbus-broker-launch[465]: Caught SIGHUP, trigger reload. machine # [ 23.254671] dbus-broker-launch[465]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 23.256753] dbus-broker-launch[465]: NSS returned no entry for 'systemd-timesync' machine # [ 23.257951] dbus-broker-launch[465]: Invalid user-name in /nix/store/yvgw3s9zm3mgcxkvcnqz6bkmy838l1p9-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 23.271482] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 23.277063] systemd[1]: Stopping Address configuration of eth1... machine # [ 23.305468] network-addresses-eth1-pre-stop[1230]: deleting address 192.168.1.2/24... done machine # [ 23.311279] network-addresses-eth1-pre-stop[1230]: deleting address 2001:db8:1::2/64... done machine # [ 23.317613] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 23.322266] systemd[1]: Stopped Address configuration of eth1. machine # [ 23.324408] systemd[1]: Starting Address configuration of eth1... machine # [ 23.363587] network-addresses-eth1-start[1235]: adding address 192.168.1.1/24... done machine # [ 23.370247] network-addresses-eth1-start[1235]: adding address 2001:db8:1::1/64... done machine # [ 23.379520] systemd[1]: Finished Address configuration of eth1. machine # [ 23.383886] systemd[1]: Reached target Local File Systems. machine # [ 23.386303] systemd[1]: Reached target Remote File Systems. machine # [ 23.391366] systemd[1]: Starting linger-users.service... machine # [ 23.403263] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 23.412448] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 23.413407] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 23.414662] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 23.427970] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 23.434284] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.441905] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.443355] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.449311] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 23.468115] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 23.472447] systemd[1]: Finished linger-users.service. machine # [ 23.603700] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 23.605730] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 23.862400] nixos[1149]: finished switching to system configuration /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.87 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 24.066677] nixos[1305]: switching to system configuration /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test machine # [ 24.069492] systemd[1]: Stopped target Remote File Systems. machine # [ 24.071995] systemd[1]: Stopped target Local File Systems. machine # [ 24.334719] systemd[1]: Reload requested from client PID 1305 ('.switch-to-conf') (unit backdoor.service)... machine # [ 24.336902] systemd[1]: Reloading... machine # [ 24.646985] systemd[1]: Reloading finished in 308 ms. machine # [ 24.730812] systemd[573]: Reexecution requested from client PID 1374 ('switch-to-confi')... machine # [ 24.734979] systemd[573]: Reexecuting. machine # [ 24.791355] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.909450] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.916599] systemd[573]: Reload requested from client PID 1374 ('switch-to-confi')... machine # [ 24.920103] systemd[573]: Reloading... machine # [ 25.032124] systemd[573]: Reloading finished in 112 ms. machine # [ 25.048197] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.058377] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 25.060937] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 25.063263] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 25.097421] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 25.102137] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 25.105278] systemd[1]: Stopping Reactivate sysinit units... machine # [ 25.106271] systemd[1]: Reached target Reactivate sysinit units. machine # [ 25.114846] systemd[1]: Reached target Remote File Systems. machine # [ 25.119843] systemd[1]: Starting linger-users.service... machine # [ 25.129205] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.130651] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 25.131989] systemd[1]: Reached target Local File Systems. machine # [ 25.137263] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 25.142255] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 25.143233] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 25.148371] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 25.150789] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 25.160791] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.162244] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.210937] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 25.215343] systemd[1]: Finished linger-users.service. machine # [ 25.363627] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 25.367140] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 25.622404] nixos[1305]: finished switching to system configuration /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.76 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 25.846324] nixos[1445]: switching to system configuration /nix/store/894gxzy1r19jxs5x7nm2lckjga54spgz-nixos-system-machine-test machine # [ 25.849270] systemd[1]: Stopped target Remote File Systems. machine # [ 25.851674] systemd[1]: Stopped target Local File Systems. machine # [ 26.136768] systemd[1]: Reload requested from client PID 1445 ('.switch-to-conf') (unit backdoor.service)... machine # [ 26.138847] systemd[1]: Reloading... machine # [ 26.458040] systemd[1]: Reloading finished in 317 ms. machine # [ 26.552178] systemd[573]: Reexecution requested from client PID 1514 ('switch-to-confi')... machine # [ 26.556899] systemd[573]: Reexecuting. machine # [ 26.611344] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.725989] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.733696] systemd[573]: Reload requested from client PID 1514 ('switch-to-confi')... machine # [ 26.736605] systemd[573]: Reloading... machine # [ 26.845412] systemd[573]: Reloading finished in 107 ms. machine # [ 26.856165] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.867292] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 26.869846] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 26.872105] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 26.905462] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 26.910273] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 26.914088] systemd[1]: Stopping Reactivate sysinit units... machine # [ 26.915245] systemd[1]: Reached target Reactivate sysinit units. machine # [ 26.919523] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.921890] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 26.925774] systemd[1]: Reached target Remote File Systems. machine # [ 26.931876] systemd[1]: Starting linger-users.service... machine # [ 26.936464] systemd[1]: Starting test.service... machine # [ 26.953513] systemd[1]: Reached target Local File Systems. machine # [ 26.954502] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 26.964416] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 26.965476] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 26.966782] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 26.981659] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 26.983481] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.994595] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.019268] systemd[1]: Finished test.service. machine # [ 27.048775] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 27.053143] systemd[1]: Finished linger-users.service. machine # [ 27.219136] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 27.222478] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 27.477966] nixos[1445]: finished switching to system configuration /nix/store/894gxzy1r19jxs5x7nm2lckjga54spgz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.85 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 27.692795] nixos[1588]: switching to system configuration /nix/store/894gxzy1r19jxs5x7nm2lckjga54spgz-nixos-system-machine-test machine # [ 27.695414] systemd[1]: Stopped target Remote File Systems. machine # [ 27.697980] systemd[1]: Stopped target Local File Systems. machine # [ 27.989928] systemd[1]: Reload requested from client PID 1588 ('.switch-to-conf') (unit backdoor.service)... machine # [ 27.991971] systemd[1]: Reloading... machine # [ 28.313008] systemd[1]: Reloading finished in 318 ms. machine # [ 28.400195] systemd[573]: Reexecution requested from client PID 1657 ('switch-to-confi')... machine # [ 28.401770] systemd[573]: Reexecuting. machine # [ 28.459580] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.579397] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.587143] systemd[573]: Reload requested from client PID 1657 ('switch-to-confi')... machine # [ 28.591561] systemd[573]: Reloading... machine # [ 28.701829] systemd[573]: Reloading finished in 111 ms. machine # [ 28.716179] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.726637] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 28.729291] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 28.731477] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 28.764612] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 28.768394] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 28.771283] systemd[1]: Stopping Reactivate sysinit units... machine # [ 28.774345] systemd[1]: Reached target Reactivate sysinit units. machine # [ 28.775303] systemd[1]: Reached target Remote File Systems. machine # [ 28.777318] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.778736] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 28.786722] systemd[1]: Starting linger-users.service... machine # [ 28.796655] systemd[1]: Reached target Local File Systems. machine # [ 28.802325] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 28.807154] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 28.812916] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 28.814330] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 28.820850] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 28.825427] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.826760] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.875848] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 28.880322] systemd[1]: Finished linger-users.service. machine # [ 29.003735] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 29.006904] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 29.262747] nixos[1588]: finished switching to system configuration /nix/store/894gxzy1r19jxs5x7nm2lckjga54spgz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.79 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 29.492715] nixos[1728]: switching to system configuration /nix/store/8zs4abd5z1yj2d4ykaa34n60fr9cwhhl-nixos-system-machine-test machine # [ 29.495606] systemd[1]: Stopped target Local File Systems. machine # [ 29.498848] systemd[1]: Stopped target Remote File Systems. machine # [ 29.785174] systemd[1]: Reload requested from client PID 1728 ('.switch-to-conf') (unit backdoor.service)... machine # [ 29.787527] systemd[1]: Reloading... machine # [ 30.139469] systemd[1]: Reloading finished in 350 ms. machine # [ 30.231338] systemd[573]: Reexecution requested from client PID 1797 ('switch-to-confi')... machine # [ 30.235620] systemd[573]: Reexecuting. machine # [ 30.291762] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.403909] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.411543] systemd[573]: Reload requested from client PID 1797 ('switch-to-confi')... machine # [ 30.415482] systemd[573]: Reloading... machine # [ 30.568208] systemd[573]: Reloading finished in 153 ms. machine # [ 30.584191] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.594761] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 30.597388] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 30.599645] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 30.631168] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 30.635502] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 30.637313] systemd[1]: Stopping Reactivate sysinit units... machine # [ 30.638158] systemd[1]: Reached target Reactivate sysinit units. machine # [ 30.639674] systemd[1]: Reached target Remote File Systems. machine # [ 30.643462] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.645501] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 30.650823] systemd[1]: Starting linger-users.service... machine # [ 30.661625] systemd[1]: Reached target Local File Systems. machine # [ 30.665847] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 30.677243] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 30.678180] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 30.679455] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 30.688531] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 30.692334] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.695866] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.738760] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 30.741687] systemd[1]: Finished linger-users.service. machine # [ 30.873557] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 30.876469] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 31.130640] nixos[1728]: finished switching to system configuration /nix/store/8zs4abd5z1yj2d4ykaa34n60fr9cwhhl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 1.87 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 31.352462] nixos[1869]: switching to system configuration /nix/store/8jqk8mvfrv8r49gmhnfpwynf2hpw7j0g-nixos-system-machine-test machine # [ 31.355005] systemd[1]: Stopped target Remote File Systems. machine # [ 31.357680] systemd[1]: test.service: Deactivated successfully. machine # [ 31.358591] systemd[1]: Stopped Test unit. machine # [ 31.359819] systemd[1]: Stopped target Local File Systems. machine # [ 31.633940] systemd[1]: Reload requested from client PID 1869 ('.switch-to-conf') (unit backdoor.service)... machine # [ 31.636433] systemd[1]: Reloading... machine # [ 31.947522] systemd[1]: Reloading finished in 309 ms. machine # [ 32.035625] systemd[573]: Reexecution requested from client PID 1938 ('switch-to-confi')... machine # [ 32.038040] systemd[573]: Reexecuting. machine # [ 32.091074] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.199874] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.206438] systemd[573]: Reload requested from client PID 1938 ('switch-to-confi')... machine # [ 32.209990] systemd[573]: Reloading... machine # [ 32.315553] systemd[573]: Reloading finished in 106 ms. machine # [ 32.332159] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.342089] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 32.344445] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 32.346691] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 32.379208] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 32.383211] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 32.386087] systemd[1]: Stopping Reactivate sysinit units... machine # [ 32.386936] systemd[1]: Reached target Reactivate sysinit units. machine # [ 32.387809] systemd[1]: Reached target Local File Systems. machine # [ 32.392416] systemd[1]: Reached target Remote File Systems. machine # [ 32.395487] systemd[1]: Starting linger-users.service... machine # [ 32.399003] systemd[1]: Starting test.service... machine # [ 32.412513] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.413928] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 32.418708] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 32.427183] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 32.434271] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 32.435824] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 32.451473] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 32.458710] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.463464] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.472250] systemd[1]: Finished test.service. machine # [ 32.506531] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 32.511353] systemd[1]: Finished linger-users.service. machine # [ 32.649233] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 32.652580] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 32.906718] nixos[1869]: finished switching to system configuration /nix/store/8jqk8mvfrv8r49gmhnfpwynf2hpw7j0g-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.78 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 33.126945] nixos[2011]: switching to system configuration /nix/store/z4mlxahhjyavg0cj1ql2skv6yb4kzcdd-nixos-system-machine-test machine # [ 33.131974] systemd[1]: Stopped target Remote File Systems. machine # [ 33.132891] systemd[1]: Stopped target Local File Systems. machine # [ 33.402512] systemd[1]: Reload requested from client PID 2011 ('.switch-to-conf') (unit backdoor.service)... machine # [ 33.404600] systemd[1]: Reloading... machine # [ 33.720174] systemd[1]: Reloading finished in 313 ms. machine # [ 33.855977] systemd[573]: Reexecution requested from client PID 2080 ('switch-to-confi')... machine # [ 33.857436] systemd[573]: Reexecuting. machine # [ 33.915274] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.025995] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.032285] systemd[573]: Reload requested from client PID 2080 ('switch-to-confi')... machine # [ 34.035763] systemd[573]: Reloading... machine # [ 34.137274] systemd[573]: Reloading finished in 102 ms. machine # [ 34.148165] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.158728] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 34.159793] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 34.162302] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 34.190137] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 34.193946] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 34.195899] systemd[1]: Stopping Reactivate sysinit units... machine # [ 34.199531] systemd[1]: Reached target Reactivate sysinit units. machine # [ 34.200801] systemd[1]: test.service: Deactivated successfully. machine # [ 34.201732] systemd[1]: Stopped test.service. machine # [ 34.202379] systemd[1]: Stopping test.service... machine # [ 34.204245] systemd[1]: Starting test.service... machine # [ 34.227651] systemd[1]: Finished test.service. machine # [ 34.230561] systemd[1]: Reached target Remote File Systems. machine # [ 34.233565] systemd[1]: Reached target Local File Systems. machine # [ 34.238633] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.239989] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 34.245832] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 34.250625] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 34.251524] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 34.260262] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 34.262534] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 34.264470] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.265833] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.417877] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 34.422708] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 34.424795] systemd[1]: Starting linger-users.service... machine # [ 34.463659] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 34.466565] systemd[1]: Finished linger-users.service. machine # [ 34.722180] nixos[2011]: finished switching to system configuration /nix/store/z4mlxahhjyavg0cj1ql2skv6yb4kzcdd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.82 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 34.945352] nixos[2154]: switching to system configuration /nix/store/4gizcf751y7x74ynhkivi64wr4p74v2q-nixos-system-machine-test machine # [ 34.950649] systemd[1]: Stopped target Remote File Systems. machine # [ 34.951559] systemd[1]: Stopped target Local File Systems. machine # [ 35.227394] systemd[1]: Reload requested from client PID 2154 ('.switch-to-conf') (unit backdoor.service)... machine # [ 35.229501] systemd[1]: Reloading... machine # [ 35.541483] systemd[1]: Reloading finished in 310 ms. machine # [ 35.626297] systemd[573]: Reexecution requested from client PID 2223 ('switch-to-confi')... machine # [ 35.630491] systemd[573]: Reexecuting. machine # [ 35.687651] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.799124] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.805624] systemd[573]: Reload requested from client PID 2223 ('switch-to-confi')... machine # [ 35.807938] systemd[573]: Reloading... machine # [ 35.914554] systemd[573]: Reloading finished in 105 ms. machine # [ 35.932267] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.942401] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 35.944803] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 35.947006] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 35.980114] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 35.984746] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 35.985843] systemd[1]: Stopping Reactivate sysinit units... machine # [ 35.986708] systemd[1]: Reached target Reactivate sysinit units. machine # [ 35.991567] systemd[1]: Reloading test.service... machine # [ 36.016822] systemd[1]: Reloaded test.service. machine # [ 36.022108] systemd[1]: Reached target Local File Systems. machine # [ 36.025716] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.027091] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 36.028700] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 36.032182] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 36.033144] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 36.034383] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 36.050700] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 36.053127] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.054431] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.055624] systemd[1]: Reached target Remote File Systems. machine # [ 36.217682] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 36.220757] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 36.225569] systemd[1]: Starting linger-users.service... machine # [ 36.266371] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 36.269449] systemd[1]: Finished linger-users.service. machine # [ 36.527051] nixos[2154]: finished switching to system configuration /nix/store/4gizcf751y7x74ynhkivi64wr4p74v2q-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 1.80 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 36.751970] nixos[2296]: switching to system configuration /nix/store/ryrd2p6mns60z77wfyzz7ha4i1davzwi-nixos-system-machine-test machine # [ 36.754799] systemd[1]: Stopped target Remote File Systems. machine # [ 36.756830] systemd[1]: Stopped target Local File Systems. machine # [ 37.035184] systemd[1]: Reload requested from client PID 2296 ('.switch-to-conf') (unit backdoor.service)... machine # [ 37.037478] systemd[1]: Reloading... machine # [ 37.362330] systemd[1]: Reloading finished in 323 ms. machine # [ 37.486863] systemd[573]: Reexecution requested from client PID 2365 ('switch-to-confi')... machine # [ 37.491061] systemd[573]: Reexecuting. machine # [ 37.543309] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.654431] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.661045] systemd[573]: Reload requested from client PID 2365 ('switch-to-confi')... machine # [ 37.663467] systemd[573]: Reloading... machine # [ 37.771586] systemd[573]: Reloading finished in 107 ms. machine # [ 37.788165] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.797745] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 37.800180] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 37.802450] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 37.832117] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 37.836269] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 37.837372] systemd[1]: Stopping Reactivate sysinit units... machine # [ 37.839236] systemd[1]: Reached target Reactivate sysinit units. machine # [ 37.843871] systemd[1]: Reached target Remote File Systems. machine # [ 37.847113] systemd[1]: Starting linger-users.service... machine # [ 37.853895] systemd[1]: Reached target Local File Systems. machine # [ 37.858902] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.868106] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 37.869519] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 37.880825] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 37.881928] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 37.885560] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 37.892462] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 37.897718] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.902951] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.941979] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 37.945335] systemd[1]: Finished linger-users.service. machine # [ 38.076928] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 38.080654] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.334745] nixos[2296]: finished switching to system configuration /nix/store/ryrd2p6mns60z77wfyzz7ha4i1davzwi-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.31 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 38.828687] nixos[2447]: switching to system configuration /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test machine # [ 38.831336] systemd[1]: Stopped target Local File Systems. machine # [ 38.834149] systemd[1]: test.service: Deactivated successfully. machine # [ 38.835086] systemd[1]: Stopped test.service. machine # [ 38.836398] systemd[1]: Stopped target Remote File Systems. machine # [ 39.105384] systemd[1]: Reload requested from client PID 2447 ('.switch-to-conf') (unit backdoor.service)... machine # [ 39.107522] systemd[1]: Reloading... machine # [ 39.416474] systemd[1]: Reloading finished in 307 ms. machine # [ 39.500435] systemd[573]: Reexecution requested from client PID 2516 ('switch-to-confi')... machine # [ 39.503760] systemd[573]: Reexecuting. machine # [ 39.551339] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.658497] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.665854] systemd[573]: Reload requested from client PID 2516 ('switch-to-confi')... machine # [ 39.667319] systemd[573]: Reloading... machine # [ 39.772852] systemd[573]: Reloading finished in 104 ms. machine # [ 39.788437] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.800569] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 39.803612] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 39.806411] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 39.843255] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 39.848225] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 39.852849] systemd[1]: Stopping Reactivate sysinit units... machine # [ 39.853936] systemd[1]: Reached target Reactivate sysinit units. machine # [ 39.855737] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.865617] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 39.867120] systemd[1]: Reached target Local File Systems. machine # [ 39.873205] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 39.875001] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 39.875895] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 39.887442] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 39.890201] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 39.891895] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.894285] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.895656] systemd[1]: Reached target Remote File Systems. machine # [ 40.072449] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 40.074738] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 40.080553] systemd[1]: Starting linger-users.service... machine # [ 40.122330] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 40.125828] systemd[1]: Finished linger-users.service. machine # [ 40.381461] nixos[2447]: finished switching to system configuration /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.74 seconds) machine: must succeed: /nix/store/r1wx2j1k76ws9nhyxf7r54y7as3axsn8-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 40.641716] nixos[2587]: switching to system configuration /nix/store/6kdwqcygkpbq94r9pbl2r87jzzr8drhr-nixos-system-machine-test machine # [ 40.644533] systemd[1]: Stopped target Local File Systems. machine # [ 40.646412] systemd[1]: Stopped target Remote File Systems. machine # [ 40.942471] systemd[1]: Reload requested from client PID 2587 ('.switch-to-conf') (unit backdoor.service)... machine # [ 40.944692] systemd[1]: Reloading... machine # [ 41.260848] systemd[1]: Reloading finished in 314 ms. machine # [ 41.356581] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 41.360876] systemd[573]: Reexecution requested from client PID 2657 ('switch-to-confi')... machine # [ 41.362369] systemd[573]: Reexecuting. machine # [ 41.419811] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.535779] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.543506] systemd[573]: Reload requested from client PID 2657 ('switch-to-confi')... machine # [ 41.546248] systemd[573]: Reloading... machine # [ 41.651364] systemd[573]: Reloading finished in 104 ms. machine # [ 41.668402] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.680687] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 41.683854] systemd[1]: Stopping Reactivate sysinit units... machine # [ 41.689431] systemd[1]: Reached target Reactivate sysinit units. machine # [ 41.690481] systemd[1]: Reached target Local File Systems. machine # [ 41.691357] systemd[1]: Reached target Remote File Systems. machine # [ 41.695342] systemd[1]: Starting linger-users.service... machine # [ 41.700779] systemd[1]: Starting test.service... machine # [ 41.712756] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 41.725254] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 41.726306] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 41.727675] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 41.741769] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 41.743526] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.750800] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.757060] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.766820] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 41.795229] systemd[1]: Finished test.service. machine # [ 41.831001] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 41.834835] systemd[1]: Finished linger-users.service. machine # [ 41.973417] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 41.977541] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 42.233406] nixos[2587]: finished switching to system configuration /nix/store/6kdwqcygkpbq94r9pbl2r87jzzr8drhr-nixos-system-machine-test machine: (finished: must succeed: /nix/store/r1wx2j1k76ws9nhyxf7r54y7as3axsn8-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.85 seconds) machine: must succeed: ! test -e /run/current-system/activate machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.02 seconds) machine: must succeed: ! test -e /run/current-system/dry-activate machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.02 seconds) machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.02 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 42.520821] nixos[2736]: switching to system configuration /nix/store/lj2vl4ijmpncsh4rd1gf4yv3n0j6dwh1-nixos-system-machine-test machine # [ 42.523848] systemd[1]: Stopped target Local File Systems. machine # [ 42.528550] systemd[1]: Stopped target Remote File Systems. machine # [ 42.529565] systemd[1]: test.service: Deactivated successfully. machine # [ 42.530473] systemd[1]: Stopped test.service. machine # [ 42.827429] systemd[1]: Reload requested from client PID 2736 ('.switch-to-conf') (unit backdoor.service)... machine # [ 42.829621] systemd[1]: Reloading... machine # [ 43.145713] systemd[1]: Reloading finished in 314 ms. machine # [ 43.230355] systemd[573]: Reexecution requested from client PID 2805 ('switch-to-confi')... machine # [ 43.234493] systemd[573]: Reexecuting. machine # [ 43.287838] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.405676] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.413695] systemd[573]: Reload requested from client PID 2805 ('switch-to-confi')... machine # [ 43.416435] systemd[573]: Reloading... machine # [ 43.531227] systemd[573]: Reloading finished in 113 ms. machine # [ 43.548299] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.560811] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 43.595803] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 43.602165] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 43.603527] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 43.612339] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 43.616859] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 43.618170] systemd[1]: Stopping Reactivate sysinit units... machine # [ 43.623029] systemd[1]: Reached target Reactivate sysinit units. machine # [ 43.629169] systemd[1]: Reached target Remote File Systems. machine # [ 43.633294] systemd[1]: Started test.service. machine # [ 43.639591] systemd[1]: Reached target Local File Systems. machine # [ 43.672127] systemd[1]: Starting linger-users.service... machine # [ 43.680901] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 43.694039] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.695502] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 43.709489] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 43.711140] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 43.712002] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 43.717889] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 43.722864] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 43.732669] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.739781] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.744908] systemd[1]: test.service: Deactivated successfully. machine # [ 43.806171] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 43.808313] systemd[1]: Finished linger-users.service. machine # [ 43.963773] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 43.967247] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 44.222299] nixos[2736]: finished switching to system configuration /nix/store/lj2vl4ijmpncsh4rd1gf4yv3n0j6dwh1-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.92 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 44.442201] nixos[2882]: switching to system configuration /nix/store/74cbw7idyk8kl3qcf66g9fs2752lxlqv-nixos-system-machine-test machine # [ 44.446088] systemd[1]: Stopped target Local File Systems. machine # [ 44.448310] systemd[1]: Stopped target Remote File Systems. machine # [ 44.722746] systemd[1]: Reload requested from client PID 2882 ('.switch-to-conf') (unit backdoor.service)... machine # [ 44.724832] systemd[1]: Reloading... machine # [ 45.041987] systemd[1]: Reloading finished in 315 ms. machine # [ 45.130891] systemd[573]: Reexecution requested from client PID 2951 ('switch-to-confi')... machine # [ 45.132947] systemd[573]: Reexecuting. machine # [ 45.190831] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.294994] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.302770] systemd[573]: Reload requested from client PID 2951 ('switch-to-confi')... machine # [ 45.306556] systemd[573]: Reloading... machine # [ 45.410437] systemd[573]: Reloading finished in 104 ms. machine # [ 45.428196] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.438981] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 45.440296] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 45.444093] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 45.475740] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 45.480007] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 45.485133] systemd[1]: Stopping Reactivate sysinit units... machine # [ 45.486082] systemd[1]: Reached target Reactivate sysinit units. machine # [ 45.486964] systemd[1]: Reached target Local File Systems. machine # [ 45.487774] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 45.493270] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 45.494213] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 45.495527] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 45.509349] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 45.511117] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.516327] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.517622] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.518924] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 45.523266] systemd[1]: Reached target Remote File Systems. machine # [ 45.679046] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 45.684269] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 45.687651] systemd[1]: Starting escaped\x2ddash.service... machine # [ 45.690634] systemd[1]: Starting linger-users.service... machine # [ 45.733582] systemd[1]: Finished escaped\x2ddash.service. machine # [ 45.752427] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 45.755590] systemd[1]: Finished linger-users.service. machine # [ 46.011114] nixos[2882]: finished switching to system configuration /nix/store/74cbw7idyk8kl3qcf66g9fs2752lxlqv-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 1.79 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 46.237659] nixos[3024]: switching to system configuration /nix/store/q4dar2dcj7kd15y1nzqs9viv3ribyc3d-nixos-system-machine-test machine # [ 46.240355] systemd[1]: Stopped target Remote File Systems. machine # [ 46.246212] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 46.247273] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 46.248517] systemd[1]: Stopped target Local File Systems. machine # [ 46.527155] systemd[1]: Reload requested from client PID 3024 ('.switch-to-conf') (unit backdoor.service)... machine # [ 46.529384] systemd[1]: Reloading... machine # [ 46.849175] systemd[1]: Reloading finished in 317 ms. machine # [ 46.931823] systemd[573]: Reexecution requested from client PID 3093 ('switch-to-confi')... machine # [ 46.936312] systemd[573]: Reexecuting. machine # [ 46.978860] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.087865] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.094988] systemd[573]: Reload requested from client PID 3093 ('switch-to-confi')... machine # [ 47.098400] systemd[573]: Reloading... machine # [ 47.206770] systemd[573]: Reloading finished in 109 ms. machine # [ 47.220177] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.229782] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 47.232212] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 47.234452] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 47.263746] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 47.267857] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 47.270938] systemd[1]: Stopping Reactivate sysinit units... machine # [ 47.271832] systemd[1]: Reached target Reactivate sysinit units. machine # [ 47.275676] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.279495] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 47.281343] systemd[1]: Reached target Remote File Systems. machine # [ 47.283559] systemd[1]: Reached target Local File Systems. machine # [ 47.288843] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 47.297792] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 47.298729] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 47.302207] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 47.307207] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 47.310343] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.311758] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.471022] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 47.473134] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 47.479473] systemd[1]: Starting escaped\x2ddash.service... machine # [ 47.482753] systemd[1]: Starting linger-users.service... machine # [ 47.523556] systemd[1]: Finished escaped\x2ddash.service. machine # [ 47.543356] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 47.545477] systemd[1]: Finished linger-users.service. machine # [ 47.802137] nixos[3024]: finished switching to system configuration /nix/store/q4dar2dcj7kd15y1nzqs9viv3ribyc3d-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 1.79 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 48.104729] nixos[3166]: switching to system configuration /nix/store/f9dkfch6n7nspjxidnlvfyyyk0859zpn-nixos-system-machine-test machine # [ 48.107891] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 48.111962] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 48.113421] systemd[1]: Stopped target Remote File Systems. machine # [ 48.114283] systemd[1]: Stopped target Local File Systems. machine # [ 48.429768] systemd[1]: Reload requested from client PID 3166 ('.switch-to-conf') (unit backdoor.service)... machine # [ 48.431755] systemd[1]: Reloading... machine # [ 48.786575] systemd[1]: Reloading finished in 353 ms. machine # [ 48.876457] systemd[573]: Reexecution requested from client PID 3235 ('switch-to-confi')... machine # [ 48.880206] systemd[573]: Reexecuting. machine # [ 48.939859] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.058881] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.066490] systemd[573]: Reload requested from client PID 3235 ('switch-to-confi')... machine # [ 49.069263] systemd[573]: Reloading... machine # [ 49.179215] systemd[573]: Reloading finished in 109 ms. machine # [ 49.196401] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.207361] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 49.210612] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 49.213259] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 49.244704] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 49.249544] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 49.252459] systemd[1]: Stopping Reactivate sysinit units... machine # [ 49.253403] systemd[1]: Reached target Reactivate sysinit units. machine # [ 49.255574] systemd[1]: Reached target Remote File Systems. machine # [ 49.257792] systemd[1]: Reached target Local File Systems. machine # [ 49.261647] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.267507] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 49.269411] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 49.275534] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 49.281291] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 49.282627] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 49.288971] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 49.290670] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.291979] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.452267] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 49.456616] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 49.460297] systemd[1]: Starting -.service... machine # [ 49.465371] systemd[1]: Starting linger-users.service... machine # [ 49.502508] systemd[1]: Finished -.service. machine # [ 49.524357] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 49.526977] systemd[1]: Finished linger-users.service. machine # [ 49.784432] nixos[3166]: finished switching to system configuration /nix/store/f9dkfch6n7nspjxidnlvfyyyk0859zpn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.98 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 50.017523] nixos[3308]: switching to system configuration /nix/store/fckgkwbi3cvq4v1mnqlc9i5z3yyz8f1v-nixos-system-machine-test machine # [ 50.021763] systemd[1]: Stopped target Local File Systems. machine # [ 50.023218] systemd[1]: Stopped target Remote File Systems. machine # [ 50.310591] systemd[1]: Reload requested from client PID 3308 ('.switch-to-conf') (unit backdoor.service)... machine # [ 50.312666] systemd[1]: Reloading... machine # [ 50.640705] systemd[1]: Reloading finished in 326 ms. machine # [ 50.726651] systemd[573]: Reexecution requested from client PID 3377 ('switch-to-confi')... machine # [ 50.729021] systemd[573]: Reexecuting. machine # [ 50.787242] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.900673] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.907574] systemd[573]: Reload requested from client PID 3377 ('switch-to-confi')... machine # [ 50.911138] systemd[573]: Reloading... machine # [ 51.015816] systemd[573]: Reloading finished in 105 ms. machine # [ 51.032167] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.042043] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 51.044403] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 51.046426] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 51.079289] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 51.082790] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 51.086907] systemd[1]: Stopping Reactivate sysinit units... machine # [ 51.087828] systemd[1]: Reached target Reactivate sysinit units. machine # [ 51.090231] systemd[1]: Reloading -.service... machine # [ 51.112379] systemd[1]: Reloaded -.service. machine # [ 51.116605] systemd[1]: Reached target Local File Systems. machine # [ 51.119591] systemd[1]: Reached target Remote File Systems. machine # [ 51.122191] systemd[1]: Starting linger-users.service... machine # [ 51.135057] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 51.141608] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 51.142541] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 51.143811] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 51.158390] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 51.163330] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.170159] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.174644] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.178304] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 51.215703] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 51.219062] systemd[1]: Finished linger-users.service. machine # [ 51.344226] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 51.346956] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 51.601941] nixos[3308]: finished switching to system configuration /nix/store/fckgkwbi3cvq4v1mnqlc9i5z3yyz8f1v-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.82 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 51.834997] nixos[3450]: switching to system configuration /nix/store/c0n55z85g4zhj023qhi4f5pyzfxyvdhg-nixos-system-machine-test machine # [ 51.837890] systemd[1]: Stopped target Remote File Systems. machine # [ 51.839941] systemd[1]: -.service: Deactivated successfully. machine # [ 51.842921] systemd[1]: Stopped -.service. machine # [ 51.843646] systemd[1]: Stopped target Local File Systems. machine # [ 52.128315] systemd[1]: Reload requested from client PID 3450 ('.switch-to-conf') (unit backdoor.service)... machine # [ 52.130346] systemd[1]: Reloading... machine # [ 52.469099] systemd[1]: Reloading finished in 337 ms. machine # [ 52.564650] systemd[573]: Reexecution requested from client PID 3519 ('switch-to-confi')... machine # [ 52.569750] systemd[573]: Reexecuting. machine # [ 52.627901] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.746979] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.754898] systemd[573]: Reload requested from client PID 3519 ('switch-to-confi')... machine # [ 52.759254] systemd[573]: Reloading... machine # [ 52.872493] systemd[573]: Reloading finished in 114 ms. machine # [ 52.888224] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.899178] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 52.902239] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 52.905684] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 52.940627] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 52.945875] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 52.948614] systemd[1]: Stopping Reactivate sysinit units... machine # [ 52.949793] systemd[1]: Reached target Reactivate sysinit units. machine # [ 52.955159] systemd[1]: Reached target Local File Systems. machine # [ 52.959655] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 52.968636] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 52.969677] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 52.970968] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 52.986911] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 52.989660] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.991119] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.993066] systemd[1]: Reached target Remote File Systems. machine # [ 52.994005] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.996449] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 53.180959] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 53.186374] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 53.190331] systemd[1]: Starting linger-users.service... machine # [ 53.194586] systemd[1]: Starting required-service.service... machine # [ 53.208491] systemd[1]: Starting test-service.service... machine # [ 53.252958] systemd[1]: Finished required-service.service. machine # [ 53.261181] systemd[1]: Finished test-service.service. machine # [ 53.281164] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 53.284362] systemd[1]: Finished linger-users.service. machine # [ 53.540344] nixos[3450]: finished switching to system configuration /nix/store/c0n55z85g4zhj023qhi4f5pyzfxyvdhg-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.94 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 53.801537] nixos[3594]: switching to system configuration /nix/store/agcbk7zipmmfww5kz77gvbbj22a3qw6l-nixos-system-machine-test machine # [ 53.805124] systemd[1]: required-service.service: Deactivated successfully. machine # [ 53.809037] systemd[1]: Stopped required-service.service. machine # [ 53.809963] systemd[1]: test-service.service: Deactivated successfully. machine # [ 53.810935] systemd[1]: Stopped test-service.service. machine # [ 53.811701] systemd[1]: Stopped target Remote File Systems. machine # [ 53.813191] systemd[1]: Stopped target Local File Systems. machine # [ 54.105580] systemd[1]: Reload requested from client PID 3594 ('.switch-to-conf') (unit backdoor.service)... machine # [ 54.107585] systemd[1]: Reloading... machine # [ 54.432754] systemd[1]: Reloading finished in 323 ms. machine # [ 54.520432] systemd[573]: Reexecution requested from client PID 3663 ('switch-to-confi')... machine # [ 54.523818] systemd[573]: Reexecuting. machine # [ 54.579198] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.692808] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.699602] systemd[573]: Reload requested from client PID 3663 ('switch-to-confi')... machine # [ 54.703044] systemd[573]: Reloading... machine # [ 54.806870] systemd[573]: Reloading finished in 104 ms. machine # [ 54.824173] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.835496] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 54.837944] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 54.840128] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 54.871141] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 54.875508] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 54.877655] systemd[1]: Stopping Reactivate sysinit units... machine # [ 54.878584] systemd[1]: Reached target Reactivate sysinit units. machine # [ 54.882321] systemd[1]: Reached target Local File Systems. machine # [ 54.885928] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 54.890934] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 54.891822] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 54.900252] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 54.902568] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 54.907749] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.913495] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.914779] systemd[1]: Reached target Remote File Systems. machine # [ 54.915632] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.923228] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 55.074626] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 55.076635] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 55.082856] systemd[1]: Starting linger-users.service... machine # [ 55.086541] systemd[1]: Starting required-service.service... machine # [ 55.092465] systemd[1]: Starting test-service.service... machine # [ 55.141336] systemd[1]: Finished required-service.service. machine # [ 55.144610] systemd[1]: Finished test-service.service. machine # [ 55.164140] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 55.167291] systemd[1]: Finished linger-users.service. machine # [ 55.421642] nixos[3594]: finished switching to system configuration /nix/store/agcbk7zipmmfww5kz77gvbbj22a3qw6l-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.88 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 55.653475] nixos[3738]: switching to system configuration /nix/store/4qfk8xa6n8vfx9h0q3g7cganpyycy798-nixos-system-machine-test machine # [ 55.656292] systemd[1]: Stopped target Remote File Systems. machine # [ 55.659419] systemd[1]: required-service.service: Deactivated successfully. machine # [ 55.662024] systemd[1]: Stopped required-service.service. machine # [ 55.662849] systemd[1]: test-service.service: Deactivated successfully. machine # [ 55.663774] systemd[1]: Stopped test-service.service. machine # [ 55.664924] systemd[1]: Stopped target Local File Systems. machine # [ 55.952463] systemd[1]: Reload requested from client PID 3738 ('.switch-to-conf') (unit backdoor.service)... machine # [ 55.954565] systemd[1]: Reloading... machine # [ 56.280305] systemd[1]: Reloading finished in 324 ms. machine # [ 56.366414] systemd[573]: Reexecution requested from client PID 3807 ('switch-to-confi')... machine # [ 56.370753] systemd[573]: Reexecuting. machine # [ 56.427166] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.542671] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.550431] systemd[573]: Reload requested from client PID 3807 ('switch-to-confi')... machine # [ 56.554668] systemd[573]: Reloading... machine # [ 56.667267] systemd[573]: Reloading finished in 113 ms. machine # [ 56.684209] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.695130] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 56.697825] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 56.700377] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 56.732098] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 56.736856] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 56.738032] systemd[1]: Stopping Reactivate sysinit units... machine # [ 56.741192] systemd[1]: Reached target Reactivate sysinit units. machine # [ 56.742328] systemd[1]: Reached target Local File Systems. machine # [ 56.750142] systemd[1]: Starting required-service.service... machine # [ 56.758439] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.759875] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 56.764507] systemd[1]: Reached target Remote File Systems. machine # [ 56.773428] systemd[1]: Starting linger-users.service... machine # [ 56.780168] systemd[1]: Starting test-service.service... machine # [ 56.790751] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 56.800723] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 56.801651] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 56.802923] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 56.816226] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 56.818039] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.819358] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.845563] systemd[1]: Finished required-service.service. machine # [ 56.865870] systemd[1]: Finished test-service.service. machine # [ 56.902245] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 56.906997] systemd[1]: Finished linger-users.service. machine # [ 57.044649] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 57.048393] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 57.302570] nixos[3738]: finished switching to system configuration /nix/store/4qfk8xa6n8vfx9h0q3g7cganpyycy798-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.88 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 57.536483] nixos[3882]: switching to system configuration /nix/store/csad9raspmdy09rd8sfi3jc0ci0c0isc-nixos-system-machine-test machine # [ 57.539088] systemd[1]: Stopped target Remote File Systems. machine # [ 57.541375] systemd[1]: Stopped target Local File Systems. machine # [ 57.543527] systemd[1]: required-service.service: Deactivated successfully. machine # [ 57.546851] systemd[1]: Stopped required-service.service. machine # [ 57.547708] systemd[1]: test-service.service: Deactivated successfully. machine # [ 57.549226] systemd[1]: Stopped test-service.service. machine # [ 57.844420] systemd[1]: Reload requested from client PID 3882 ('.switch-to-conf') (unit backdoor.service)... machine # [ 57.846400] systemd[1]: Reloading... machine # [ 58.176553] systemd[1]: Reloading finished in 328 ms. machine # [ 58.263906] systemd[573]: Reexecution requested from client PID 3951 ('switch-to-confi')... machine # [ 58.267311] systemd[573]: Reexecuting. machine # [ 58.323622] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.434926] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.442266] systemd[573]: Reload requested from client PID 3951 ('switch-to-confi')... machine # [ 58.443648] systemd[573]: Reloading... machine # [ 58.550940] systemd[573]: Reloading finished in 106 ms. machine # [ 58.568177] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.578466] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 58.580970] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 58.583113] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 58.615964] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 58.619752] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 58.622339] systemd[1]: Stopping Reactivate sysinit units... machine # [ 58.623201] systemd[1]: Reached target Reactivate sysinit units. machine # [ 58.625677] systemd[1]: Reached target Remote File Systems. machine # [ 58.628386] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.629779] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 58.632419] systemd[1]: Reached target Local File Systems. machine # [ 58.638018] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 58.644767] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 58.645718] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 58.647014] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 58.655465] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 58.660644] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.662028] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.663256] systemd[1]: Created slice Slice /system/instantiated. machine # [ 58.822980] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 58.828495] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 58.831917] systemd[1]: Starting instantiated@one.service... machine # [ 58.835930] systemd[1]: Starting instantiated@two.service... machine # [ 58.840315] systemd[1]: Starting linger-users.service... machine # [ 58.897201] systemd[1]: Finished instantiated@one.service. machine # [ 58.900190] systemd[1]: Finished instantiated@two.service. machine # [ 58.918137] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 58.919798] systemd[1]: Finished linger-users.service. machine # [ 59.177931] nixos[3882]: finished switching to system configuration /nix/store/csad9raspmdy09rd8sfi3jc0ci0c0isc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.87 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 59.427733] nixos[4026]: switching to system configuration /nix/store/asknm92k04nry0cl3yjpkgq0v1101c75-nixos-system-machine-test machine # [ 59.431184] systemd[1]: Stopped target Local File Systems. machine # [ 59.433373] systemd[1]: Stopped target Remote File Systems. machine # [ 59.435217] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 59.438842] systemd[1]: Stopped instantiated@two.service. machine # [ 59.439696] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 59.442179] systemd[1]: Stopped instantiated@one.service. machine # [ 59.744408] systemd[1]: Reload requested from client PID 4026 ('.switch-to-conf') (unit backdoor.service)... machine # [ 59.746634] systemd[1]: Reloading... machine # [ 60.083034] systemd[1]: Reloading finished in 334 ms. machine # [ 60.171018] systemd[573]: Reexecution requested from client PID 4095 ('switch-to-confi')... machine # [ 60.175335] systemd[573]: Reexecuting. machine # [ 60.231431] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.349237] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.356325] systemd[573]: Reload requested from client PID 4095 ('switch-to-confi')... machine # [ 60.360228] systemd[573]: Reloading... machine # [ 60.465060] systemd[573]: Reloading finished in 106 ms. machine # [ 60.480190] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.490040] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 60.492392] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 60.494484] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 60.527338] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 60.531840] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 60.537045] systemd[1]: Stopping Reactivate sysinit units... machine # [ 60.537912] systemd[1]: Reached target Reactivate sysinit units. machine # [ 60.538814] systemd[1]: Reached target Remote File Systems. machine # [ 60.542326] systemd[1]: Starting instantiated@one.service... machine # [ 60.546075] systemd[1]: Starting instantiated@two.service... machine # [ 60.549026] systemd[1]: Starting linger-users.service... machine # [ 60.560284] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.561751] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 60.570104] systemd[1]: Reached target Local File Systems. machine # [ 60.575008] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 60.585126] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 60.586046] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 60.602816] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 60.616187] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 60.625124] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.626566] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.641835] systemd[1]: Finished instantiated@two.service. machine # [ 60.646964] systemd[1]: Finished instantiated@one.service. machine # [ 60.675694] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 60.679396] systemd[1]: Finished linger-users.service. machine # [ 60.808767] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 60.812550] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 61.067944] nixos[4026]: finished switching to system configuration /nix/store/asknm92k04nry0cl3yjpkgq0v1101c75-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.89 seconds) (finished: subtest: services, in 39.08 seconds) subtest: failing units machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 61.278940] nixos[4170]: switching to system configuration /nix/store/8jqk8mvfrv8r49gmhnfpwynf2hpw7j0g-nixos-system-machine-test machine # [ 61.282306] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 61.283337] systemd[1]: Stopped instantiated@two.service. machine # [ 61.285636] systemd[1]: Stopped target Local File Systems. machine # [ 61.286509] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 61.287479] systemd[1]: Stopped instantiated@one.service. machine # [ 61.292240] systemd[1]: Stopped target Remote File Systems. machine # [ 61.552536] systemd[1]: Reload requested from client PID 4170 ('.switch-to-conf') (unit backdoor.service)... machine # [ 61.554581] systemd[1]: Reloading... machine # [ 61.863297] systemd[1]: Reloading finished in 307 ms. machine # [ 61.950316] systemd[573]: Reexecution requested from client PID 4239 ('switch-to-confi')... machine # [ 61.954532] systemd[573]: Reexecuting. machine # [ 62.011729] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.133231] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.139828] systemd[573]: Reload requested from client PID 4239 ('switch-to-confi')... machine # [ 62.143740] systemd[573]: Reloading... machine # [ 62.254480] systemd[573]: Reloading finished in 111 ms. machine # [ 62.272203] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.282393] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 62.284875] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 62.287111] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 62.321332] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 62.325441] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 62.327915] systemd[1]: Stopping Reactivate sysinit units... machine # [ 62.330408] systemd[1]: Reached target Reactivate sysinit units. machine # [ 62.331358] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.334689] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 62.337809] systemd[1]: Reached target Local File Systems. machine # [ 62.342511] systemd[1]: Reached target Remote File Systems. machine # [ 62.347921] systemd[1]: Starting linger-users.service... machine # [ 62.351972] systemd[1]: Starting test.service... machine # [ 62.364127] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 62.371451] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 62.376663] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 62.378199] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 62.381303] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 62.382960] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.390673] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.423773] systemd[1]: Finished test.service. machine # [ 62.460643] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 62.462475] systemd[1]: Finished linger-users.service. machine # [ 62.595169] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 62.597930] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 62.854590] nixos[4170]: finished switching to system configuration /nix/store/8jqk8mvfrv8r49gmhnfpwynf2hpw7j0g-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.79 seconds) machine: must fail: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 63.086429] nixos[4312]: switching to system configuration /nix/store/59jdhg6mpkfhfybwxmxhhd2rzs2w0zv1-nixos-system-machine-test machine # [ 63.089249] systemd[1]: Stopped target Local File Systems. machine # [ 63.093281] systemd[1]: test.service: Deactivated successfully. machine # [ 63.094267] systemd[1]: Stopped test.service. machine # [ 63.094932] systemd[1]: Stopped target Remote File Systems. machine # [ 63.389568] systemd[1]: Reload requested from client PID 4312 ('.switch-to-conf') (unit backdoor.service)... machine # [ 63.391566] systemd[1]: Reloading... machine # [ 63.716971] systemd[1]: Reloading finished in 323 ms. machine # [ 63.805112] systemd[573]: Reexecution requested from client PID 4381 ('switch-to-confi')... machine # [ 63.809641] systemd[573]: Reexecuting. machine # [ 63.867303] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.977746] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.984267] systemd[573]: Reload requested from client PID 4381 ('switch-to-confi')... machine # [ 63.986632] systemd[573]: Reloading... machine # [ 64.090528] systemd[573]: Reloading finished in 102 ms. machine # [ 64.108186] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.118186] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 64.120519] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 64.122681] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 64.154609] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 64.158514] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 64.161452] systemd[1]: Stopping Reactivate sysinit units... machine # [ 64.162386] systemd[1]: Reached target Reactivate sysinit units. machine # [ 64.164704] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.166073] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 64.173594] systemd[1]: Starting test.service... machine # [ 64.183629] systemd[1]: Reached target Remote File Systems. machine # [ 64.191278] systemd[1]: Starting linger-users.service... machine # [ 64.196276] systemd[1]: Reached target Local File Systems. machine # [ 64.204540] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 64.211379] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 64.218562] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 64.219869] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 64.228819] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 64.230515] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.242324] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.247768] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 64.253064] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 64.254395] systemd[1]: Failed to start test.service. machine # [ 64.292123] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 64.296157] systemd[1]: Finished linger-users.service. machine # [ 64.421223] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 64.424682] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 64.699570] nixos[4312]: switching to system configuration /nix/store/59jdhg6mpkfhfybwxmxhhd2rzs2w0zv1-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.85 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 64.921993] nixos[4455]: switching to system configuration /nix/store/ggj77483j8g31za0wn2hklcpxhx8hwnj-nixos-system-machine-test machine # [ 64.926875] systemd[1]: Stopped target Remote File Systems. machine # [ 64.927838] systemd[1]: Stopped target Local File Systems. machine # [ 65.222467] systemd[1]: Reload requested from client PID 4455 ('.switch-to-conf') (unit backdoor.service)... machine # [ 65.224634] systemd[1]: Reloading... machine # [ 65.553520] systemd[1]: Reloading finished in 327 ms. machine # [ 65.637238] systemd[573]: Reexecution requested from client PID 4524 ('switch-to-confi')... machine # [ 65.641219] systemd[573]: Reexecuting. machine # [ 65.687479] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.795286] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.802406] systemd[573]: Reload requested from client PID 4524 ('switch-to-confi')... machine # [ 65.806295] systemd[573]: Reloading... machine # [ 65.912094] systemd[573]: Reloading finished in 106 ms. machine # [ 65.928185] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.938522] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 65.940941] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 65.943016] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 65.974428] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 65.978862] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 65.979829] systemd[1]: Stopping Reactivate sysinit units... machine # [ 65.985841] systemd[1]: Reached target Reactivate sysinit units. machine # [ 65.986761] systemd[1]: Reached target Remote File Systems. machine # [ 65.990046] systemd[1]: Started autorestart.service. machine # [ 65.993388] systemd[1]: Starting linger-users.service... machine # [ 66.008348] systemd[1]: Reached target Local File Systems. machine # [ 66.009302] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 66.020440] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 66.021377] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 66.022625] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 66.035525] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 66.043697] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.053354] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.060652] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.069137] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 66.071081] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 66.103852] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 66.106980] systemd[1]: Finished linger-users.service. machine # [ 66.232787] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 66.236984] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 66.492397] nixos[4455]: finished switching to system configuration /nix/store/ggj77483j8g31za0wn2hklcpxhx8hwnj-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.79 seconds) machine # [ 66.538329] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 66.736651] nixos[4602]: switching to system configuration /nix/store/ggj77483j8g31za0wn2hklcpxhx8hwnj-nixos-system-machine-test machine # [ 66.741178] systemd[1]: Stopped target Local File Systems. machine # [ 66.742859] systemd[1]: Stopped target Remote File Systems. machine # [ 67.003711] systemd[1]: Reload requested from client PID 4602 ('.switch-to-conf') (unit backdoor.service)... machine # [ 67.006176] systemd[1]: Reloading... machine # [ 67.317339] systemd[1]: Reloading finished in 310 ms. machine # [ 67.401194] systemd[573]: Reexecution requested from client PID 4671 ('switch-to-confi')... machine # [ 67.405579] systemd[573]: Reexecuting. machine # [ 67.459770] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.570698] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.578401] systemd[573]: Reload requested from client PID 4671 ('switch-to-confi')... machine # [ 67.582457] systemd[573]: Reloading... machine # [ 67.690088] systemd[573]: Reloading finished in 107 ms. machine # [ 67.704186] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.714304] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 67.716680] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 67.718913] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 67.751556] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 67.755661] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 67.758706] systemd[1]: Stopping Reactivate sysinit units... machine # [ 67.759599] systemd[1]: Reached target Reactivate sysinit units. machine # [ 67.764860] systemd[1]: Reached target Remote File Systems. machine # [ 67.765754] systemd[1]: Reached target Local File Systems. machine # [ 67.766544] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 67.778064] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 67.779000] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 67.787783] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 67.790422] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 67.792092] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.793470] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.794718] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.797162] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 67.946262] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 67.951418] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 67.955503] systemd[1]: Started autorestart.service. machine # [ 67.958356] systemd[1]: Starting linger-users.service... machine # [ 67.999897] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 68.022048] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 68.025539] systemd[1]: Finished linger-users.service. machine # [ 68.280640] nixos[4602]: finished switching to system configuration /nix/store/ggj77483j8g31za0wn2hklcpxhx8hwnj-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.74 seconds) machine # [ 68.321824] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 68.534988] nixos[4749]: switching to system configuration /nix/store/w25sf8vfkalxfzjg63lg80yk3q6ds95h-nixos-system-machine-test machine # [ 68.537629] systemd[1]: Stopped target Local File Systems. machine # [ 68.539851] systemd[1]: Stopped target Remote File Systems. machine # [ 68.831625] systemd[1]: Reload requested from client PID 4749 ('.switch-to-conf') (unit backdoor.service)... machine # [ 68.834189] systemd[1]: Reloading... machine # [ 69.155851] systemd[1]: Reloading finished in 320 ms. machine # [ 69.247259] systemd[573]: Reexecution requested from client PID 4818 ('switch-to-confi')... machine # [ 69.249422] systemd[573]: Reexecuting. machine # [ 69.303525] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.417814] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.424698] systemd[573]: Reload requested from client PID 4818 ('switch-to-confi')... machine # [ 69.428599] systemd[573]: Reloading... machine # [ 69.532139] systemd[573]: Reloading finished in 104 ms. machine # [ 69.548196] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.558361] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 69.559536] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 69.562786] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 69.591702] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 69.596097] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 69.597680] systemd[1]: Stopping Reactivate sysinit units... machine # [ 69.598573] systemd[1]: Reached target Reactivate sysinit units. machine # [ 69.603992] systemd[1]: Reached target Remote File Systems. machine # [ 69.610022] systemd[1]: Started autorestart.service. machine # [ 69.613656] systemd[1]: Starting linger-users.service... machine # [ 69.628752] systemd[1]: Reached target Local File Systems. machine # [ 69.629764] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 69.637747] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 69.638809] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 69.648387] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 69.650882] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 69.668956] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.670529] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.671862] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.690292] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 69.691842] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 69.699854] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 69.726153] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 69.729582] systemd[1]: Finished linger-users.service. machine # [ 69.863690] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 69.866053] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.144636] nixos[4749]: switching to system configuration /nix/store/w25sf8vfkalxfzjg63lg80yk3q6ds95h-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.82 seconds) (finished: subtest: failing units, in 9.08 seconds) subtest: unit file parser machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 70.348912] nixos[4892]: switching to system configuration /nix/store/z4mlxahhjyavg0cj1ql2skv6yb4kzcdd-nixos-system-machine-test machine # [ 70.351968] systemd[1]: Stopped target Local File Systems. machine # [ 70.354317] systemd[1]: Stopped autorestart.service. machine # [ 70.355905] systemd[1]: Stopped target Remote File Systems. machine # [ 70.617135] systemd[1]: Reload requested from client PID 4892 ('.switch-to-conf') (unit backdoor.service)... machine # [ 70.618820] systemd[1]: Reloading... machine # [ 70.927388] systemd[1]: Reloading finished in 306 ms. machine # [ 71.015007] systemd[573]: Reexecution requested from client PID 4961 ('switch-to-confi')... machine # [ 71.018709] systemd[573]: Reexecuting. machine # [ 71.079569] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.194923] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.201525] systemd[573]: Reload requested from client PID 4961 ('switch-to-confi')... machine # [ 71.205285] systemd[573]: Reloading... machine # [ 71.308460] systemd[573]: Reloading finished in 104 ms. machine # [ 71.324187] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.335625] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 71.336939] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 71.339292] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 71.373481] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 71.378693] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 71.379904] systemd[1]: Stopping Reactivate sysinit units... machine # [ 71.385644] systemd[1]: Reached target Reactivate sysinit units. machine # [ 71.386866] systemd[1]: Reached target Local File Systems. machine # [ 71.393482] systemd[1]: Reached target Remote File Systems. machine # [ 71.396567] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 71.402362] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 71.403370] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 71.407209] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 71.416434] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 71.418262] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.419599] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.423346] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.425018] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 71.582774] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 71.587744] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 71.591519] systemd[1]: Starting linger-users.service... machine # [ 71.594735] systemd[1]: Starting test.service... machine # [ 71.634626] systemd[1]: Finished test.service. machine # [ 71.656141] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 71.659340] systemd[1]: Finished linger-users.service. machine # [ 71.915436] nixos[4892]: finished switching to system configuration /nix/store/z4mlxahhjyavg0cj1ql2skv6yb4kzcdd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.77 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 72.139535] nixos[5034]: switching to system configuration /nix/store/y53vpgjclyn1x7msgmq0mw5cxgv7v94d-nixos-system-machine-test machine # [ 72.142636] systemd[1]: Stopped target Remote File Systems. machine # [ 72.146029] systemd[1]: Stopped target Local File Systems. machine # [ 72.433899] systemd[1]: Reload requested from client PID 5034 ('.switch-to-conf') (unit backdoor.service)... machine # [ 72.435943] systemd[1]: Reloading... machine # [ 72.760463] systemd[1]: Reloading finished in 322 ms. machine # [ 72.848462] systemd[573]: Reexecution requested from client PID 5103 ('switch-to-confi')... machine # [ 72.852219] systemd[573]: Reexecuting. machine # [ 72.907160] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.022442] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.029235] systemd[573]: Reload requested from client PID 5103 ('switch-to-confi')... machine # [ 73.031576] systemd[573]: Reloading... machine # [ 73.138389] systemd[573]: Reloading finished in 105 ms. machine # [ 73.156190] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.166984] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 73.168185] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 73.172272] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 73.204104] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 73.208146] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 73.212578] systemd[1]: Stopping Reactivate sysinit units... machine # [ 73.213523] systemd[1]: Reached target Reactivate sysinit units. machine # [ 73.214429] systemd[1]: test.service: Deactivated successfully. machine # [ 73.215301] systemd[1]: Stopped test.service. machine # [ 73.215999] systemd[1]: Stopping test.service... machine # [ 73.218426] systemd[1]: Starting test.service... machine # [ 73.244886] systemd[1]: Finished test.service. machine # [ 73.251230] systemd[1]: Reached target Local File Systems. machine # [ 73.255210] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 73.265498] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 73.266411] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 73.267688] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 73.278406] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 73.280243] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.281673] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.282909] systemd[1]: Reached target Remote File Systems. machine # [ 73.283720] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.286382] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 73.442181] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 73.447041] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 73.449534] systemd[1]: Starting linger-users.service... machine # [ 73.489520] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 73.492482] systemd[1]: Finished linger-users.service. machine # [ 73.748278] nixos[5034]: finished switching to system configuration /nix/store/y53vpgjclyn1x7msgmq0mw5cxgv7v94d-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.83 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 73.978056] nixos[5176]: switching to system configuration /nix/store/qa1nxvhr1q8ic0yibqi3r0flq5s72p8i-nixos-system-machine-test machine # [ 73.980596] systemd[1]: Stopped target Remote File Systems. machine # [ 73.983278] systemd[1]: Stopped target Local File Systems. machine # [ 74.275280] systemd[1]: Reload requested from client PID 5176 ('.switch-to-conf') (unit backdoor.service)... machine # [ 74.277755] systemd[1]: Reloading... machine # [ 74.610798] systemd[1]: Reloading finished in 331 ms. machine # [ 74.702581] systemd[573]: Reexecution requested from client PID 5245 ('switch-to-confi')... machine # [ 74.705316] systemd[573]: Reexecuting. machine # [ 74.764133] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.884007] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.890992] systemd[573]: Reload requested from client PID 5245 ('switch-to-confi')... machine # [ 74.895116] systemd[573]: Reloading... machine # [ 75.003231] systemd[573]: Reloading finished in 109 ms. machine # [ 75.021795] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.029829] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 75.032088] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 75.034596] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 75.068291] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 75.072452] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 75.074564] systemd[1]: Stopping Reactivate sysinit units... machine # [ 75.075502] systemd[1]: Reached target Reactivate sysinit units. machine # [ 75.079597] systemd[1]: test.service: Deactivated successfully. machine # [ 75.080681] systemd[1]: Stopped test.service. machine # [ 75.081373] systemd[1]: Stopping test.service... machine # [ 75.083143] systemd[1]: Starting test.service... machine # [ 75.109372] systemd[1]: Finished test.service. machine # [ 75.113900] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.120286] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 75.121796] systemd[1]: Reached target Local File Systems. machine # [ 75.122615] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 75.133507] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 75.134409] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 75.135677] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 75.141803] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 75.143500] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.150099] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.152138] systemd[1]: Reached target Remote File Systems. machine # [ 75.299186] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 75.302245] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 75.306632] systemd[1]: Starting linger-users.service... machine # [ 75.349115] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 75.352336] systemd[1]: Finished linger-users.service. machine # [ 75.606701] nixos[5176]: finished switching to system configuration /nix/store/qa1nxvhr1q8ic0yibqi3r0flq5s72p8i-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.86 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 75.819161] nixos[5318]: switching to system configuration /nix/store/z4mlxahhjyavg0cj1ql2skv6yb4kzcdd-nixos-system-machine-test machine # [ 75.822682] systemd[1]: Stopped target Remote File Systems. machine # [ 75.824407] systemd[1]: Stopped target Local File Systems. machine # [ 76.107436] systemd[1]: Reload requested from client PID 5318 ('.switch-to-conf') (unit backdoor.service)... machine # [ 76.109718] systemd[1]: Reloading... machine # [ 76.419977] systemd[1]: Reloading finished in 308 ms. machine # [ 76.504434] systemd[573]: Reexecution requested from client PID 5387 ('switch-to-confi')... machine # [ 76.508191] systemd[573]: Reexecuting. machine # [ 76.567629] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.682861] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.689660] systemd[573]: Reload requested from client PID 5387 ('switch-to-confi')... machine # [ 76.693389] systemd[573]: Reloading... machine # [ 76.796196] systemd[573]: Reloading finished in 103 ms. machine # [ 76.812167] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.822167] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 76.824561] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 76.826878] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 76.859952] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 76.864878] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 76.865876] systemd[1]: Stopping Reactivate sysinit units... machine # [ 76.866690] systemd[1]: Reached target Reactivate sysinit units. machine # [ 76.869443] systemd[1]: test.service: Deactivated successfully. machine # [ 76.872155] systemd[1]: Stopped test.service. machine # [ 76.872959] systemd[1]: Stopping test.service... machine # [ 76.875125] systemd[1]: Starting test.service... machine # [ 76.901069] systemd[1]: Finished test.service. machine # [ 76.904587] systemd[1]: Reached target Local File Systems. machine # [ 76.908593] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 76.913672] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 76.914595] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 76.915864] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 76.929289] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 76.931065] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.936821] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.938198] systemd[1]: Reached target Remote File Systems. machine # [ 76.939019] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.941430] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 77.093236] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 77.096438] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 77.100513] systemd[1]: Starting linger-users.service... machine # [ 77.140846] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 77.143358] systemd[1]: Finished linger-users.service. machine # [ 77.400970] nixos[5318]: finished switching to system configuration /nix/store/z4mlxahhjyavg0cj1ql2skv6yb4kzcdd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.79 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 77.636493] nixos[5460]: switching to system configuration /nix/store/k2sdhk0792izbn869ysjxcciv8vklv3i-nixos-system-machine-test machine # [ 77.639082] systemd[1]: Stopped target Remote File Systems. machine # [ 77.641265] systemd[1]: Stopped target Local File Systems. machine # [ 77.934087] systemd[1]: Reload requested from client PID 5460 ('.switch-to-conf') (unit backdoor.service)... machine # [ 77.936536] systemd[1]: Reloading... machine # [ 78.261405] systemd[1]: Reloading finished in 323 ms. machine # [ 78.350199] systemd[573]: Reexecution requested from client PID 5529 ('switch-to-confi')... machine # [ 78.354594] systemd[573]: Reexecuting. machine # [ 78.407840] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.528562] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.536111] systemd[573]: Reload requested from client PID 5529 ('switch-to-confi')... machine # [ 78.537552] systemd[573]: Reloading... machine # [ 78.652052] systemd[573]: Reloading finished in 112 ms. machine # [ 78.668178] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.678556] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 78.681161] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 78.683467] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 78.716855] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 78.721713] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 78.722822] systemd[1]: Stopping Reactivate sysinit units... machine # [ 78.723710] systemd[1]: Reached target Reactivate sysinit units. machine # [ 78.727539] systemd[1]: Reached target Remote File Systems. machine # [ 78.733253] systemd[1]: Starting linger-users.service... machine # [ 78.741071] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.742505] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 78.743863] systemd[1]: Reached target Local File Systems. machine # [ 78.761355] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 78.762973] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 78.763791] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 78.768176] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 78.770549] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 78.773943] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.775329] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.830437] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 78.833231] systemd[1]: Finished linger-users.service. machine # [ 78.966401] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 78.969958] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 79.226362] nixos[5460]: finished switching to system configuration /nix/store/k2sdhk0792izbn869ysjxcciv8vklv3i-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.82 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 79.459821] nixos[5600]: switching to system configuration /nix/store/251lra7qypxhyllk9jb87wgbqlvmlksv-nixos-system-machine-test machine # [ 79.462521] systemd[1]: Stopped target Remote File Systems. machine # [ 79.465117] systemd[1]: Stopped target Local File Systems. machine # [ 79.749129] systemd[1]: Reload requested from client PID 5600 ('.switch-to-conf') (unit backdoor.service)... machine # [ 79.751129] systemd[1]: Reloading... machine # [ 80.074283] systemd[1]: Reloading finished in 321 ms. machine # [ 80.162256] systemd[573]: Reexecution requested from client PID 5669 ('switch-to-confi')... machine # [ 80.163703] systemd[573]: Reexecuting. machine # [ 80.223451] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.340317] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.347208] systemd[573]: Reload requested from client PID 5669 ('switch-to-confi')... machine # [ 80.351091] systemd[573]: Reloading... machine # [ 80.456893] systemd[573]: Reloading finished in 107 ms. machine # [ 80.472188] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.482656] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 80.485094] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 80.487291] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 80.520562] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 80.524738] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 80.527181] systemd[1]: Stopping Reactivate sysinit units... machine # [ 80.531340] systemd[1]: Reached target Reactivate sysinit units. machine # [ 80.536235] systemd[1]: test.service: Deactivated successfully. machine # [ 80.537323] systemd[1]: Stopped test.service. machine # [ 80.537955] systemd[1]: Stopping test.service... machine # [ 80.538625] systemd[1]: Starting test.service... machine # [ 80.561096] systemd[1]: Finished test.service. machine # [ 80.563807] systemd[1]: Reached target Local File Systems. machine # [ 80.566961] systemd[1]: Reached target Remote File Systems. machine # [ 80.575021] systemd[1]: Starting linger-users.service... machine # [ 80.578360] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 80.588638] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 80.589588] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 80.590834] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 80.604954] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 80.606623] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.607899] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.610868] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.615417] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 80.666204] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 80.669348] systemd[1]: Finished linger-users.service. machine # [ 80.798257] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 80.801937] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 81.055894] nixos[5600]: finished switching to system configuration /nix/store/251lra7qypxhyllk9jb87wgbqlvmlksv-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.83 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 81.279350] nixos[5742]: switching to system configuration /nix/store/f7hhb93v8yfn9c79lkd8labkis4kfkxc-nixos-system-machine-test machine # [ 81.282553] systemd[1]: Stopped target Remote File Systems. machine # [ 81.284967] systemd[1]: Stopped target Local File Systems. machine # [ 81.564841] systemd[1]: Reload requested from client PID 5742 ('.switch-to-conf') (unit backdoor.service)... machine # [ 81.566847] systemd[1]: Reloading... machine # [ 81.876476] systemd[1]: Reloading finished in 308 ms. machine # [ 81.963098] systemd[573]: Reexecution requested from client PID 5811 ('switch-to-confi')... machine # [ 81.966759] systemd[573]: Reexecuting. machine # [ 82.023280] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.133151] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.139454] systemd[573]: Reload requested from client PID 5811 ('switch-to-confi')... machine # [ 82.142986] systemd[573]: Reloading... machine # [ 82.247908] systemd[573]: Reloading finished in 105 ms. machine # [ 82.264169] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.274349] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 82.276677] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 82.278811] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 82.310556] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 82.314693] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 82.316851] systemd[1]: Stopping Reactivate sysinit units... machine # [ 82.317728] systemd[1]: Reached target Reactivate sysinit units. machine # [ 82.321413] systemd[1]: test.service: Deactivated successfully. machine # [ 82.322330] systemd[1]: Stopped test.service. machine # [ 82.322975] systemd[1]: Stopping test.service... machine # [ 82.325537] systemd[1]: Starting test.service... machine # [ 82.348585] systemd[1]: Finished test.service. machine # [ 82.354095] systemd[1]: Reached target Local File Systems. machine # [ 82.359525] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 82.368356] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 82.369386] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 82.370627] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 82.379970] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 82.381876] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.383135] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.384776] systemd[1]: Reached target Remote File Systems. machine # [ 82.385638] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.387559] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 82.536124] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 82.540835] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 82.543349] systemd[1]: Starting linger-users.service... machine # [ 82.584793] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 82.587626] systemd[1]: Finished linger-users.service. machine # [ 82.843444] nixos[5742]: finished switching to system configuration /nix/store/f7hhb93v8yfn9c79lkd8labkis4kfkxc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.79 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 83.126970] nixos[5884]: switching to system configuration /nix/store/4hi7vqddmk840jj8nma63mz9hxcfh5iq-nixos-system-machine-test machine # [ 83.129833] systemd[1]: Stopped target Remote File Systems. machine # [ 83.132614] systemd[1]: Stopped target Local File Systems. machine # [ 83.417290] systemd[1]: Reload requested from client PID 5884 ('.switch-to-conf') (unit backdoor.service)... machine # [ 83.419200] systemd[1]: Reloading... machine # [ 83.739787] systemd[1]: Reloading finished in 319 ms. machine # [ 83.824269] systemd[573]: Reexecution requested from client PID 5953 ('switch-to-confi')... machine # [ 83.828119] systemd[573]: Reexecuting. machine # [ 83.883210] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.994087] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.000702] systemd[573]: Reload requested from client PID 5953 ('switch-to-confi')... machine # [ 84.003099] systemd[573]: Reloading... machine # [ 84.105942] systemd[573]: Reloading finished in 101 ms. machine # [ 84.120159] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.129926] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 84.132080] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 84.134264] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 84.166865] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 84.170773] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 84.175326] systemd[1]: Stopping Reactivate sysinit units... machine # [ 84.176475] systemd[1]: Reached target Reactivate sysinit units. machine # [ 84.177436] systemd[1]: test.service: Deactivated successfully. machine # [ 84.178262] systemd[1]: Stopped test.service. machine # [ 84.178942] systemd[1]: Stopping test.service... machine # [ 84.180721] systemd[1]: Starting test.service... machine # [ 84.204147] systemd[1]: Finished test.service. machine # [ 84.207449] systemd[1]: Reached target Remote File Systems. machine # [ 84.212879] systemd[1]: Starting linger-users.service... machine # [ 84.222257] systemd[1]: Reached target Local File Systems. machine # [ 84.225135] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 84.232102] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 84.233167] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 84.234450] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 84.246840] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 84.252163] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.259397] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.266542] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.267950] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 84.304770] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 84.307450] systemd[1]: Finished linger-users.service. machine # [ 84.432794] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 84.436274] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 84.690066] nixos[5884]: finished switching to system configuration /nix/store/4hi7vqddmk840jj8nma63mz9hxcfh5iq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 1.85 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 84.899055] nixos[6026]: switching to system configuration /nix/store/z4mlxahhjyavg0cj1ql2skv6yb4kzcdd-nixos-system-machine-test machine # [ 84.903942] systemd[1]: Stopped target Remote File Systems. machine # [ 84.906377] systemd[1]: Stopped target Local File Systems. machine # [ 85.162204] systemd[1]: Reload requested from client PID 6026 ('.switch-to-conf') (unit backdoor.service)... machine # [ 85.164229] systemd[1]: Reloading... machine # [ 85.462888] systemd[1]: Reloading finished in 297 ms. machine # [ 85.548428] systemd[573]: Reexecution requested from client PID 6095 ('switch-to-confi')... machine # [ 85.551912] systemd[573]: Reexecuting. machine # [ 85.611275] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.727831] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.734585] systemd[573]: Reload requested from client PID 6095 ('switch-to-confi')... machine # [ 85.738297] systemd[573]: Reloading... machine # [ 85.841466] systemd[573]: Reloading finished in 104 ms. machine # [ 85.856163] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.865710] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 85.868064] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 85.870172] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 85.903117] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 85.907277] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 85.909162] systemd[1]: Stopping Reactivate sysinit units... machine # [ 85.910035] systemd[1]: Reached target Reactivate sysinit units. machine # [ 85.914064] systemd[1]: test.service: Deactivated successfully. machine # [ 85.915059] systemd[1]: Stopped test.service. machine # [ 85.915746] systemd[1]: Stopping test.service... machine # [ 85.917939] systemd[1]: Starting test.service... machine # [ 85.941612] systemd[1]: Finished test.service. machine # [ 85.946675] systemd[1]: Reached target Remote File Systems. machine # [ 85.950138] systemd[1]: Reached target Local File Systems. machine # [ 85.954968] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.958754] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 85.964481] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 85.969434] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 85.970462] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 85.971759] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 85.982870] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 85.985137] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.986515] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.171955] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 86.176551] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 86.179582] systemd[1]: Starting linger-users.service... machine # [ 86.226934] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 86.230374] systemd[1]: Finished linger-users.service. machine # [ 86.486712] nixos[6026]: finished switching to system configuration /nix/store/z4mlxahhjyavg0cj1ql2skv6yb4kzcdd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.80 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 86.738727] nixos[6168]: switching to system configuration /nix/store/isdmzvqcdb3hr94rwd0f9vrzpxk65m02-nixos-system-machine-test machine # [ 86.742228] systemd[1]: Stopped target Remote File Systems. machine # [ 86.745285] systemd[1]: Stopped target Local File Systems. machine # [ 87.053763] systemd[1]: Reload requested from client PID 6168 ('.switch-to-conf') (unit backdoor.service)... machine # [ 87.055803] systemd[1]: Reloading... machine # [ 87.391651] systemd[1]: Reloading finished in 334 ms. machine # [ 87.479455] systemd[573]: Reexecution requested from client PID 6237 ('switch-to-confi')... machine # [ 87.481993] systemd[573]: Reexecuting. machine # [ 87.544449] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.664525] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.672130] systemd[573]: Reload requested from client PID 6237 ('switch-to-confi')... machine # [ 87.677174] systemd[573]: Reloading... machine # [ 87.791535] systemd[573]: Reloading finished in 115 ms. machine # [ 87.808184] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.819053] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 87.821379] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 87.823568] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 87.855153] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 87.860850] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 87.864701] systemd[1]: Stopping Reactivate sysinit units... machine # [ 87.865595] systemd[1]: Reached target Reactivate sysinit units. machine # [ 87.868287] systemd[1]: Reloading test.service... machine # [ 87.894320] systemd[1]: Reloaded test.service. machine # [ 87.900518] systemd[1]: Reached target Remote File Systems. machine # [ 87.904990] systemd[1]: Starting linger-users.service... machine # [ 87.915403] systemd[1]: Reached target Local File Systems. machine # [ 87.919488] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 87.926881] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 87.927896] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 87.938939] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 87.942253] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 87.947227] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.950814] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.956608] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.961241] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 88.001689] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 88.004460] systemd[1]: Finished linger-users.service. machine # [ 88.134020] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 88.137738] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 88.391891] nixos[6168]: finished switching to system configuration /nix/store/isdmzvqcdb3hr94rwd0f9vrzpxk65m02-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.90 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 88.625752] nixos[6310]: switching to system configuration /nix/store/0w2zqrnd6bbf3g5yh837nb9l3xd0s54r-nixos-system-machine-test machine # [ 88.628517] systemd[1]: Stopped target Local File Systems. machine # [ 88.630317] systemd[1]: Stopped target Remote File Systems. machine # [ 88.929666] systemd[1]: Reload requested from client PID 6310 ('.switch-to-conf') (unit backdoor.service)... machine # [ 88.931700] systemd[1]: Reloading... machine # [ 89.263248] systemd[1]: Reloading finished in 329 ms. machine # [ 89.350446] systemd[573]: Reexecution requested from client PID 6379 ('switch-to-confi')... machine # [ 89.354929] systemd[573]: Reexecuting. machine # [ 89.411671] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.523565] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.530386] systemd[573]: Reload requested from client PID 6379 ('switch-to-confi')... machine # [ 89.534152] systemd[573]: Reloading... machine # [ 89.637056] systemd[573]: Reloading finished in 103 ms. machine # [ 89.652166] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.663790] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 89.665188] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 89.667628] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 89.695305] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 89.699418] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 89.701249] systemd[1]: Stopping Reactivate sysinit units... machine # [ 89.702107] systemd[1]: Reached target Reactivate sysinit units. machine # [ 89.706919] systemd[1]: Reloading test.service... machine # [ 89.732746] systemd[1]: Reloaded test.service. machine # [ 89.738446] systemd[1]: Reached target Remote File Systems. machine # [ 89.742915] systemd[1]: Starting linger-users.service... machine # [ 89.748492] systemd[1]: Reached target Local File Systems. machine # [ 89.749457] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 89.762881] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 89.763879] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 89.770479] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 89.773658] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 89.775344] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.778381] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.779679] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.787639] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 89.834374] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 89.838041] systemd[1]: Finished linger-users.service. machine # [ 89.963051] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 89.966867] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 90.220743] nixos[6310]: finished switching to system configuration /nix/store/0w2zqrnd6bbf3g5yh837nb9l3xd0s54r-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.83 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 90.449572] nixos[6452]: switching to system configuration /nix/store/4iyjydf3q4f9mafd4i3vf2vv6276jbrz-nixos-system-machine-test machine # [ 90.452259] systemd[1]: Stopped target Local File Systems. machine # [ 90.454696] systemd[1]: Stopped target Remote File Systems. machine # [ 90.741535] systemd[1]: Reload requested from client PID 6452 ('.switch-to-conf') (unit backdoor.service)... machine # [ 90.743525] systemd[1]: Reloading... machine # [ 91.083862] systemd[1]: Reloading finished in 338 ms. machine # [ 91.178393] systemd[573]: Reexecution requested from client PID 6521 ('switch-to-confi')... machine # [ 91.183124] systemd[573]: Reexecuting. machine # [ 91.235530] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.354723] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.361740] systemd[573]: Reload requested from client PID 6521 ('switch-to-confi')... machine # [ 91.364234] systemd[573]: Reloading... machine # [ 91.476792] systemd[573]: Reloading finished in 111 ms. machine # [ 91.493893] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.505520] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 91.506659] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 91.509939] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 91.541641] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 91.546019] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 91.551210] systemd[1]: Stopping Reactivate sysinit units... machine # [ 91.552587] systemd[1]: Reached target Reactivate sysinit units. machine # [ 91.553590] systemd[1]: test.service: Deactivated successfully. machine # [ 91.554472] systemd[1]: Stopped test.service. machine # [ 91.555137] systemd[1]: Stopping test.service... machine # [ 91.556878] systemd[1]: Starting test.service... machine # [ 91.583747] systemd[1]: Finished test.service. machine # [ 91.591458] systemd[1]: Reached target Local File Systems. machine # [ 91.597079] systemd[1]: Reached target Remote File Systems. machine # [ 91.601781] systemd[1]: Starting linger-users.service... machine # [ 91.611468] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 91.621284] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 91.622324] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 91.623772] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 91.634146] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 91.637155] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.640696] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.642427] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.649989] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 91.695604] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 91.698710] systemd[1]: Finished linger-users.service. machine # [ 91.830609] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 91.833664] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 92.087995] nixos[6452]: finished switching to system configuration /nix/store/4iyjydf3q4f9mafd4i3vf2vv6276jbrz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.87 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 92.296804] nixos[6594]: switching to system configuration /nix/store/251lra7qypxhyllk9jb87wgbqlvmlksv-nixos-system-machine-test machine # [ 92.299747] systemd[1]: Stopped target Remote File Systems. machine # [ 92.302909] systemd[1]: Stopped target Local File Systems. machine # [ 92.599278] systemd[1]: Reload requested from client PID 6594 ('.switch-to-conf') (unit backdoor.service)... machine # [ 92.602274] systemd[1]: Reloading... machine # [ 92.924947] systemd[1]: Reloading finished in 321 ms. machine # [ 93.011025] systemd[573]: Reexecution requested from client PID 6663 ('switch-to-confi')... machine # [ 93.015047] systemd[573]: Reexecuting. machine # [ 93.055094] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.163420] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.170239] systemd[573]: Reload requested from client PID 6663 ('switch-to-confi')... machine # [ 93.173963] systemd[573]: Reloading... machine # [ 93.282430] systemd[573]: Reloading finished in 109 ms. machine # [ 93.300198] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.311791] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 93.313245] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 93.315260] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 93.348544] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 93.353206] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 93.355909] systemd[1]: Stopping Reactivate sysinit units... machine # [ 93.358669] systemd[1]: Reached target Reactivate sysinit units. machine # [ 93.362978] systemd[1]: Reached target Local File Systems. machine # [ 93.367665] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 93.376460] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 93.377433] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 93.378682] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 93.386447] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 93.390481] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.391845] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.395274] systemd[1]: Reached target Remote File Systems. machine # [ 93.397859] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.399253] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 93.559916] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 93.564355] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 93.567733] systemd[1]: Starting linger-users.service... machine # [ 93.610991] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 93.612868] systemd[1]: Finished linger-users.service. machine # [ 93.869550] nixos[6594]: finished switching to system configuration /nix/store/251lra7qypxhyllk9jb87wgbqlvmlksv-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.78 seconds) (finished: subtest: unit file parser, in 23.72 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 94.092902] nixos[6734]: switching to system configuration /nix/store/ryrd2p6mns60z77wfyzz7ha4i1davzwi-nixos-system-machine-test machine # [ 94.095422] systemd[1]: Stopped target Local File Systems. machine # [ 94.097794] systemd[1]: Stopped target Remote File Systems. machine # [ 94.392605] systemd[1]: Reload requested from client PID 6734 ('.switch-to-conf') (unit backdoor.service)... machine # [ 94.394644] systemd[1]: Reloading... machine # [ 94.722827] systemd[1]: Reloading finished in 326 ms. machine # [ 94.818970] systemd[573]: Reexecution requested from client PID 6803 ('switch-to-confi')... machine # [ 94.821042] systemd[573]: Reexecuting. machine # [ 94.879885] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.996383] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.004123] systemd[573]: Reload requested from client PID 6803 ('switch-to-confi')... machine # [ 95.005539] systemd[573]: Reloading... machine # [ 95.116072] systemd[573]: Reloading finished in 109 ms. machine # [ 95.132227] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.142386] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 95.145179] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 95.147603] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 95.182403] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 95.187011] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 95.190540] systemd[1]: Stopping Reactivate sysinit units... machine # [ 95.191472] systemd[1]: Reached target Reactivate sysinit units. machine # [ 95.194806] systemd[1]: Reached target Local File Systems. machine # [ 95.195644] systemd[1]: Reached target Remote File Systems. machine # [ 95.201810] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.208987] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 95.210463] systemd[1]: Starting linger-users.service... machine # [ 95.220562] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 95.235089] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 95.237738] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 95.239300] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 95.242946] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 95.248335] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.249973] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.310647] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 95.313033] systemd[1]: Finished linger-users.service. machine # [ 95.458326] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 95.462361] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 95.718098] nixos[6734]: finished switching to system configuration /nix/store/ryrd2p6mns60z77wfyzz7ha4i1davzwi-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.85 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 95.962957] nixos[6874]: switching to system configuration /nix/store/cfgnzv2zw5ha88di4arasb697kllxqpq-nixos-system-machine-test machine # [ 95.966320] systemd[1]: test.service: Deactivated successfully. machine # [ 95.967287] systemd[1]: Stopped test.service. machine # [ 95.969381] systemd[1]: Stopped target Remote File Systems. machine # [ 95.971774] systemd[1]: Stopped target Local File Systems. machine # [ 96.276368] systemd[1]: Reload requested from client PID 6874 ('.switch-to-conf') (unit backdoor.service)... machine # [ 96.278069] systemd[1]: Reloading... machine # [ 96.620981] systemd[1]: Reloading finished in 341 ms. machine # [ 96.708592] systemd[573]: Reexecution requested from client PID 6945 ('switch-to-confi')... machine # [ 96.713133] systemd[573]: Reexecuting. machine # [ 96.763287] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.877476] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.884874] systemd[573]: Reload requested from client PID 6945 ('switch-to-confi')... machine # [ 96.888076] systemd[573]: Reloading... machine # [ 96.998882] systemd[573]: Reloading finished in 111 ms. machine # [ 97.012198] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 97.023469] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 97.026200] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 97.028961] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 97.061584] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 97.066163] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 97.068482] systemd[1]: Stopping Reactivate sysinit units... machine # [ 97.069506] systemd[1]: Reached target Reactivate sysinit units. machine # [ 97.077181] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 97.081945] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 97.087107] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 97.091929] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 97.094039] systemd[1]: Reached target Remote File Systems. machine # [ 97.102130] systemd[1]: Starting linger-users.service... machine # [ 97.108281] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 97.112459] systemd[1]: Starting reload-triggers.service... machine # [ 97.132157] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 97.133553] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 97.159567] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 97.176969] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 97.178128] systemd[1]: Reached target Local File Systems. machine # [ 97.178955] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 97.230672] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 97.231732] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 97.262928] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 97.312375] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 97.328850] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 97.342163] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 97.343744] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 97.356642] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 97.357972] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 97.359331] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 97.369566] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 97.370833] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 97.375388] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 97.380644] systemd[1]: Finished reload-triggers.service. machine # [ 97.381619] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 97.382912] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 97.389594] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 97.397846] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 97.402652] systemd[1]: Finished linger-users.service. machine # [ 97.544630] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 97.548581] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 97.554169] systemd[1]: Starting no-restart-service.service... machine # [ 97.558347] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 97.562643] systemd[1]: Starting simple-reload-service.service... machine # [ 97.576609] systemd[1]: Starting simple-restart-service.service... machine # [ 97.591985] systemd[1]: Starting simple-service.service... machine # [ 97.597387] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 97.606908] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 97.621314] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 97.700138] systemd[1]: Finished no-restart-service.service. machine # [ 97.708946] systemd[1]: Finished simple-restart-service.service. machine # [ 97.709994] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 97.711005] systemd[1]: Finished simple-reload-service.service. machine # [ 97.726846] systemd[1]: Finished simple-service.service. machine # [ 97.738387] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 97.741620] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 97.748337] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 98.005450] nixos[6874]: finished switching to system configuration /nix/store/cfgnzv2zw5ha88di4arasb697kllxqpq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.29 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 98.269447] nixos[7044]: switching to system configuration /nix/store/cfgnzv2zw5ha88di4arasb697kllxqpq-nixos-system-machine-test machine # [ 98.272079] systemd[1]: Stopped target Remote File Systems. machine # [ 98.274949] systemd[1]: Stopped target Local File Systems. machine # [ 98.577422] systemd[1]: Reload requested from client PID 7044 ('.switch-to-conf') (unit backdoor.service)... machine # [ 98.579407] systemd[1]: Reloading... machine # [ 98.918556] systemd[1]: Reloading finished in 337 ms. machine # [ 99.008615] systemd[573]: Reexecution requested from client PID 7115 ('switch-to-confi')... machine # [ 99.011374] systemd[573]: Reexecuting. machine # [ 99.063252] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.174013] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.180669] systemd[573]: Reload requested from client PID 7115 ('switch-to-confi')... machine # [ 99.183081] systemd[573]: Reloading... machine # [ 99.289465] systemd[573]: Reloading finished in 105 ms. machine # [ 99.304217] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.314713] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 99.317065] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 99.319225] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 99.351247] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 99.355368] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 99.357881] systemd[1]: Stopping Reactivate sysinit units... machine # [ 99.358817] systemd[1]: Reached target Reactivate sysinit units. machine # [ 99.364944] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 99.372087] systemd[1]: Reloading reload-triggers.service... machine # [ 99.376217] systemd[1]: Reloading simple-reload-service.service... machine # [ 99.388573] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 99.400398] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 99.412084] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 99.482793] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 99.488283] systemd[1]: Reloaded reload-triggers.service. machine # [ 99.489311] systemd[1]: Reloaded simple-reload-service.service. machine # [ 99.490182] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 99.491320] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 99.493702] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 99.496858] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 99.498149] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 99.499105] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 99.510149] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 99.511267] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 99.516615] systemd[1]: Stopped simple-restart-service.service. machine # [ 99.517539] systemd[1]: Stopping simple-restart-service.service... machine # [ 99.518423] systemd[1]: Starting simple-restart-service.service... machine # [ 99.519296] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 99.540799] systemd[1]: Stopped simple-service.service. machine # [ 99.541667] systemd[1]: Stopping simple-service.service... machine # [ 99.542457] systemd[1]: Starting simple-service.service... machine # [ 99.543274] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 99.570393] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 99.571781] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 99.592642] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 99.604832] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 99.621763] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 99.630377] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 99.638409] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 99.645494] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 99.646906] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 99.647919] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 99.655316] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 99.662557] systemd[1]: Finished simple-service.service. machine # [ 99.663398] systemd[1]: Finished simple-restart-service.service. machine # [ 99.669863] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 99.670901] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 99.682296] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 99.683477] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 99.689410] systemd[1]: Reached target Local File Systems. machine # [ 99.690327] systemd[1]: Reached target Remote File Systems. machine # [ 99.691176] systemd[1]: Starting linger-users.service... machine # [ 99.691958] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.699805] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 99.704269] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 99.710212] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 99.715790] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 99.720639] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 99.722991] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 99.731863] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.735741] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.763726] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 99.768287] systemd[1]: Finished linger-users.service. machine # [ 99.890909] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 99.894273] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 100.150314] nixos[7044]: finished switching to system configuration /nix/store/cfgnzv2zw5ha88di4arasb697kllxqpq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.14 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 100.417914] nixos[7210]: switching to system configuration /nix/store/rp8y6imrlq4zd6wmcpkicbvn6k8rvh5y-nixos-system-machine-test machine # [ 100.421109] systemd[1]: Stopped target Remote File Systems. machine # [ 100.422811] systemd[1]: Stopped target Local File Systems. machine # [ 100.722057] systemd[1]: Reload requested from client PID 7210 ('.switch-to-conf') (unit backdoor.service)... machine # [ 100.723746] systemd[1]: Reloading... machine # [ 101.062965] systemd[1]: Reloading finished in 337 ms. machine # [ 101.156893] systemd[573]: Reexecution requested from client PID 7281 ('switch-to-confi')... machine # [ 101.160528] systemd[573]: Reexecuting. machine # [ 101.215691] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.331296] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.338220] systemd[573]: Reload requested from client PID 7281 ('switch-to-confi')... machine # [ 101.340747] systemd[573]: Reloading... machine # [ 101.446527] systemd[573]: Reloading finished in 104 ms. machine # [ 101.464173] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.475562] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 101.476819] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 101.479341] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 101.511487] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 101.515909] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 101.518826] systemd[1]: Stopping Reactivate sysinit units... machine # [ 101.519682] systemd[1]: Reached target Reactivate sysinit units. machine # [ 101.524668] systemd[1]: Reloading reload-triggers.service... machine # [ 101.539437] systemd[1]: Reloading simple-reload-service.service... machine # [ 101.548524] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 101.549624] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 101.590280] systemd[1]: Reloaded reload-triggers.service. machine # [ 101.602084] systemd[1]: Reloaded simple-reload-service.service. machine # [ 101.608005] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 101.610517] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 101.615835] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 101.620554] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 101.621564] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 101.622561] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 101.623538] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 101.643050] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 101.656364] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 101.657462] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 101.658380] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 101.659414] systemd[1]: Stopped simple-restart-service.service. machine # [ 101.689420] systemd[1]: Stopping simple-restart-service.service... machine # [ 101.690415] systemd[1]: Starting simple-restart-service.service... machine # [ 101.708667] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 101.723353] systemd[1]: Stopped simple-service.service. machine # [ 101.735403] systemd[1]: Stopping simple-service.service... machine # [ 101.751111] systemd[1]: Starting simple-service.service... machine # [ 101.765261] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 101.781250] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 101.782785] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 101.796275] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 101.801398] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 101.802769] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 101.803864] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 101.806952] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 101.809222] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 101.810551] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 101.811609] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 101.814828] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 101.815978] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 101.817869] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 101.818881] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 101.819869] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 101.825151] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 101.826180] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 101.827081] systemd[1]: Finished simple-service.service. machine # [ 101.827860] systemd[1]: Finished simple-restart-service.service. machine # [ 101.830400] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 101.831543] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 101.842698] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 101.843871] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 101.853207] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.854555] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 101.855888] systemd[1]: Reached target Local File Systems. machine # [ 101.861896] systemd[1]: Reached target Remote File Systems. machine # [ 101.862823] systemd[1]: Starting linger-users.service... machine # [ 101.863627] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 101.865365] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 101.866179] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 101.867400] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 101.873216] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 101.874878] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.884092] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.925725] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 101.928350] systemd[1]: Finished linger-users.service. machine # [ 102.057096] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 102.060137] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 102.317214] nixos[7210]: finished switching to system configuration /nix/store/rp8y6imrlq4zd6wmcpkicbvn6k8rvh5y-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.17 seconds) machine: must succeed: /nix/store/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-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/xr2d9p13awmaf8j3s5qh7g10q3x74zj2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.36 seconds) (finished: subtest: restart and reload by activation script, in 8.81 seconds) (finished: run the VM test script, in 103.38 seconds) test script finished in 103.44s cleanup kill QemuMachine (pid 45) machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14) machine # [2026-10-12T21:37:21Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-12T21:37:21Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-12T21:37:21Z 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