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.D9OPpsN01Z', 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: 46ffe815-2156-426f-8d85-6001848781d3 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-22T02:58:16Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-22T02:58:16Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-22T02:58:16Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-22T02:58:16Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-22T02:58:16Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-22T02:58:16Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-22T02:58:16Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-22T02:58:16Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-22T02:58:16Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-22T02:58:16Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-22T02:58:16Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-22T02:58:16Z INFO virtiofsd] Client connected, servicing requests machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.57 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT @1792058300 machine # [ 0.000000] KASLR enabled machine # [ 0.000000] random: crng init done machine # [ 0.000000] Machine model: linux,dummy-virt machine # [ 0.000000] efi: UEFI not found. machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f] machine # [ 0.000000] Zone ranges: machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] DMA32 empty machine # [ 0.000000] Normal empty machine # [ 0.000000] Device empty machine # [ 0.000000] Movable zone start for each node machine # [ 0.000000] Early memory node ranges machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000 machine # [ 0.000000] psci: probing for conduit method from DT. machine # [ 0.000000] psci: PSCIv1.3 detected in firmware. machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs machine # [ 0.000000] psci: Trusted OS migration not required machine # [ 0.000000] psci: SMC Calling Convention v1.1 machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) machine # [ 0.000000] percpu: Embedded 76 pages/cpu s187672 r8192 d115432 u311296 machine # [ 0.000000] Detected PIPT I-cache on CPU0 machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) machine # [ 0.000000] CPU features: detected: GICv3 CPU interface machine # [ 0.000000] CPU features: detected: Spectre-v4 machine # [ 0.000000] CPU features: detected: Spectre-BHB machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 machine # [ 0.000000] alternatives: applying boot alternatives machine # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/init regInfo=/nix/.ro-store/wjpb50m56229pl1hkl556g44mfvv3aww-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/wjpb50m56229pl1hkl556g44mfvv3aww-closure-info/registration", will be passed to user space. machine # [ 0.000000] printk: log buffer data + meta data: 1048576 + 3670016 = 4718592 bytes machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB machine # [ 0.000000] software IO TLB: area num 1. machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB) machine # [ 0.000000] Fallback order for Node 0: 0 machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 machine # [ 0.000000] Policy zone: DMA machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.000000] allocated 2097152 bytes of page_ext machine # [ 0.000000] ftrace: allocating 75301 entries in 296 pages machine # [ 0.000000] ftrace: allocated 296 pages with 3 groups machine # [ 0.000000] rcu: Hierarchical RCU implementation. machine # [ 0.000000] rcu: RCU event tracing is enabled. machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1. machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. machine # [ 0.000000] Rude variant of Tasks RCU enabled. machine # [ 0.000000] Tracing variant of Tasks RCU enabled. machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 machine # [ 0.000000] GICv3: 256 SPIs implemented machine # [ 0.000000] GICv3: 0 Extended SPIs implemented machine # [ 0.000000] Root IRQ handler: gic_handle_irq machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @450e0000 (indirect, esz 8, psz 64K, shr 1) machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @450f0000 (flat, esz 8, psz 64K, shr 1) machine # [ 0.000000] GICv3: using LPI property table @0x0000000045100000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000045110000 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.000038] arm-pv: using stolen time PV machine # [ 0.000434] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000615] Console: colour dummy device 80x25 machine # [ 0.000624] printk: legacy console [tty0] enabled machine # [ 0.000835] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000842] pid_max: default: 32768 minimum: 301 machine # [ 0.000939] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima machine # [ 0.001078] landlock: Up and running. machine # [ 0.001082] Yama: becoming mindful. machine # [ 0.001548] LSM support for eBPF active machine # [ 0.001679] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.001701] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.003771] rcu: Hierarchical SRCU implementation. machine # [ 0.003778] rcu: Max phase no-delay instances is 1000. machine # [ 0.005229] fsl-mc MSI: its@8080000 domain created machine # [ 0.005363] EFI services will not be available. machine # [ 0.005518] smp: Bringing up secondary CPUs ... machine # [ 0.005530] smp: Brought up 1 node, 1 CPU machine # [ 0.005534] SMP: Total of 1 processors activated. machine # [ 0.005536] CPU: All CPU(s) started at EL1 machine # [ 0.005549] CPU features: detected: Branch Target Identification machine # [ 0.005554] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.005557] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.005560] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.005569] CPU features: detected: Common not Private translations machine # [ 0.005573] CPU features: detected: CRC32 instructions machine # [ 0.005576] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.005579] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.005582] CPU features: detected: Data independent timing control (DIT) machine # [ 0.005585] CPU features: detected: E0PD machine # [ 0.005588] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.005591] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.005594] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.005598] CPU features: detected: Fine Grained Traps machine # [ 0.005602] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.005607] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.005610] CPU features: detected: LSE atomic instructions machine # [ 0.005613] CPU features: detected: Privileged Access Never machine # [ 0.005616] CPU features: detected: PMUv3 machine # [ 0.005618] CPU features: detected: RAS Extension Support machine # [ 0.005621] CPU features: detected: RASv1p1 Extension Support machine # [ 0.005624] CPU features: detected: Random Number Generator machine # [ 0.005630] CPU features: detected: Speculation barrier (SB) machine # [ 0.005633] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.005636] CPU features: detected: TLB range maintenance instructions machine # [ 0.005641] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.005680] alternatives: applying system-wide alternatives machine # [ 0.009057] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.009257] Memory: 886656K/1048576K available (24640K kernel code, 10246K rwdata, 26664K rodata, 7808K init, 2086K bss, 120628K reserved, 32768K cma-reserved) machine # [ 0.009709] devtmpfs: initialized machine # [ 0.011645] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.011672] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.011865] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.011870] 0 pages in range for non-PLT usage machine # [ 0.011871] 506368 pages in range for PLT usage machine # [ 0.012010] pinctrl core: initialized pinctrl subsystem machine # [ 0.012894] DMI not present or invalid. machine # [ 0.016509] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.019159] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.019345] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.019529] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.019557] audit: initializing netlink subsys (disabled) machine # [ 0.020225] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.020228] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.020232] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.020235] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.020238] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.020267] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 machine # [ 0.020276] cpuidle: using governor ladder machine # [ 0.020282] cpuidle: using governor menu machine # [ 0.020481] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.020499] ASID allocator initialised with 65536 entries machine # [ 0.021913] Serial: AMBA PL011 UART driver machine # [ 0.027963] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.028171] printk: console [ttyAMA0] enabled machine # [ 0.157172] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.157185] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.157189] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.157192] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.157194] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.157197] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.157200] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.157203] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.158541] fbcon: Taking over console machine # [ 0.158553] ACPI: Interpreter disabled. machine # [ 0.168360] iommu: Default domain type: Translated machine # [ 0.168366] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.168867] SCSI subsystem initialized machine # [ 0.170978] usbcore: registered new interface driver usbfs machine # [ 0.171020] usbcore: registered new interface driver hub machine # [ 0.171042] usbcore: registered new device driver usb machine # [ 0.171375] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.171379] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.171388] PTP clock support registered machine # [ 0.171444] EDAC MC: Ver: 3.0.0 machine # [ 0.177786] scmi_core: SCMI protocol bus registered machine # [ 0.178208] FPGA manager framework machine # [ 0.181322] vgaarb: loaded machine # [ 0.183058] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.189482] VFS: Disk quotas dquot_6.6.0 machine # [ 0.189517] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.192844] netfs: FS-Cache loaded machine # [ 0.192984] pnp: PnP ACPI: disabled machine # [ 0.197998] NET: Registered PF_INET protocol family machine # [ 0.198158] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.230746] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.230792] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.230819] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.230865] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.230939] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.231033] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.237023] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.237075] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.237163] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.237216] NET: Registered PF_XDP protocol family machine # [ 0.237235] PCI: CLS 0 bytes, default 64 machine # [ 0.237519] Trying to unpack rootfs image as initramfs... machine # [ 0.243616] kvm [1]: HYP mode not available machine # [ 0.355319] Initialise system trusted keyrings machine # [ 0.355374] Key type blacklist registered machine # [ 0.360362] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.360864] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.360920] 9p: Installing v9fs 9p2000 file system support machine # [ 0.361031] integrity: Platform Keyring initialized machine # [ 0.361043] integrity: Machine keyring initialized machine # [ 0.384550] Key type asymmetric registered machine # [ 0.384567] Asymmetric key parser 'x509' registered machine # [ 0.384658] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.389341] io scheduler mq-deadline registered machine # [ 0.389352] io scheduler kyber registered machine # [ 0.402350] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.402999] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.405053] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.405068] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.405082] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.405089] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.405108] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.405132] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.405214] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.405222] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.405227] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.405230] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.405233] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.405292] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.405755] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.405944] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.405956] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.405983] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.405996] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.406472] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.406659] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.406671] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.406697] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.435305] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.435543] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.435557] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.435584] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.436145] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.436342] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.436354] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.436381] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.436394] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.436863] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.437053] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.437079] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.437543] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.437733] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.437760] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.438166] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.438348] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.438636] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.438826] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.438852] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.456813] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.457010] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.457037] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.457511] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.457702] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.457731] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.458215] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.458527] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.458545] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.458571] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.459054] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.469261] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.469277] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.469310] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.470001] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.470008] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.470011] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.470060] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.470112] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.470158] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.470202] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.470251] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.470295] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.470340] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.470384] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.470428] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.470518] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.470561] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.470579] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.470597] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.470615] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.470632] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.470650] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.470668] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.470687] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.470706] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.470724] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.470742] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.470761] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.470778] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.470796] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.470813] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned machine # [ 0.470830] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned machine # [ 0.470848] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.470866] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.470891] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.470896] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.470899] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.511957] pci 0000:00:07.0: enabling device (0000 -> 0002) machine # [ 0.534868] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.545797] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.548885] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.550780] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.560542] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002) machine # [ 0.562728] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002) machine # [ 0.572507] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.574315] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.578094] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.587642] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.590094] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.604532] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.606540] msm_serial: driver initialized machine # [ 0.606678] SuperH (H)SCI(F) driver initialized machine # [ 0.606740] STM32 USART driver initialized machine # [ 0.645571] loop: module loaded machine # [ 0.645776] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 0.646645] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.659948] megasas: 07.734.00.00-rc1 machine # [ 0.660811] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.662896] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.662916] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.668458] Using buffer write method machine # [ 0.668534] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.670130] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.670193] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.685562] Using buffer write method machine # [ 0.685592] Concatenating MTD devices: machine # [ 0.685594] (0): "0.flash" machine # [ 0.685597] (1): "0.flash" machine # [ 0.685599] into device "0.flash" machine # [ 0.996701] Freeing initrd memory: 26088K machine # [ 1.003654] tun: Universal TUN/TAP device driver, 1.6 machine # [ 1.006870] thunder_xcv, ver 1.0 machine # [ 1.006899] thunder_bgx, ver 1.0 machine # [ 1.006920] nicpf, ver 1.0 machine # [ 1.009590] e1000: Intel(R) PRO/1000 Network Driver machine # [ 1.009596] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 1.009627] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 1.009636] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 1.009663] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 1.009666] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 1.009688] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 1.009692] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 1.009840] sky2: driver version 1.30 machine # [ 1.018018] usbcore: registered new interface driver usb-storage machine # [ 1.018134] usbcore: registered new interface driver usbserial_generic machine # [ 1.018146] usbserial: USB Serial support registered for generic machine # [ 1.018821] hv_vmbus: registering driver hyperv_keyboard machine # [ 1.022788] ehci-pci 0000:00:07.0: EHCI Host Controller machine # [ 1.022818] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1 machine # [ 1.022996] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000 machine # [ 1.026340] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 1.026365] rtc-pl031 9010000.pl031: setting system clock to 2026-10-22T02:58:17 UTC (1792637897) machine # [ 1.026696] i2c_dev: i2c /dev entries driver machine # [ 1.032656] sdhci: Secure Digital Host Controller Interface driver machine # [ 1.032662] sdhci: Copyright(c) Pierre Ossman machine # [ 1.032966] Synopsys Designware Multimedia Card Interface Driver machine # [ 1.033369] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 1.037933] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00 machine # [ 1.038289] hub 1-0:1.0: USB hub found machine # [ 1.038305] hub 1-0:1.0: 6 ports detected machine # [ 1.038739] hid: raw HID events driver (C) Jiri Kosina machine # [ 1.039023] usbcore: registered new interface driver usbhid machine # [ 1.039027] usbhid: USB HID core driver machine # [ 1.044065] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 1.045815] drop_monitor: Initializing network drop monitor service machine # [ 1.045981] NET: Registered PF_INET6 protocol family machine # [ 1.046586] Segment Routing with IPv6 machine # [ 1.046598] In-situ OAM (IOAM) with IPv6 machine # [ 1.046625] NET: Registered PF_PACKET protocol family machine # [ 1.046710] 9pnet: Installing 9P2000 support machine # [ 1.046753] Key type dns_resolver registered machine # [ 1.058872] registered taskstats version 1 machine # [ 1.059040] Loading compiled-in X.509 certificates machine # [ 1.068272] Demotion targets for Node 0: null machine # [ 1.068396] Key type .fscrypt registered machine # [ 1.068399] Key type fscrypt-provisioning registered machine # [ 1.068505] ima: No TPM chip found, activating TPM-bypass! machine # [ 1.068528] ima: Allocated hash algorithm: sha1 machine # [ 1.068558] ima: No architecture policies found machine # [ 1.069345] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 1.093775] clk: Disabling unused clocks machine # [ 1.093796] PM: genpd: Disabling unused power domains machine # [ 1.099899] Freeing unused kernel memory: 7808K machine # [ 1.100108] Run /init as init process machine # [ 1.118585] fuse: module verification failed: signature and/or required key missing - tainting kernel machine # [ 1.122803] fuse: init (API version 7.45) machine # [ 1.126433] virtiofs virtio6: discovered new tag: nix-store machine # [ 1.128154] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 1.144843] virtiofs virtio7: discovered new tag: shared machine # [ 1.145763] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 1.148660] virtiofs virtio8: discovered new tag: xchg machine # [ 1.149421] virtiofs virtio8: virtio_fs_setup_dax: No cache capability machine # [ 1.162118] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.162699] systemd[1]: systemd 263-558da31 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.162715] systemd[1]: Detected virtualization qemu. machine # [ 1.162737] systemd[1]: Detected architecture arm64. machine # [ 1.162743] systemd[1]: Running in initrd. machine # [ 1.163034] systemd[1]: Initializing machine ID from random generator. machine # [ 1.171171] systemd[1]: Hostname set to . machine # [ 1.270092] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.287239] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.332102] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.341524] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.341739] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.341771] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.341796] systemd[1]: Reached target Path Units. machine # [ 1.341811] systemd[1]: Reached target Slice Units. machine # [ 1.341827] systemd[1]: Reached target Swaps. machine # [ 1.341841] systemd[1]: Reached target Timer Units. machine # [ 1.342008] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.342178] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.342339] systemd[1]: Listening on Journal Sockets. machine # [ 1.342415] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.342573] systemd[1]: Listening on udev Varlink Socket. machine # [ 1.342612] systemd[1]: Reached target Socket Units. machine # [ 1.354098] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.354190] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.360300] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.374906] systemd[1]: Starting Journal Service... machine # [ 1.387669] systemd[1]: Starting Load Kernel Modules... machine # [ 1.387837] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.419431] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.426909] systemd-journald[71]: Collecting audit messages is disabled. machine # [ 1.428325] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.450138] 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.467866] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.468785] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.543470] 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.544615] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.546547] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.546781] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.553374] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0 machine # [ 1.553650] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.553659] [drm] features: -context_init machine # [ 1.554461] [drm] number of scanouts: 1 machine # [ 1.554485] [drm] number of cap sets: 0 machine # [ 1.564030] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.583740] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic machine # [ 1.583758] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0 machine # [ 1.619472] Console: switching to colour frame buffer device 160x50 machine # [ 1.614029] systemd-modules-load[73]: Inserted module 'dm_mod' machine # [ 1.631495] systemd[1]: Started Journal Service. machine # [ 1.637791] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.627133] systemd-modules-load[73]: Module 'virtio_balloon' is built in machine # [ 1.629110] systemd-modules-load[73]: Module 'virtio_console' is built in machine # [ 1.636632] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.640399] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.649917] systemd[1]: Reached target Local File Systems. machine # [ 1.651042] systemd-modules-load[73]: Inserted module 'virtio_gpu' machine # [ 1.667122] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.654670] systemd-modules-load[73]: Module 'virtio_rng' is built in machine # [ 1.656392] systemd[1]: Starting Create System Files and Directories... machine # [ 1.664159] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.665736] systemd[1]: Finished Load Kernel Modules. machine # [ 1.690629] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.725070] systemd[1]: Finished Create System Files and Directories. machine # [ 1.749373] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.769955] systemd-udevd[79]: Using default interface naming scheme 'v261'. machine # [ 1.818955] 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.824396] 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.813013] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.913478] systemd[1]: Starting Virtual Console Setup... machine # [ 2.001587] systemd-vconsole-setup[98]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.005688] systemd[1]: Finished Virtual Console Setup. machine # [ 2.717613] (udev-worker)[104]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.730574] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.731548] systemd[1]: Reached target System Initialization. machine # [ 2.732559] systemd[1]: Reached target Basic System. machine # [ 2.751135] (udev-worker)[91]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.756388] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.767939] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.772194] systemd[1]: Reached target Initrd Root Device. machine # [ 2.775547] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 2.827846] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 2.835985] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.839328] systemd[1]: Mounting /sysroot... machine # [ 2.900529] EXT4-fs (vda): mounted filesystem 46ffe815-2156-426f-8d85-6001848781d3 r/w with ordered data mode. Quota mode: none. machine # [ 2.889935] systemd[1]: Mounted /sysroot. machine # [ 2.892569] systemd[1]: Reached target Initrd Root File System. machine # [ 2.895959] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.936536] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.940935] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.945466] systemd[1]: Reloading... machine # [ 3.150650] systemd[1]: Reloading finished in 206 ms. machine # [ 3.187718] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace... machine # [ 3.193192] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace... machine # [ 3.198872] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.202499] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.205466] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.407772] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.419783] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.434411] systemd[1]: Mounting /sysroot/run... machine # [ 3.451992] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.483373] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.522726] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.539892] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.542478] systemd[1]: Mounted /sysroot/run. machine # [ 3.562308] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.573268] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.578884] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.610040] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.611571] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.075347] (udev-worker)[103]: mtd0ro: Failed to find and pin callout binary "/nix/store/2y5k9a77439362ij1h4pbjx5g55dn8d2-systemd-263-558da31/lib/udev/mtd_probe": No such file or directory machine # [ 4.082035] (udev-worker)[103]: mtd0ro: /etc/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory machine # [ 4.112945] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.115407] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.116883] systemd[1]: Stopping Virtual Console Setup... machine # [ 4.120308] systemd[1]: Starting Virtual Console Setup... machine # [ 4.147960] systemd-vconsole-setup[150]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 4.151949] systemd[1]: Finished Virtual Console Setup. machine # [ 4.406728] systemd[1]: Mounting /sysroot/nix/store... machine # [ 4.453311] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.455912] systemd[1]: Reached target Initrd File Systems. machine # [ 4.460861] systemd[1]: Starting Find NixOS closure... machine # [ 4.472516] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.514634] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.517390] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 4.531936] systemd[1]: Finished Find NixOS closure. machine # [ 4.535236] systemd[1]: Reached target Initrd Default Target. machine # [ 4.537356] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.568891] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.572904] systemd[1]: Stopped target Basic System. machine # [ 4.573941] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.575434] systemd[1]: Stopped target Path Units. machine # [ 4.578626] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.580484] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.584888] systemd[1]: Stopped target Slice Units. machine # [ 4.588866] systemd[1]: Stopped target Socket Units. machine # [ 4.590663] systemd[1]: Stopped target System Initialization. machine # [ 4.593484] systemd[1]: Stopped target Swaps. machine # [ 4.596249] systemd[1]: Stopped target Timer Units. machine # [ 4.601377] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.602371] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.604432] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.607885] systemd[1]: Stopped Find NixOS closure. machine # [ 4.612247] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.614512] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.615632] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.616627] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.617681] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.618439] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.619582] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.626901] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.631769] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.637061] systemd[1]: Stopped target Local File Systems. machine # [ 4.637943] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.638903] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.639912] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.644490] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.647099] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.648229] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.649789] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.652464] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.654228] systemd[1]: systemd-udevd.service: Consumed 1.381s CPU time over 2.962s wall clock time, 25.4M memory peak. machine # [ 4.655782] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.656936] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.657889] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully. machine # [ 4.658918] systemd[1]: Closed udev Varlink Socket. machine # [ 4.659632] systemd[1]: Starting Cleanup udev Database... machine # [ 4.665371] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.668363] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.672687] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.674081] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.675151] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.680175] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.681123] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.682151] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.712882] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.715871] systemd[1]: Finished Cleanup udev Database. machine # [ 4.717562] systemd[1]: Reached target Switch Root. machine # [ 4.720331] systemd[1]: Starting NixOS Activation... machine # [ 4.800760] initrd-nixos-activation-start[173]: booting system configuration /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test machine # [ 4.834380] initrd-nixos-activation-start[173]: running activation script... machine # [ 5.071366] initrd-nixos-activation-start[196]: setting up /etc... machine # [ 5.195791] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 5.199100] systemd[1]: Finished NixOS Activation. machine # [ 5.204458] systemd[1]: Starting Switch Root... machine # [ 5.225024] systemd[1]: Switching root. machine # [ 5.412929] systemd-journald[71]: Received SIGTERM from PID 1 (systemd). machine # [ 5.510736] NET: Registered PF_VSOCK protocol family machine # [ 5.584189] systemd[1]: systemd 263-558da31 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.585067] systemd[1]: Detected virtualization qemu. machine # [ 5.585108] systemd[1]: Detected architecture arm64. machine # [ 5.585171] systemd[1]: Detected first boot. machine # [ 5.586543] systemd[1]: Initializing machine ID from random generator. machine # [ 5.710749] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 5.856538] systemd[1]: Applying preset policy. machine # [ 6.068572] systemd[1]: Populated /etc with preset unit settings. machine # [ 6.269523] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 6.269967] systemd[1]: Stopped initrd-switch-root.service. machine # [ 6.272773] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 6.274080] systemd[1]: Created slice Slice /system/getty. machine # [ 6.274955] systemd[1]: Created slice User and Session Slice. machine # [ 6.280213] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 6.280618] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 6.281224] systemd[1]: Expecting device /dev/hvc0... machine # [ 6.281812] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 6.282401] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 6.282952] systemd[1]: Stopped target initrd-fs.target. machine # [ 6.288865] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 6.289216] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 6.289485] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 6.289747] systemd[1]: Reached target Path Units. machine # [ 6.289997] systemd[1]: Reached target Remote File Systems. machine # [ 6.290232] systemd[1]: Reached target Slice Units. machine # [ 6.290481] systemd[1]: Reached target Swaps. machine # [ 6.301504] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 6.304907] systemd[1]: Listening on Process Core Dump Socket. machine # [ 6.306310] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 6.309782] systemd[1]: Listening on Factory Reset Management. machine # [ 6.310388] systemd[1]: Listening on Hostname Service Socket. machine # [ 6.316589] systemd[1]: Starting Journal Log Access Socket... machine # [ 6.317560] systemd[1]: Listening on Journal Audit Socket. machine # [ 6.321042] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 6.321837] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 6.322349] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.322982] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 6.333051] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 6.333700] systemd[1]: Listening on udev Varlink Socket. machine # [ 6.338162] systemd[1]: Mounting Huge Pages File System... machine # [ 6.342468] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 6.351946] systemd[1]: Mounting Kernel Debug File System... machine # [ 6.370122] systemd[1]: Mounting Kernel Trace File System... machine # [ 6.380255] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 6.384240] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 6.401187] systemd[1]: Mounting Kernel Configuration File System... machine # [ 6.401756] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 6.411740] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.412290] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 6.439618] systemd[1]: Mounting FUSE Control File System... machine # [ 6.440203] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.469061] systemd[1]: Starting Journal Service... machine # [ 6.493904] systemd[1]: Starting Load Kernel Modules... machine # [ 6.523388] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 6.543802] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 6.544249] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.565133] systemd[1]: Starting Coldplug All udev Devices... machine # [ 6.580508] systemd-journald[267]: Collecting audit messages is enabled. machine # [ 6.586521] systemd[1]: Listening on Journal Log Access Socket. machine # [ 6.587012] systemd[1]: Mounted Huge Pages File System. machine # [ 6.571491] systemd[1]: Queued start job for default target Multi-User System. machine # [ 6.574057] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0. machine # [ 6.575354] systemd[1]: Unnecessary job was removed for /sys/devices/platform/9000000.pl011/9000000.pl011:0/9000000.pl011:0.0/tty/ttyAMA0. machine # [ 6.583550] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 6.591634] systemd-modules-load[268]: Module 'atkbd' is built in machine # [ 6.613105] systemd[1]: Started Journal Service. machine # [ 6.602341] systemd-modules-load[268]: Module 'loop' is built in machine # [ 6.603396] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 6.611665] systemd[1]: Mounted Kernel Debug File System. machine # [ 6.616776] systemd[1]: Mounted Kernel Trace File System. machine # [ 6.617753] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 6.618767] systemd[1]: Finished Load Kernel Modules. machine # [ 6.649860] systemd[1]: Starting Firewall... machine # [ 6.666711] systemd[1]: Starting Apply Kernel Variables... machine # [ 6.685888] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 6.694309] systemd[1]: Mounted FUSE Control File System. machine # [ 6.699098] systemd[1]: Mounted Kernel Configuration File System. machine # [ 6.715170] EXT4-fs (vda): re-mounted 46ffe815-2156-426f-8d85-6001848781d3. machine # [ 6.721639] systemd-oomd[269]: No swap; memory pressure usage will be degraded machine # [ 6.745310] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 6.754148] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 6.755224] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 6.772357] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 6.773471] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 6.793602] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 6.794627] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.858762] systemd[1]: Finished Apply Kernel Variables. machine # [ 6.904919] systemd-journald[267]: Received client request to flush runtime journal. machine # [ 6.964723] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 6.965733] systemd[1]: Reached target First Boot Complete. machine # [ 6.972435] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 6.978347] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 6.981014] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 7.082805] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 7.083898] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 7.089631] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 7.244081] systemd-udevd[309]: Using default interface naming scheme 'v261'. machine # [ 7.260619] systemd[1]: Mounting /run/wrappers... machine # [ 7.338049] systemd[1]: Mounted /run/wrappers. machine # [ 7.338914] systemd[1]: Reached target Local File Systems. machine # [ 7.344164] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 7.351382] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 7.352615] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 7.362078] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 7.365934] systemd[1]: Starting Create System Files and Directories... machine # [ 7.416876] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 7.600748] systemd[1]: Finished Create System Files and Directories. machine # [ 7.611107] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 7.624181] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 7.637956] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 7.648175] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 7.745244] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 7.796556] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 7.806394] systemd[1]: Starting Update is Completed... machine # [ 7.867837] systemd[1]: Finished Update is Completed. machine # [ 8.095742] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 8.171066] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 8.222059] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 8.230472] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 8.420348] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 8.473793] systemd[1]: Finished Coldplug All udev Devices. machine # [ 8.477119] systemd[1]: Reached target System Initialization. machine # [ 8.478117] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 8.479143] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 8.489513] systemd[1]: Reached target Timer Units. machine # [ 8.490335] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 8.491279] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 8.501114] systemd[1]: Reached target Socket Units. machine # [ 8.501946] systemd[1]: Reached target Basic System. machine # [ 8.502710] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 8.503760] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 8.516566] systemd[1]: Starting Post-Boot Actions... machine # [ 8.537467] systemd[1]: Started Reset console on configuration changes. machine # [ 8.588919] systemd[1]: Starting resolvconf update... machine # [ 8.599729] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 8.639866] systemd[1]: Started backdoor.service. machine # [ 8.664196] systemd[1]: Starting D-Bus System Message Bus... machine # [ 8.708413] systemd[1]: Finished Post-Boot Actions. machine # [ 8.721841] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 8.766436] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 8.781100] nsncd[435]: Oct 22 02:58:25.269 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 8.800262] systemd[1]: Reached target User and Group Name Lookups. machine # [ 8.801744] (udev-worker)[334]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 8.829366] (udev-worker)[334]: Network interface NamePolicy= disabled on kernel command line. machine # [ 8.830693] systemd[1]: Starting User Login Management... machine # [ 8.853970] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # connecting to host... machine # [ 8.944869] (udev-worker)[337]: Network interface NamePolicy= disabled on kernel command line. machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 9.30 seconds) machine: (finished: waiting for the VM to finish booting, in 9.76 seconds) machine # [ 9.005651] dbus-broker-launch[447]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 9.020304] dbus-broker-launch[447]: NSS returned no entry for 'systemd-timesync' machine # [ 9.021447] dbus-broker-launch[447]: Invalid user-name in /nix/store/dzw73qhbffhj63s97znfqy5r1pmm0dxp-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 9.068948] systemd[1]: Started D-Bus System Message Bus. machine # [ 9.132660] systemd-logind[468]: New seat seat0. machine # [ 9.139493] dbus-broker-launch[447]: Ready machine # [ 9.147512] systemd[1]: Started User Login Management. machine # [ 9.153395] systemd[1]: Starting linger-users.service... machine # [ 9.342507] systemd[1]: Finished Firewall. machine # [ 9.381111] systemd[1]: Created slice Slice /user/1001. machine # [ 9.382052] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 9.383066] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 9.457185] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 9.478463] systemd[1]: Stopping User and Group Name Lookups... machine # [ 9.479543] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 9.505710] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 9.506805] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 9.507776] systemd[1]: Finished linger-users.service. machine # [ 9.571109] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 9.596948] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 9.621507] systemd[1]: nscd.service: Deactivated successfully. machine # [ 9.622855] (systemd)[572]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 9.641002] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 9.642031] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 9.642974] systemd-logind[468]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # [ 9.664289] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 9.665338] systemd[1]: Starting User Manager for UID 1001... machine # [ 9.666192] systemd-logind[468]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 9.688666] mousedev: PS/2 mouse device common for all mice machine # [ 9.693694] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 9.846268] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 9.847683] nsncd[567]: Oct 22 02:58:26.203 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 9.925618] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 9.926649] systemd[1]: Reached target User and Group Name Lookups. machine # [ 9.927578] systemd[1]: Finished resolvconf update. machine # [ 9.960139] systemd[1]: Reached target Preparation for Network. machine # [ 9.961096] systemd[1]: Starting DHCP Client... machine # [ 9.961751] systemd[1]: Starting Address configuration of eth1... machine # [ 9.962589] systemd[1]: Starting Extra networking commands.... machine # [ 9.963394] systemd-logind[468]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 10.060312] systemd[572]: Queued start job for default target Main User Target. machine # [ 10.061489] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 10.161284] systemd[572]: Created slice User Application Slice. machine # [ 10.162352] systemd[572]: Started Daily Cleanup of User's Temporary Directories. machine # [ 10.208335] systemd[572]: Reached target Paths. machine # [ 10.235291] systemd[572]: Reached target Timers. machine # [ 10.240502] systemd[572]: Starting D-Bus User Message Bus Socket... machine # [ 10.241652] systemd[572]: Starting Create User Files and Directories... machine # [ 10.242708] systemd[572]: Finished Create User Files and Directories. machine # [ 10.243637] systemd[572]: Listening on D-Bus User Message Bus Socket. machine # [ 10.246419] systemd[572]: Reached target Sockets. machine # [ 10.264124] systemd[572]: Reached target Basic System. machine # [ 10.265025] systemd[1]: Started User Manager for UID 1001. machine # [ 10.265840] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 10.266819] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 10.267740] systemd[572]: Reached target Main User Target. machine # [ 10.292436] systemd[572]: Startup finished in 544ms. machine # [ 10.353268] network-addresses-eth1-start[594]: adding address 192.168.1.1/24... done machine # [ 10.378211] network-addresses-eth1-start[594]: adding address 2001:db8:1::1/64... done machine # [ 10.455843] systemd[1]: Finished Address configuration of eth1. machine # [ 10.860597] dhcpcd[610]: dhcpcd-10.3.2 starting machine # [ 10.895739] dhcpcd[674]: dev: loaded udev machine # [ 10.954306] 8021q: 802.1Q VLAN Support v1.8 machine # [ 10.954682] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 11.081328] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 11.087517] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 11.088008] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 11.090282] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 11.090610] cfg80211: failed to load regulatory.db machine # [ 11.190071] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3 machine # [ 11.277054] systemd[1]: Finished Extra networking commands.. machine # [ 11.278048] systemd[1]: Reached target Network. machine # [ 11.308386] systemd[1]: Starting Permit User Sessions... machine # [ 11.537014] systemd[1]: Finished Permit User Sessions. machine # [ 11.546277] systemd[1]: Started Getty on tty1. machine # [ 11.547125] systemd[1]: Reached target Login Prompts. machine # [ 11.599226] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 11.621440] systemd[1]: Starting Virtual Console Setup... machine # [ 11.650828] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 11.643216] dhcpcd[674]: eth0: waiting for carrier machine # [ 11.652128] dhcpcd[674]: eth0: carrier acquired machine # [ 11.668508] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 11.669710] systemd[1]: Stopped Virtual Console Setup. machine # [ 11.679062] systemd[1]: Starting Virtual Console Setup... machine # [ 11.680380] systemd-logind[468]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 11.686090] dhcpcd[674]: DUID 00:01:00:01:32:6c:38:54:52:54:00:12:34:56 machine # [ 11.687095] dhcpcd[674]: eth0: IAID 00:12:34:56 machine # [ 11.687774] dhcpcd[674]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 11.797057] systemd-vconsole-setup[706]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 11.803903] systemd[1]: Finished Virtual Console Setup. machine # [ 12.862537] dhcpcd[674]: eth0: soliciting a DHCP lease machine # [ 12.865124] dhcpcd[674]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 12.872441] dhcpcd[674]: eth0: probing address 10.0.2.15/24 machine # [ 13.768455] dhcpcd[674]: eth0: soliciting an IPv6 router machine # [ 13.770375] dhcpcd[674]: eth0: Router Advertisement from fe80::2 machine # [ 13.771758] dhcpcd[674]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 13.773813] dhcpcd[674]: eth0: adding route to fec0::/64 machine # [ 13.775071] dhcpcd[674]: eth0: adding default route via fe80::2 machine # [ 17.102117] dhcpcd[674]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 17.102340] dhcpcd[674]: eth0: adding route to 10.0.2.0/24 machine # [ 17.102421] dhcpcd[674]: eth0: adding default route via 10.0.2.2 machine # [ 17.214752] systemd[1]: Started DHCP Client. machine # [ 17.217228] systemd[1]: Reached target Multi-User System. machine # [ 17.218282] systemd[1]: Startup finished in 1.086s (kernel) + 4.384s (initrd) + 11.745s (userspace) = 17.216s. machine: (finished: waiting for unit multi-user.target, in 18.37 seconds) machine: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 17.862486] nixos[822]: switching to system configuration /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test machine # [ 17.865330] systemd[1]: Stopped target Remote File Systems. machine # [ 17.867044] systemd[1]: Stopped target Local File Systems. machine # activating the configuration... machine # setting up /etc... machine # [ 18.149578] systemd[1]: Reload requested from client PID 822 ('.switch-to-conf') (unit backdoor.service)... machine # [ 18.151551] systemd[1]: Reloading... machine # [ 18.450469] systemd[1]: Reloading finished in 297 ms. machine # reloading user units for usertest... machine # [ 18.502777] systemd[572]: Created slice User Core Session Slice. machine # [ 18.505759] systemd[572]: Starting D-Bus User Message Bus... machine # [ 18.538732] dbus-broker-launch[893]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/dzw73qhbffhj63s97znfqy5r1pmm0dxp-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 18.542147] dbus-broker-launch[893]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/dzw73qhbffhj63s97znfqy5r1pmm0dxp-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 18.546033] dbus-broker-launch[893]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/dzw73qhbffhj63s97znfqy5r1pmm0dxp-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 18.549140] dbus-broker-launch[893]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/dzw73qhbffhj63s97znfqy5r1pmm0dxp-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 18.554066] dbus-broker-launch[893]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 18.556256] dbus-broker-launch[893]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 18.557973] systemd[572]: Started D-Bus User Message Bus. machine # [ 18.560498] dbus-broker-launch[893]: Ready machine # [ 18.600872] systemd[572]: Reexecution requested from client PID 892 ('switch-to-confi')... machine # [ 18.604954] systemd[572]: Reexecuting. machine # [ 18.663103] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 18.773219] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 18.780089] systemd[572]: Reload requested from client PID 892 ('switch-to-confi')... machine # [ 18.781537] systemd[572]: Reloading... machine # [ 18.887021] systemd[572]: Reloading finished in 103 ms. machine # [ 18.904262] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 18.914723] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 18.915788] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 18.919524] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 18.946791] systemd[572]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 18.957817] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 19.036356] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 19.041380] systemd[1]: Reached target Reactivate sysinit units. machine # [ 19.044800] systemd[1]: Reached target Remote File Systems. machine # [ 19.052384] systemd[1]: Starting linger-users.service... machine # [ 19.055817] systemd[1]: Reached target Local File Systems. machine # [ 19.061455] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 19.067515] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 19.072406] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 19.073724] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 19.075939] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 19.082423] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.083800] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.085209] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.086529] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 19.147027] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 19.151357] systemd[1]: Finished linger-users.service. machine # [ 19.272604] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 19.276003] systemd[1]: Finished Create SUID/SGID Wrappers. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 19.532091] nixos[822]: finished switching to system configuration /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test machine: (finished: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/bin/switch-to-configuration test, in 1.93 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.03 seconds) machine: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/4abp65kirv7qfjfk7373ih47xb9njczd-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/4abp65kirv7qfjfk7373ih47xb9njczd-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 19.786308] nixos[970]: switching to system configuration /nix/store/4abp65kirv7qfjfk7373ih47xb9njczd-nixos-system-other-test machine # [ 19.789196] systemd[1]: Stopped target Local File Systems. machine # activating the configuration... machine # [ 19.792086] systemd[1]: Stopped target Remote File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 20.060740] systemd[1]: Reload requested from client PID 970 ('.switch-to-conf') (unit backdoor.service)... machine # [ 20.062329] systemd[1]: Reloading... machine # [ 20.372104] systemd[1]: Reloading finished in 308 ms. machine # reloading user units for usertest... machine # [ 20.460514] systemd[572]: Reexecution requested from client PID 1041 ('switch-to-confi')... machine # [ 20.463993] systemd[572]: Reexecuting. machine # [ 20.523124] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.640716] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.647711] systemd[572]: Reload requested from client PID 1041 ('switch-to-confi')... machine # [ 20.651243] systemd[572]: Reloading... machine # [ 20.757081] systemd[572]: Reloading finished in 106 ms. machine # [ 20.772249] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 20.783532] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 20.784905] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 20.788590] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 20.819222] systemd[572]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 20.824818] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 20.825827] systemd[1]: Stopping Reactivate sysinit units... machine # [ 20.826667] systemd[1]: Reached target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service machine # [ 20.830419] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 20.831640] dbus-broker-launch[447]: Caught SIGHUP, trigger reload. machine # [ 20.837909] dbus-broker-launch[447]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 20.839997] dbus-broker-launch[447]: NSS returned no entry for 'systemd-timesync' machine # [ 20.841296] dbus-broker-launch[447]: Invalid user-name in /nix/store/5q8ggmpjhlkgybj5rgsynhr5va1f69bw-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 20.856976] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 20.863041] systemd[1]: Stopping Address configuration of eth1... machine # [ 20.894101] network-addresses-eth1-pre-stop[1053]: deleting address 192.168.1.1/24... done machine # [ 20.900347] network-addresses-eth1-pre-stop[1053]: deleting address 2001:db8:1::1/64... done machine # [ 20.906998] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 20.911375] systemd[1]: Stopped Address configuration of eth1. machine # [ 20.913628] systemd[1]: Starting Address configuration of eth1... machine # [ 20.952809] network-addresses-eth1-start[1058]: adding address 192.168.1.2/24... done machine # [ 20.959083] network-addresses-eth1-start[1058]: adding address 2001:db8:1::2/64... done machine # [ 20.977394] systemd[1]: Finished Address configuration of eth1. machine # [ 20.983185] systemd[1]: Reached target Local File Systems. machine # [ 20.989217] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 21.000653] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 21.001578] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 21.002872] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 21.021104] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 21.022810] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.031848] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.036432] systemd[1]: Reached target Remote File Systems. machine # [ 21.037292] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.038609] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 21.223392] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 21.227814] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 21.230228] systemd[1]: Starting linger-users.service... machine # [ 21.262192] linger-users-start[1131]: id: ‘usertest’: no such user machine # [ 21.264371] linger-users-start[1129]: Removing linger for missing user usertest machine # [ 21.270777] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 21.272648] systemd[1]: Finished linger-users.service. machine # [ 21.529878] nixos[970]: finished switching to system configuration /nix/store/4abp65kirv7qfjfk7373ih47xb9njczd-nixos-system-other-test machine: (finished: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/4abp65kirv7qfjfk7373ih47xb9njczd-nixos-system-other-test/bin/switch-to-configuration test, in 1.97 seconds) subtest: services machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 21.748886] nixos[1137]: switching to system configuration /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test machine # [ 21.753335] systemd[1]: Stopped target Remote File Systems. machine # [ 21.754864] systemd[1]: Stopped target Local File Systems. machine # [ 22.051941] systemd[1]: Reload requested from client PID 1137 ('.switch-to-conf') (unit backdoor.service)... machine # [ 22.054371] systemd[1]: Reloading... machine # [ 22.381186] systemd[1]: Reloading finished in 325 ms. machine # [ 22.465597] systemd[572]: Reexecution requested from client PID 1206 ('switch-to-confi')... machine # [ 22.470029] systemd[572]: Reexecuting. machine # [ 22.527977] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.640258] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.647599] systemd[572]: Reload requested from client PID 1206 ('switch-to-confi')... machine # [ 22.650085] systemd[572]: Reloading... machine # [ 22.757655] systemd[572]: Reloading finished in 106 ms. machine # [ 22.772262] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.781766] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 22.784379] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 22.786573] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 22.817304] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 22.821715] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 22.826517] systemd[1]: Stopping Reactivate sysinit units... machine # [ 22.827482] systemd[1]: Reached target Reactivate sysinit units. machine # [ 22.829623] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 22.832793] dbus-broker-launch[447]: Caught SIGHUP, trigger reload. machine # [ 22.834811] dbus-broker-launch[447]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 22.837177] dbus-broker-launch[447]: NSS returned no entry for 'systemd-timesync' machine # [ 22.838291] dbus-broker-launch[447]: Invalid user-name in /nix/store/dzw73qhbffhj63s97znfqy5r1pmm0dxp-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 22.863890] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 22.870452] systemd[1]: Stopping Address configuration of eth1... machine # [ 22.905817] network-addresses-eth1-pre-stop[1218]: deleting address 192.168.1.2/24... done machine # [ 22.912506] network-addresses-eth1-pre-stop[1218]: deleting address 2001:db8:1::2/64... done machine # [ 22.919658] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 22.922364] systemd[1]: Stopped Address configuration of eth1. machine # [ 22.926950] systemd[1]: Starting Address configuration of eth1... machine # [ 22.970711] network-addresses-eth1-start[1223]: adding address 192.168.1.1/24... done machine # [ 22.978062] network-addresses-eth1-start[1223]: adding address 2001:db8:1::1/64... done machine # [ 22.987428] systemd[1]: Finished Address configuration of eth1. machine # [ 22.991620] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.995113] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 22.998522] systemd[1]: Reached target Remote File Systems. machine # [ 23.001271] systemd[1]: Reached target Local File Systems. machine # [ 23.006998] systemd[1]: Starting linger-users.service... machine # [ 23.019166] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 23.028716] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 23.031764] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 23.036552] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 23.044761] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 23.050700] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.055234] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.078226] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 23.081192] systemd[1]: Finished linger-users.service. machine # [ 23.229534] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 23.231426] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 23.489742] nixos[1137]: finished switching to system configuration /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.96 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 23.707881] nixos[1292]: switching to system configuration /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test machine # [ 23.710675] systemd[1]: Stopped target Remote File Systems. machine # [ 23.713869] systemd[1]: Stopped target Local File Systems. machine # [ 23.985728] systemd[1]: Reload requested from client PID 1292 ('.switch-to-conf') (unit backdoor.service)... machine # [ 23.987717] systemd[1]: Reloading... machine # [ 24.300797] systemd[1]: Reloading finished in 310 ms. machine # [ 24.412747] systemd[572]: Reexecution requested from client PID 1361 ('switch-to-confi')... machine # [ 24.416073] systemd[572]: Reexecuting. machine # [ 24.470946] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.578754] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.585627] systemd[572]: Reload requested from client PID 1361 ('switch-to-confi')... machine # [ 24.589700] systemd[572]: Reloading... machine # [ 24.694948] systemd[572]: Reloading finished in 106 ms. machine # [ 24.712285] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.721808] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 24.724199] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 24.726624] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 24.761508] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 24.765794] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 24.767873] systemd[1]: Stopping Reactivate sysinit units... machine # [ 24.770265] systemd[1]: Reached target Reactivate sysinit units. machine # [ 24.774876] systemd[1]: Reached target Remote File Systems. machine # [ 24.779219] systemd[1]: Starting linger-users.service... machine # [ 24.784294] systemd[1]: Reached target Local File Systems. machine # [ 24.793178] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 24.794893] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 24.795710] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 24.807474] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 24.816785] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 24.818497] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.827070] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.834193] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.835609] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 24.879880] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 24.884928] systemd[1]: Finished linger-users.service. machine # [ 25.017284] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 25.020505] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 25.276173] nixos[1292]: finished switching to system configuration /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.79 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 25.501389] nixos[1433]: switching to system configuration /nix/store/fs6npkhwlp2gfhxh7f3hxxzvllnrsw1c-nixos-system-machine-test machine # [ 25.504134] systemd[1]: Stopped target Remote File Systems. machine # [ 25.506559] systemd[1]: Stopped target Local File Systems. machine # [ 25.792460] systemd[1]: Reload requested from client PID 1433 ('.switch-to-conf') (unit backdoor.service)... machine # [ 25.794502] systemd[1]: Reloading... machine # [ 26.107391] systemd[1]: Reloading finished in 311 ms. machine # [ 26.194211] systemd[572]: Reexecution requested from client PID 1502 ('switch-to-confi')... machine # [ 26.198904] systemd[572]: Reexecuting. machine # [ 26.251418] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.362583] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.369451] systemd[572]: Reload requested from client PID 1502 ('switch-to-confi')... machine # [ 26.371690] systemd[572]: Reloading... machine # [ 26.477239] systemd[572]: Reloading finished in 105 ms. machine # [ 26.492208] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.502166] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 26.504651] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 26.506813] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 26.539960] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 26.544857] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 26.545843] systemd[1]: Stopping Reactivate sysinit units... machine # [ 26.546667] systemd[1]: Reached target Reactivate sysinit units. machine # [ 26.552792] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.554272] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 26.557878] systemd[1]: Reached target Local File Systems. machine # [ 26.560837] systemd[1]: Reached target Remote File Systems. machine # [ 26.562927] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 26.571434] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 26.577086] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 26.578392] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 26.583579] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 26.585789] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.587152] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.751472] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 26.753553] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 26.759714] systemd[1]: Starting linger-users.service... machine # [ 26.763284] systemd[1]: Starting test.service... machine # [ 26.807772] systemd[1]: Finished test.service. machine # [ 26.827728] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 26.830019] systemd[1]: Finished linger-users.service. machine # [ 27.087842] nixos[1433]: finished switching to system configuration /nix/store/fs6npkhwlp2gfhxh7f3hxxzvllnrsw1c-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 27.305747] nixos[1575]: switching to system configuration /nix/store/fs6npkhwlp2gfhxh7f3hxxzvllnrsw1c-nixos-system-machine-test machine # [ 27.308531] systemd[1]: Stopped target Remote File Systems. machine # [ 27.311610] systemd[1]: Stopped target Local File Systems. machine # [ 27.619931] systemd[1]: Reload requested from client PID 1575 ('.switch-to-conf') (unit backdoor.service)... machine # [ 27.628292] systemd[1]: Reloading... machine # [ 27.972884] systemd[1]: Reloading finished in 348 ms. machine # [ 28.086028] systemd[572]: Reexecution requested from client PID 1644 ('switch-to-confi')... machine # [ 28.090772] systemd[572]: Reexecuting. machine # [ 28.147855] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.263028] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.271116] systemd[572]: Reload requested from client PID 1644 ('switch-to-confi')... machine # [ 28.274750] systemd[572]: Reloading... machine # [ 28.384250] systemd[572]: Reloading finished in 110 ms. machine # [ 28.400292] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.410708] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 28.413336] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 28.415905] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 28.450062] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 28.454332] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 28.456409] systemd[1]: Stopping Reactivate sysinit units... machine # [ 28.457288] systemd[1]: Reached target Reactivate sysinit units. machine # [ 28.461922] systemd[1]: Reached target Local File Systems. machine # [ 28.466102] systemd[1]: Reached target Remote File Systems. machine # [ 28.468930] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.471387] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 28.477078] systemd[1]: Starting linger-users.service... machine # [ 28.479908] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 28.495965] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 28.496990] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 28.498292] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 28.502268] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 28.503902] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.508860] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.561774] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 28.564558] systemd[1]: Finished linger-users.service. machine # [ 28.697242] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 28.700910] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 28.955022] nixos[1575]: finished switching to system configuration /nix/store/fs6npkhwlp2gfhxh7f3hxxzvllnrsw1c-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.87 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 29.189524] nixos[1716]: switching to system configuration /nix/store/lzpwy4bhqy8di0nc5irkqrp6aap6agya-nixos-system-machine-test machine # [ 29.192693] systemd[1]: Stopped target Local File Systems. machine # [ 29.194716] systemd[1]: Stopped target Remote File Systems. machine # [ 29.501883] systemd[1]: Reload requested from client PID 1716 ('.switch-to-conf') (unit backdoor.service)... machine # [ 29.503907] systemd[1]: Reloading... machine # [ 29.863326] systemd[1]: Reloading finished in 357 ms. machine # [ 29.945391] systemd[572]: Reexecution requested from client PID 1785 ('switch-to-confi')... machine # [ 29.949363] systemd[572]: Reexecuting. machine # [ 29.995275] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.103248] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.110383] systemd[572]: Reload requested from client PID 1785 ('switch-to-confi')... machine # [ 30.113052] systemd[572]: Reloading... machine # [ 30.223183] systemd[572]: Reloading finished in 109 ms. machine # [ 30.236251] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.248598] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 30.251027] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 30.253397] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 30.284205] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 30.287844] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 30.289295] systemd[1]: Stopping Reactivate sysinit units... machine # [ 30.290118] systemd[1]: Reached target Reactivate sysinit units. machine # [ 30.294529] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.297560] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 30.300356] systemd[1]: Reached target Remote File Systems. machine # [ 30.303631] systemd[1]: Starting linger-users.service... machine # [ 30.308511] systemd[1]: Reached target Local File Systems. machine # [ 30.309347] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 30.327587] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 30.330790] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 30.332334] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 30.334599] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 30.336460] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.337770] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.399947] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 30.403567] systemd[1]: Finished linger-users.service. machine # [ 30.523491] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 30.527458] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 30.781686] nixos[1716]: finished switching to system configuration /nix/store/lzpwy4bhqy8di0nc5irkqrp6aap6agya-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 1.83 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 31.056347] nixos[1856]: switching to system configuration /nix/store/02xxghd394vm6b94phmga3r2w3kiyyhn-nixos-system-machine-test machine # [ 31.059433] systemd[1]: test.service: Deactivated successfully. machine # [ 31.062908] systemd[1]: Stopped Test unit. machine # [ 31.063619] systemd[1]: Stopped target Local File Systems. machine # [ 31.066787] systemd[1]: Stopped target Remote File Systems. machine # [ 31.353763] systemd[1]: Reload requested from client PID 1856 ('.switch-to-conf') (unit backdoor.service)... machine # [ 31.355749] systemd[1]: Reloading... machine # [ 31.671172] systemd[1]: Reloading finished in 313 ms. machine # [ 31.761701] systemd[572]: Reexecution requested from client PID 1926 ('switch-to-confi')... machine # [ 31.765788] systemd[572]: Reexecuting. machine # [ 31.823604] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.935348] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.943258] systemd[572]: Reload requested from client PID 1926 ('switch-to-confi')... machine # [ 31.947219] systemd[572]: Reloading... machine # [ 32.052505] systemd[572]: Reloading finished in 106 ms. machine # [ 32.069692] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.078707] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 32.081254] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 32.083561] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 32.117049] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 32.121561] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 32.124836] systemd[1]: Stopping Reactivate sysinit units... machine # [ 32.125747] systemd[1]: Reached target Reactivate sysinit units. machine # [ 32.131488] systemd[1]: Starting test.service... machine # [ 32.135443] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.141362] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 32.145019] systemd[1]: Reached target Local File Systems. machine # [ 32.150475] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 32.155460] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 32.161004] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 32.162287] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 32.170691] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 32.175624] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.182676] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.187967] systemd[1]: Reached target Remote File Systems. machine # [ 32.195986] systemd[1]: Finished test.service. machine # [ 32.342038] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 32.347018] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 32.349353] systemd[1]: Starting linger-users.service... machine # [ 32.389720] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 32.392462] systemd[1]: Finished linger-users.service. machine # [ 32.647866] nixos[1856]: finished switching to system configuration /nix/store/02xxghd394vm6b94phmga3r2w3kiyyhn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.87 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 32.878434] nixos[1999]: switching to system configuration /nix/store/89hgfl7546jyh2d52psxkwdh6yzfzl81-nixos-system-machine-test machine # [ 32.880997] systemd[1]: Stopped target Remote File Systems. machine # [ 32.883483] systemd[1]: Stopped target Local File Systems. machine # [ 33.170746] systemd[1]: Reload requested from client PID 1999 ('.switch-to-conf') (unit backdoor.service)... machine # [ 33.173011] systemd[1]: Reloading... machine # [ 33.495010] systemd[1]: Reloading finished in 320 ms. machine # [ 33.581213] systemd[572]: Reexecution requested from client PID 2068 ('switch-to-confi')... machine # [ 33.586210] systemd[572]: Reexecuting. machine # [ 33.639033] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.745761] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.752249] systemd[572]: Reload requested from client PID 2068 ('switch-to-confi')... machine # [ 33.755884] systemd[572]: Reloading... machine # [ 33.861112] systemd[572]: Reloading finished in 106 ms. machine # [ 33.876165] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.886210] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 33.888577] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 33.890648] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 33.923304] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 33.927600] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 33.929581] systemd[1]: Stopping Reactivate sysinit units... machine # [ 33.930473] systemd[1]: Reached target Reactivate sysinit units. machine # [ 33.934239] systemd[1]: test.service: Deactivated successfully. machine # [ 33.935163] systemd[1]: Stopped test.service. machine # [ 33.935802] systemd[1]: Stopping test.service... machine # [ 33.938503] systemd[1]: Starting test.service... machine # [ 33.960725] systemd[1]: Finished test.service. machine # [ 33.963932] systemd[1]: Reached target Remote File Systems. machine # [ 33.970373] systemd[1]: Starting linger-users.service... machine # [ 33.976560] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.978007] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 33.985100] systemd[1]: Reached target Local File Systems. machine # [ 33.993109] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 33.994719] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 33.995600] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 34.002804] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 34.011090] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 34.015770] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.021888] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.065342] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 34.069907] systemd[1]: Finished linger-users.service. machine # [ 34.198124] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 34.201589] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 34.456822] nixos[1999]: finished switching to system configuration /nix/store/89hgfl7546jyh2d52psxkwdh6yzfzl81-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 34.684410] nixos[2142]: switching to system configuration /nix/store/k5ybrrkqj2wibcyyh0kv85md825hpi03-nixos-system-machine-test machine # [ 34.688154] systemd[1]: Stopped target Local File Systems. machine # [ 34.690381] systemd[1]: Stopped target Remote File Systems. machine # [ 34.973826] systemd[1]: Reload requested from client PID 2142 ('.switch-to-conf') (unit backdoor.service)... machine # [ 34.975781] systemd[1]: Reloading... machine # [ 35.289157] systemd[1]: Reloading finished in 311 ms. machine # [ 35.380537] systemd[572]: Reexecution requested from client PID 2211 ('switch-to-confi')... machine # [ 35.384263] systemd[572]: Reexecuting. machine # [ 35.438929] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.548402] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.555675] systemd[572]: Reload requested from client PID 2211 ('switch-to-confi')... machine # [ 35.558937] systemd[572]: Reloading... machine # [ 35.663438] systemd[572]: Reloading finished in 105 ms. machine # [ 35.680176] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.689877] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 35.692223] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 35.694676] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 35.728157] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 35.731812] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 35.736301] systemd[1]: Stopping Reactivate sysinit units... machine # [ 35.737229] systemd[1]: Reached target Reactivate sysinit units. machine # [ 35.739324] systemd[1]: Reloading test.service... machine # [ 35.765636] systemd[1]: Reloaded test.service. machine # [ 35.770437] systemd[1]: Reached target Remote File Systems. machine # [ 35.774734] systemd[1]: Starting linger-users.service... machine # [ 35.784972] systemd[1]: Reached target Local File Systems. machine # [ 35.789438] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.796627] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 35.798111] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 35.809560] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 35.810540] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 35.811784] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 35.822624] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 35.824674] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.826303] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.864514] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 35.866898] systemd[1]: Finished linger-users.service. machine # [ 36.007781] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 36.010537] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 36.266771] nixos[2142]: finished switching to system configuration /nix/store/k5ybrrkqj2wibcyyh0kv85md825hpi03-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 36.510772] nixos[2284]: switching to system configuration /nix/store/94mf2bvp763s7jynh1fw6p32r84z3kxk-nixos-system-machine-test machine # [ 36.513611] systemd[1]: Stopped target Local File Systems. machine # [ 36.516237] systemd[1]: Stopped target Remote File Systems. machine # [ 36.821379] systemd[1]: Reload requested from client PID 2284 ('.switch-to-conf') (unit backdoor.service)... machine # [ 36.823441] systemd[1]: Reloading... machine # [ 37.167140] systemd[1]: Reloading finished in 342 ms. machine # [ 37.256438] systemd[572]: Reexecution requested from client PID 2353 ('switch-to-confi')... machine # [ 37.257858] systemd[572]: Reexecuting. machine # [ 37.315812] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.431006] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.438349] systemd[572]: Reload requested from client PID 2353 ('switch-to-confi')... machine # [ 37.442258] systemd[572]: Reloading... machine # [ 37.549834] systemd[572]: Reloading finished in 108 ms. machine # [ 37.564182] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.575129] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 37.577590] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 37.580314] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 37.623635] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 37.631552] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 37.638541] systemd[1]: Stopping Reactivate sysinit units... machine # [ 37.639440] systemd[1]: Reached target Reactivate sysinit units. machine # [ 37.648169] systemd[1]: Reached target Remote File Systems. machine # [ 37.649061] systemd[1]: Reached target Local File Systems. machine # [ 37.649865] systemd[1]: Starting linger-users.service... machine # [ 37.660715] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 37.668413] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 37.669338] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 37.670596] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 37.687338] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 37.697094] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.705025] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.712673] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.714075] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 37.782756] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 37.785680] systemd[1]: Finished linger-users.service. machine # [ 37.925268] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 37.928462] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.184618] nixos[2284]: finished switching to system configuration /nix/store/94mf2bvp763s7jynh1fw6p32r84z3kxk-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.92 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.32 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 38.697539] nixos[2435]: switching to system configuration /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test machine # [ 38.701156] systemd[1]: Stopped target Local File Systems. machine # [ 38.703406] systemd[1]: test.service: Deactivated successfully. machine # [ 38.706665] systemd[1]: Stopped test.service. machine # [ 38.707401] systemd[1]: Stopped target Remote File Systems. machine # [ 39.000502] systemd[1]: Reload requested from client PID 2435 ('.switch-to-conf') (unit backdoor.service)... machine # [ 39.002190] systemd[1]: Reloading... machine # [ 39.333520] systemd[1]: Reloading finished in 329 ms. machine # [ 39.422809] systemd[572]: Reexecution requested from client PID 2504 ('switch-to-confi')... machine # [ 39.425476] systemd[572]: Reexecuting. machine # [ 39.492964] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.620672] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.627954] systemd[572]: Reload requested from client PID 2504 ('switch-to-confi')... machine # [ 39.631746] systemd[572]: Reloading... machine # [ 39.742455] systemd[572]: Reloading finished in 111 ms. machine # [ 39.760201] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.772656] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 39.775222] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 39.777575] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 39.809484] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 39.814031] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 39.817343] systemd[1]: Stopping Reactivate sysinit units... machine # [ 39.818298] systemd[1]: Reached target Reactivate sysinit units. machine # [ 39.820469] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.821872] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 39.826510] systemd[1]: Reached target Remote File Systems. machine # [ 39.829104] systemd[1]: Reached target Local File Systems. machine # [ 39.831803] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 39.841761] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 39.842703] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 39.852378] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 39.854707] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 39.857461] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.858802] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.026710] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 40.028816] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 40.034059] systemd[1]: Starting linger-users.service... machine # [ 40.080515] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 40.083522] systemd[1]: Finished linger-users.service. machine # [ 40.341588] nixos[2435]: finished switching to system configuration /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.84 seconds) machine: must succeed: /nix/store/cmyahhd8vhs6g56lz10bwkqlczjrvwnv-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 40.592500] nixos[2575]: switching to system configuration /nix/store/6djlmxgpnzk3y8bs36l60zhw875563js-nixos-system-machine-test machine # [ 40.595296] systemd[1]: Stopped target Local File Systems. machine # [ 40.598169] systemd[1]: Stopped target Remote File Systems. machine # [ 40.923105] systemd[1]: Reload requested from client PID 2575 ('.switch-to-conf') (unit backdoor.service)... machine # [ 40.925521] systemd[1]: Reloading... machine # [ 41.294283] systemd[1]: Reloading finished in 367 ms. machine # [ 41.436898] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 41.440832] systemd[572]: Reexecution requested from client PID 2644 ('switch-to-confi')... machine # [ 41.443749] systemd[572]: Reexecuting. machine # [ 41.495459] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.617143] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.624566] systemd[572]: Reload requested from client PID 2644 ('switch-to-confi')... machine # [ 41.625936] systemd[572]: Reloading... machine # [ 41.740627] systemd[572]: Reloading finished in 113 ms. machine # [ 41.756215] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.769205] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 41.771436] systemd[1]: Stopping Reactivate sysinit units... machine # [ 41.773038] systemd[1]: Reached target Reactivate sysinit units. machine # [ 41.782675] systemd[1]: Reached target Remote File Systems. machine # [ 41.788168] systemd[1]: Starting linger-users.service... machine # [ 41.793539] systemd[1]: Starting test.service... machine # [ 41.804808] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.806307] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 41.821952] systemd[1]: Reached target Local File Systems. machine # [ 41.822996] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 41.832273] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 41.833395] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 41.834667] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 41.844919] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 41.846738] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.858098] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.888863] systemd[1]: Finished test.service. machine # [ 41.932267] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 41.935511] systemd[1]: Finished linger-users.service. machine # [ 42.095070] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 42.097463] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 42.357554] nixos[2575]: finished switching to system configuration /nix/store/6djlmxgpnzk3y8bs36l60zhw875563js-nixos-system-machine-test machine: (finished: must succeed: /nix/store/cmyahhd8vhs6g56lz10bwkqlczjrvwnv-separate-activation-script/bin/switch-to-configuration test 2>&1, in 2.02 seconds) machine: must succeed: ! test -e /run/current-system/activate machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.03 seconds) machine: must succeed: ! test -e /run/current-system/dry-activate machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.03 seconds) machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.02 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 42.704731] nixos[2724]: switching to system configuration /nix/store/ff3xx8p5l10ikjd36nkk2y0javwgfvd9-nixos-system-machine-test machine # [ 42.708573] systemd[1]: test.service: Deactivated successfully. machine # [ 42.709615] systemd[1]: Stopped test.service. machine # [ 42.712631] systemd[1]: Stopped target Local File Systems. machine # [ 42.714472] systemd[1]: Stopped target Remote File Systems. machine # [ 43.065990] systemd[1]: Reload requested from client PID 2724 ('.switch-to-conf') (unit backdoor.service)... machine # [ 43.068268] systemd[1]: Reloading... machine # [ 43.435757] systemd[1]: Reloading finished in 366 ms. machine # [ 43.536940] systemd[572]: Reexecution requested from client PID 2793 ('switch-to-confi')... machine # [ 43.541854] systemd[572]: Reexecuting. machine # [ 43.600723] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.732941] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.740322] systemd[572]: Reload requested from client PID 2793 ('switch-to-confi')... machine # [ 43.742664] systemd[572]: Reloading... machine # [ 43.869030] systemd[572]: Reloading finished in 125 ms. machine # [ 43.884245] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.901399] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 43.939858] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 43.946610] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 43.947754] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 43.956492] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 43.959143] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 43.962960] systemd[1]: Stopping Reactivate sysinit units... machine # [ 43.963903] systemd[1]: Reached target Reactivate sysinit units. machine # [ 43.979958] systemd[1]: Started test.service. machine # [ 44.002126] systemd[1]: Reached target Local File Systems. machine # [ 44.003178] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 44.027836] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 44.036573] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 44.038227] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 44.055201] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 44.074680] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.084241] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.091263] systemd[1]: Reached target Remote File Systems. machine # [ 44.094073] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.095445] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 44.104073] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 44.108761] systemd[1]: test.service: Deactivated successfully. machine # [ 44.371203] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 44.379466] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 44.383605] systemd[1]: Starting linger-users.service... machine # [ 44.425711] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 44.428894] systemd[1]: Finished linger-users.service. machine # [ 44.686342] nixos[2724]: finished switching to system configuration /nix/store/ff3xx8p5l10ikjd36nkk2y0javwgfvd9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 2.25 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 44.938455] nixos[2870]: switching to system configuration /nix/store/ykfkvr51vvl324vcxhj69jxksp3j7vc8-nixos-system-machine-test machine # [ 44.941268] systemd[1]: Stopped target Remote File Systems. machine # [ 44.944293] systemd[1]: Stopped target Local File Systems. machine # [ 45.280945] systemd[1]: Reload requested from client PID 2870 ('.switch-to-conf') (unit backdoor.service)... machine # [ 45.282604] systemd[1]: Reloading... machine # [ 45.655807] systemd[1]: Reloading finished in 371 ms. machine # [ 45.751223] systemd[572]: Reexecution requested from client PID 2939 ('switch-to-confi')... machine # [ 45.755663] systemd[572]: Reexecuting. machine # [ 45.811322] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.934490] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.944143] systemd[572]: Reload requested from client PID 2939 ('switch-to-confi')... machine # [ 45.948243] systemd[572]: Reloading... machine # [ 46.069355] systemd[572]: Reloading finished in 121 ms. machine # [ 46.087044] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.096911] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 46.099457] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 46.101935] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 46.134417] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 46.138875] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 46.141712] systemd[1]: Stopping Reactivate sysinit units... machine # [ 46.142687] systemd[1]: Reached target Reactivate sysinit units. machine # [ 46.148596] systemd[1]: Reached target Remote File Systems. machine # [ 46.154724] systemd[1]: Starting escaped\x2ddash.service... machine # [ 46.159508] systemd[1]: Starting linger-users.service... machine # [ 46.168313] systemd[1]: Reached target Local File Systems. machine # [ 46.174132] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.175611] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 46.188593] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 46.190217] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 46.191035] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 46.204888] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 46.207276] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 46.224815] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.232966] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.244448] systemd[1]: Finished escaped\x2ddash.service. machine # [ 46.287113] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 46.289908] systemd[1]: Finished linger-users.service. machine # [ 46.451575] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 46.454607] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 46.712512] nixos[2870]: finished switching to system configuration /nix/store/ykfkvr51vvl324vcxhj69jxksp3j7vc8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 2.02 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 46.981111] nixos[3012]: switching to system configuration /nix/store/31a3panbs2rydcd1235q3a58hq96g381-nixos-system-machine-test machine # [ 46.987135] systemd[1]: Stopped target Local File Systems. machine # [ 46.990575] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 46.991684] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 46.993177] systemd[1]: Stopped target Remote File Systems. machine # [ 47.317257] systemd[1]: Reload requested from client PID 3012 ('.switch-to-conf') (unit backdoor.service)... machine # [ 47.319267] systemd[1]: Reloading... machine # [ 47.706817] systemd[1]: Reloading finished in 385 ms. machine # [ 47.804607] systemd[572]: Reexecution requested from client PID 3081 ('switch-to-confi')... machine # [ 47.808541] systemd[572]: Reexecuting. machine # [ 47.872213] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.994703] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.002352] systemd[572]: Reload requested from client PID 3081 ('switch-to-confi')... machine # [ 48.004928] systemd[572]: Reloading... machine # [ 48.118266] systemd[572]: Reloading finished in 111 ms. machine # [ 48.132315] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.143187] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 48.144362] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 48.146812] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 48.177913] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 48.181894] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 48.184207] systemd[1]: Stopping Reactivate sysinit units... machine # [ 48.185119] systemd[1]: Reached target Reactivate sysinit units. machine # [ 48.190410] systemd[1]: Starting escaped\x2ddash.service... machine # [ 48.197824] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.199260] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 48.209186] systemd[1]: Reached target Local File Systems. machine # [ 48.210196] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 48.215372] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 48.219462] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 48.229677] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 48.237939] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 48.239660] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.243159] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.246151] systemd[1]: Reached target Remote File Systems. machine # [ 48.253038] systemd[1]: Finished escaped\x2ddash.service. machine # [ 48.404749] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 48.408391] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 48.411756] systemd[1]: Starting linger-users.service... machine # [ 48.453436] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 48.456296] systemd[1]: Finished linger-users.service. machine # [ 48.713359] nixos[3012]: finished switching to system configuration /nix/store/31a3panbs2rydcd1235q3a58hq96g381-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 2.00 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 48.944933] nixos[3154]: switching to system configuration /nix/store/gpzzbfjp6i4zvkqlac89sfpbiap1hr5c-nixos-system-machine-test machine # [ 48.947648] systemd[1]: Stopped target Local File Systems. machine # [ 48.951486] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 48.953855] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 48.954680] systemd[1]: Stopped target Remote File Systems. machine # [ 49.249717] systemd[1]: Reload requested from client PID 3154 ('.switch-to-conf') (unit backdoor.service)... machine # [ 49.251692] systemd[1]: Reloading... machine # [ 49.567143] systemd[1]: Reloading finished in 313 ms. machine # [ 49.656508] systemd[572]: Reexecution requested from client PID 3223 ('switch-to-confi')... machine # [ 49.658040] systemd[572]: Reexecuting. machine # [ 49.716506] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.831861] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.838754] systemd[572]: Reload requested from client PID 3223 ('switch-to-confi')... machine # [ 49.842459] systemd[572]: Reloading... machine # [ 49.947290] systemd[572]: Reloading finished in 105 ms. machine # [ 49.965658] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.974206] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 49.976694] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 49.978977] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 50.011743] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 50.015687] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 50.017182] systemd[1]: Stopping Reactivate sysinit units... machine # [ 50.018042] systemd[1]: Reached target Reactivate sysinit units. machine # [ 50.020923] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.024871] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 50.028485] systemd[1]: Reached target Remote File Systems. machine # [ 50.032194] systemd[1]: Starting -.service... machine # [ 50.035453] systemd[1]: Starting linger-users.service... machine # [ 50.052644] systemd[1]: Reached target Local File Systems. machine # [ 50.053979] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 50.061103] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 50.068601] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 50.076323] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 50.078606] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 50.089578] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.090903] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.102711] systemd[1]: Finished -.service. machine # [ 50.135848] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 50.138282] systemd[1]: Finished linger-users.service. machine # [ 50.268990] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 50.271354] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 50.528428] nixos[3154]: finished switching to system configuration /nix/store/gpzzbfjp6i4zvkqlac89sfpbiap1hr5c-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 50.752469] nixos[3296]: switching to system configuration /nix/store/mq380y2gl9nkbvdxy9wk2izmcp48d123-nixos-system-machine-test machine # [ 50.757344] systemd[1]: Stopped target Local File Systems. machine # [ 50.758220] systemd[1]: Stopped target Remote File Systems. machine # [ 51.070481] systemd[1]: Reload requested from client PID 3296 ('.switch-to-conf') (unit backdoor.service)... machine # [ 51.072670] systemd[1]: Reloading... machine # [ 51.413354] systemd[1]: Reloading finished in 339 ms. machine # [ 51.497333] systemd[572]: Reexecution requested from client PID 3365 ('switch-to-confi')... machine # [ 51.501355] systemd[572]: Reexecuting. machine # [ 51.559794] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.675668] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.684228] systemd[572]: Reload requested from client PID 3365 ('switch-to-confi')... machine # [ 51.685661] systemd[572]: Reloading... machine # [ 51.797979] systemd[572]: Reloading finished in 110 ms. machine # [ 51.812179] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.822092] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 51.824707] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 51.827083] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 51.860607] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 51.865114] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 51.869683] systemd[1]: Stopping Reactivate sysinit units... machine # [ 51.870628] systemd[1]: Reached target Reactivate sysinit units. machine # [ 51.872791] systemd[1]: Reloading -.service... machine # [ 51.898996] systemd[1]: Reloaded -.service. machine # [ 51.902957] systemd[1]: Reached target Remote File Systems. machine # [ 51.905859] systemd[1]: Reached target Local File Systems. machine # [ 51.911028] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.914641] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 51.920211] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 51.930100] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 51.931135] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 51.932738] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 51.935078] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 51.940505] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.941931] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.107092] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 52.112974] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 52.116512] systemd[1]: Starting linger-users.service... machine # [ 52.166875] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 52.170341] systemd[1]: Finished linger-users.service. machine # [ 52.424535] nixos[3296]: finished switching to system configuration /nix/store/mq380y2gl9nkbvdxy9wk2izmcp48d123-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.90 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 52.661088] nixos[3438]: switching to system configuration /nix/store/7k90apj497ay3yjqh1all38zz650i1d6-nixos-system-machine-test machine # [ 52.663661] systemd[1]: -.service: Deactivated successfully. machine # [ 52.667701] systemd[1]: Stopped -.service. machine # [ 52.668675] systemd[1]: Stopped target Remote File Systems. machine # [ 52.669481] systemd[1]: Stopped target Local File Systems. machine # [ 52.965224] systemd[1]: Reload requested from client PID 3438 ('.switch-to-conf') (unit backdoor.service)... machine # [ 52.967429] systemd[1]: Reloading... machine # [ 53.293042] systemd[1]: Reloading finished in 324 ms. machine # [ 53.389320] systemd[572]: Reexecution requested from client PID 3507 ('switch-to-confi')... machine # [ 53.393648] systemd[572]: Reexecuting. machine # [ 53.447796] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.565501] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.572670] systemd[572]: Reload requested from client PID 3507 ('switch-to-confi')... machine # [ 53.576170] systemd[572]: Reloading... machine # [ 53.684974] systemd[572]: Reloading finished in 109 ms. machine # [ 53.700197] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.710577] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 53.713056] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 53.715237] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 53.747329] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 53.751401] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 53.753337] systemd[1]: Stopping Reactivate sysinit units... machine # [ 53.754243] systemd[1]: Reached target Reactivate sysinit units. machine # [ 53.758261] systemd[1]: Reached target Remote File Systems. machine # [ 53.764151] systemd[1]: Starting linger-users.service... machine # [ 53.769897] systemd[1]: Starting required-service.service... machine # [ 53.770830] systemd[1]: Starting test-service.service... machine # [ 53.790620] systemd[1]: Reached target Local File Systems. machine # [ 53.791568] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 53.806692] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 53.807650] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 53.821003] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 53.833232] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 53.843486] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.850217] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.851609] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.864451] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 53.865869] systemd[1]: Finished test-service.service. machine # [ 53.866634] systemd[1]: Finished required-service.service. machine # [ 53.894396] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 53.898128] systemd[1]: Finished linger-users.service. machine # [ 54.037169] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 54.041015] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 54.295770] nixos[3438]: finished switching to system configuration /nix/store/7k90apj497ay3yjqh1all38zz650i1d6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.87 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 54.523753] nixos[3582]: switching to system configuration /nix/store/1jm7a27f9anlbalqjqz93brw19pwb05n-nixos-system-machine-test machine # [ 54.527078] systemd[1]: Stopped target Remote File Systems. machine # [ 54.528946] systemd[1]: required-service.service: Deactivated successfully. machine # [ 54.532541] systemd[1]: Stopped required-service.service. machine # [ 54.534015] systemd[1]: test-service.service: Deactivated successfully. machine # [ 54.534975] systemd[1]: Stopped test-service.service. machine # [ 54.535711] systemd[1]: Stopped target Local File Systems. machine # [ 54.826543] systemd[1]: Reload requested from client PID 3582 ('.switch-to-conf') (unit backdoor.service)... machine # [ 54.828786] systemd[1]: Reloading... machine # [ 55.150764] systemd[1]: Reloading finished in 320 ms. machine # [ 55.232995] systemd[572]: Reexecution requested from client PID 3651 ('switch-to-confi')... machine # [ 55.237343] systemd[572]: Reexecuting. machine # [ 55.291321] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.405709] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.412662] systemd[572]: Reload requested from client PID 3651 ('switch-to-confi')... machine # [ 55.415179] systemd[572]: Reloading... machine # [ 55.522307] systemd[572]: Reloading finished in 106 ms. machine # [ 55.536168] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.546144] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 55.548595] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 55.550752] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 55.584136] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 55.587797] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 55.589992] systemd[1]: Stopping Reactivate sysinit units... machine # [ 55.590891] systemd[1]: Reached target Reactivate sysinit units. machine # [ 55.596580] systemd[1]: Reached target Remote File Systems. machine # [ 55.601830] systemd[1]: Starting linger-users.service... machine # [ 55.606040] systemd[1]: Starting required-service.service... machine # [ 55.616391] systemd[1]: Starting test-service.service... machine # [ 55.624667] systemd[1]: Reached target Local File Systems. machine # [ 55.630889] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.636433] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 55.637796] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 55.646768] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 55.647725] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 55.659576] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 55.670021] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 55.680460] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.681864] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.697592] systemd[1]: Finished test-service.service. machine # [ 55.705359] systemd[1]: Finished required-service.service. machine # [ 55.740126] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 55.742283] systemd[1]: Finished linger-users.service. machine # [ 55.880346] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 55.883486] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 56.139390] nixos[3582]: finished switching to system configuration /nix/store/1jm7a27f9anlbalqjqz93brw19pwb05n-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.84 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 56.384518] nixos[3726]: switching to system configuration /nix/store/5v1w1znf2s3qn992q1hicxs3nqd2k8zl-nixos-system-machine-test machine # [ 56.387577] systemd[1]: required-service.service: Deactivated successfully. machine # [ 56.391121] systemd[1]: Stopped required-service.service. machine # [ 56.392945] systemd[1]: test-service.service: Deactivated successfully. machine # [ 56.394760] systemd[1]: Stopped test-service.service. machine # [ 56.395531] systemd[1]: Stopped target Remote File Systems. machine # [ 56.396820] systemd[1]: Stopped target Local File Systems. machine # [ 56.699378] systemd[1]: Reload requested from client PID 3726 ('.switch-to-conf') (unit backdoor.service)... machine # [ 56.701798] systemd[1]: Reloading... machine # [ 57.023278] systemd[1]: Reloading finished in 320 ms. machine # [ 57.111636] systemd[572]: Reexecution requested from client PID 3795 ('switch-to-confi')... machine # [ 57.116674] systemd[572]: Reexecuting. machine # [ 57.159291] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.272079] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.279152] systemd[572]: Reload requested from client PID 3795 ('switch-to-confi')... machine # [ 57.281743] systemd[572]: Reloading... machine # [ 57.393861] systemd[572]: Reloading finished in 109 ms. machine # [ 57.408183] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.418871] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 57.421418] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 57.423795] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 57.456357] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 57.460937] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 57.462888] systemd[1]: Stopping Reactivate sysinit units... machine # [ 57.463773] systemd[1]: Reached target Reactivate sysinit units. machine # [ 57.469377] systemd[1]: Starting required-service.service... machine # [ 57.479467] systemd[1]: Reached target Local File Systems. machine # [ 57.481053] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 57.490740] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 57.491763] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 57.498407] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 57.511066] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 57.516149] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.521369] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.526447] systemd[1]: Reached target Remote File Systems. machine # [ 57.527378] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.534062] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 57.543405] systemd[1]: Finished required-service.service. machine # [ 57.691660] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 57.696681] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 57.700274] systemd[1]: Starting linger-users.service... machine # [ 57.704232] systemd[1]: Starting test-service.service... machine # [ 57.743623] systemd[1]: Finished test-service.service. machine # [ 57.766964] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 57.769661] systemd[1]: Finished linger-users.service. machine # [ 58.026374] nixos[3726]: finished switching to system configuration /nix/store/5v1w1znf2s3qn992q1hicxs3nqd2k8zl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.89 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 58.263085] nixos[3870]: switching to system configuration /nix/store/sb4702phq0kf63a9iq7psx4abimvldc1-nixos-system-machine-test machine # [ 58.265774] systemd[1]: Stopped target Local File Systems. machine # [ 58.268512] systemd[1]: test-service.service: Deactivated successfully. machine # [ 58.269524] systemd[1]: Stopped test-service.service. machine # [ 58.271071] systemd[1]: required-service.service: Deactivated successfully. machine # [ 58.273644] systemd[1]: Stopped required-service.service. machine # [ 58.274481] systemd[1]: Stopped target Remote File Systems. machine # [ 58.570144] systemd[1]: Reload requested from client PID 3870 ('.switch-to-conf') (unit backdoor.service)... machine # [ 58.572337] systemd[1]: Reloading... machine # [ 58.894859] systemd[1]: Reloading finished in 321 ms. machine # [ 58.977641] systemd[572]: Reexecution requested from client PID 3939 ('switch-to-confi')... machine # [ 58.981414] systemd[572]: Reexecuting. machine # [ 59.039490] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.150646] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.157653] systemd[572]: Reload requested from client PID 3939 ('switch-to-confi')... machine # [ 59.161298] systemd[572]: Reloading... machine # [ 59.265532] systemd[572]: Reloading finished in 105 ms. machine # [ 59.280175] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.289715] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 59.292122] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 59.294561] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 59.322997] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 59.326820] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 59.332481] systemd[1]: Stopping Reactivate sysinit units... machine # [ 59.333401] systemd[1]: Reached target Reactivate sysinit units. machine # [ 59.334258] systemd[1]: Reached target Local File Systems. machine # [ 59.335039] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 59.344744] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 59.355352] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 59.359367] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 59.361795] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 59.363387] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.365391] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.366689] systemd[1]: Reached target Remote File Systems. machine # [ 59.368001] systemd[1]: Created slice Slice /system/instantiated. machine # [ 59.369784] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.372744] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 59.519993] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 59.521928] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 59.526633] systemd[1]: Starting instantiated@one.service... machine # [ 59.531721] systemd[1]: Starting instantiated@two.service... machine # [ 59.536374] systemd[1]: Starting linger-users.service... machine # [ 59.587261] systemd[1]: Finished instantiated@one.service. machine # [ 59.591158] systemd[1]: Finished instantiated@two.service. machine # [ 59.606980] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 59.610061] systemd[1]: Finished linger-users.service. machine # [ 59.865447] nixos[3870]: finished switching to system configuration /nix/store/sb4702phq0kf63a9iq7psx4abimvldc1-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.84 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 60.105951] nixos[4014]: switching to system configuration /nix/store/1wmfl9vwnihrj1gg0na8dsn872miqc59-nixos-system-machine-test machine # [ 60.108608] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 60.112438] systemd[1]: Stopped instantiated@two.service. machine # [ 60.113322] systemd[1]: Stopped target Remote File Systems. machine # [ 60.114144] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 60.115137] systemd[1]: Stopped instantiated@one.service. machine # [ 60.116662] systemd[1]: Stopped target Local File Systems. machine # [ 60.401250] systemd[1]: Reload requested from client PID 4014 ('.switch-to-conf') (unit backdoor.service)... machine # [ 60.403226] systemd[1]: Reloading... machine # [ 60.725932] systemd[1]: Reloading finished in 320 ms. machine # [ 60.809134] systemd[572]: Reexecution requested from client PID 4083 ('switch-to-confi')... machine # [ 60.813444] systemd[572]: Reexecuting. machine # [ 60.871499] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.985716] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.992311] systemd[572]: Reload requested from client PID 4083 ('switch-to-confi')... machine # [ 60.996062] systemd[572]: Reloading... machine # [ 61.101266] systemd[572]: Reloading finished in 106 ms. machine # [ 61.116170] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.126773] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 61.129189] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 61.131284] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 61.164344] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 61.168332] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 61.169751] systemd[1]: Stopping Reactivate sysinit units... machine # [ 61.170578] systemd[1]: Reached target Reactivate sysinit units. machine # [ 61.174295] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.179660] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 61.182555] systemd[1]: Starting instantiated@one.service... machine # [ 61.186950] systemd[1]: Reached target Local File Systems. machine # [ 61.196308] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 61.200951] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 61.201864] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 61.203149] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 61.216985] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 61.218735] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.226135] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.227496] systemd[1]: Reached target Remote File Systems. machine # [ 61.245035] systemd[1]: Finished instantiated@one.service. machine # [ 61.390488] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 61.393522] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 61.397369] systemd[1]: Starting instantiated@two.service... machine # [ 61.401642] systemd[1]: Starting linger-users.service... machine # [ 61.440112] systemd[1]: Finished instantiated@two.service. machine # [ 61.457466] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 61.460591] systemd[1]: Finished linger-users.service. machine # [ 61.715065] nixos[4014]: finished switching to system configuration /nix/store/1wmfl9vwnihrj1gg0na8dsn872miqc59-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.85 seconds) (finished: subtest: services, in 40.18 seconds) subtest: failing units machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 61.934423] nixos[4158]: switching to system configuration /nix/store/02xxghd394vm6b94phmga3r2w3kiyyhn-nixos-system-machine-test machine # [ 61.937331] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 61.941064] systemd[1]: Stopped instantiated@one.service. machine # [ 61.941927] systemd[1]: Stopped target Local File Systems. machine # [ 61.942702] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 61.943658] systemd[1]: Stopped instantiated@two.service. machine # [ 61.945659] systemd[1]: Stopped target Remote File Systems. machine # [ 62.216258] systemd[1]: Reload requested from client PID 4158 ('.switch-to-conf') (unit backdoor.service)... machine # [ 62.218203] systemd[1]: Reloading... machine # [ 62.521166] systemd[1]: Reloading finished in 301 ms. machine # [ 62.604431] systemd[572]: Reexecution requested from client PID 4227 ('switch-to-confi')... machine # [ 62.607843] systemd[572]: Reexecuting. machine # [ 62.671644] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.789435] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.796070] systemd[572]: Reload requested from client PID 4227 ('switch-to-confi')... machine # [ 62.798409] systemd[572]: Reloading... machine # [ 62.904948] systemd[572]: Reloading finished in 105 ms. machine # [ 62.920161] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.930111] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 62.932554] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 62.934620] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 62.966594] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 62.970712] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 62.973562] systemd[1]: Stopping Reactivate sysinit units... machine # [ 62.974463] systemd[1]: Reached target Reactivate sysinit units. machine # [ 62.978437] systemd[1]: Reached target Local File Systems. machine # [ 62.979277] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 62.989515] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 62.990399] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 62.991634] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 63.002464] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 63.004243] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.005509] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.006740] systemd[1]: Reached target Remote File Systems. machine # [ 63.007533] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.010155] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 63.158171] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 63.160129] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 63.166024] systemd[1]: Starting linger-users.service... machine # [ 63.169272] systemd[1]: Starting test.service... machine # [ 63.207728] systemd[1]: Finished test.service. machine # [ 63.225464] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 63.228180] systemd[1]: Finished linger-users.service. machine # [ 63.484473] nixos[4158]: finished switching to system configuration /nix/store/02xxghd394vm6b94phmga3r2w3kiyyhn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.77 seconds) machine: must fail: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 63.715025] nixos[4300]: switching to system configuration /nix/store/3kybcslfnz9ljg9zdmv0cvc50k6ydz06-nixos-system-machine-test machine # [ 63.717786] systemd[1]: test.service: Deactivated successfully. machine # [ 63.721370] systemd[1]: Stopped test.service. machine # [ 63.722148] systemd[1]: Stopped target Local File Systems. machine # [ 63.722931] systemd[1]: Stopped target Remote File Systems. machine # [ 64.015283] systemd[1]: Reload requested from client PID 4300 ('.switch-to-conf') (unit backdoor.service)... machine # [ 64.017492] systemd[1]: Reloading... machine # [ 64.346172] systemd[1]: Reloading finished in 327 ms. machine # [ 64.450377] systemd[572]: Reexecution requested from client PID 4369 ('switch-to-confi')... machine # [ 64.454832] systemd[572]: Reexecuting. machine # [ 64.520701] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.658879] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.666733] systemd[572]: Reload requested from client PID 4369 ('switch-to-confi')... machine # [ 64.669500] systemd[572]: Reloading... machine # [ 64.785637] systemd[572]: Reloading finished in 113 ms. machine # [ 64.801789] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.811429] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 64.814417] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 64.816979] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 64.858669] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 64.863418] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 64.866776] systemd[1]: Stopping Reactivate sysinit units... machine # [ 64.867745] systemd[1]: Reached target Reactivate sysinit units. machine # [ 64.870324] systemd[1]: Reached target Remote File Systems. machine # [ 64.873007] systemd[1]: Reached target Local File Systems. machine # [ 64.879408] systemd[1]: Starting test.service... machine # [ 64.890205] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.891722] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 64.896671] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 64.906633] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 64.907797] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 64.921486] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 64.928580] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 64.933453] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.934905] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.953374] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 64.959609] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 64.962015] systemd[1]: Failed to start test.service. machine # [ 65.145890] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 65.151838] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 65.154863] systemd[1]: Starting linger-users.service... machine # [ 65.208568] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 65.212209] systemd[1]: Finished linger-users.service. machine # [ 65.493805] nixos[4300]: switching to system configuration /nix/store/3kybcslfnz9ljg9zdmv0cvc50k6ydz06-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 2.01 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 65.730793] nixos[4443]: switching to system configuration /nix/store/w4id3z1vbq7s1k8r1hmrh863g3jgg6is-nixos-system-machine-test machine # [ 65.733610] systemd[1]: Stopped target Remote File Systems. machine # [ 65.736053] systemd[1]: Stopped target Local File Systems. machine # [ 66.034760] systemd[1]: Reload requested from client PID 4443 ('.switch-to-conf') (unit backdoor.service)... machine # [ 66.037056] systemd[1]: Reloading... machine # [ 66.361246] systemd[1]: Reloading finished in 322 ms. machine # [ 66.453211] systemd[572]: Reexecution requested from client PID 4511 ('switch-to-confi')... machine # [ 66.458261] systemd[572]: Reexecuting. machine # [ 66.511489] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.626018] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.633158] systemd[572]: Reload requested from client PID 4511 ('switch-to-confi')... machine # [ 66.635465] systemd[572]: Reloading... machine # [ 66.746768] systemd[572]: Reloading finished in 110 ms. machine # [ 66.764201] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.773910] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 66.776128] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 66.778662] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 66.812823] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 66.816814] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 66.818907] systemd[1]: Stopping Reactivate sysinit units... machine # [ 66.819885] systemd[1]: Reached target Reactivate sysinit units. machine # [ 66.825684] systemd[1]: Reached target Local File Systems. machine # [ 66.826575] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 66.837613] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 66.838490] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 66.839779] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 66.844671] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 66.846403] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.847701] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.858601] systemd[1]: Reached target Remote File Systems. machine # [ 66.859571] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.866597] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 67.016526] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 67.020593] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 67.024469] systemd[1]: Started autorestart.service. machine # [ 67.029470] systemd[1]: Starting linger-users.service... machine # [ 67.069285] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 67.089312] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 67.092617] systemd[1]: Finished linger-users.service. machine # [ 67.348590] nixos[4443]: finished switching to system configuration /nix/store/w4id3z1vbq7s1k8r1hmrh863g3jgg6is-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.85 seconds) machine # [ 67.391706] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 67.592523] nixos[4590]: switching to system configuration /nix/store/w4id3z1vbq7s1k8r1hmrh863g3jgg6is-nixos-system-machine-test machine # [ 67.595013] systemd[1]: Stopped target Local File Systems. machine # [ 67.597072] systemd[1]: Stopped target Remote File Systems. machine # [ 67.877416] systemd[1]: Reload requested from client PID 4590 ('.switch-to-conf') (unit backdoor.service)... machine # [ 67.879515] systemd[1]: Reloading... machine # [ 68.198617] systemd[1]: Reloading finished in 317 ms. machine # [ 68.282754] systemd[572]: Reexecution requested from client PID 4659 ('switch-to-confi')... machine # [ 68.287247] systemd[572]: Reexecuting. machine # [ 68.339463] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.451520] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.458730] systemd[572]: Reload requested from client PID 4659 ('switch-to-confi')... machine # [ 68.461612] systemd[572]: Reloading... machine # [ 68.570733] systemd[572]: Reloading finished in 108 ms. machine # [ 68.588208] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.597652] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 68.600072] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 68.602300] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 68.636357] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 68.641042] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 68.642047] systemd[1]: Stopping Reactivate sysinit units... machine # [ 68.642854] systemd[1]: Reached target Reactivate sysinit units. machine # [ 68.646191] systemd[1]: Reached target Local File Systems. machine # [ 68.649895] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 68.653871] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 68.654797] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 68.662716] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 68.671289] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 68.677035] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.678396] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.679610] systemd[1]: Reached target Remote File Systems. machine # [ 68.680531] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.681878] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 68.872476] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 68.876362] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 68.880297] systemd[1]: Started autorestart.service. machine # [ 68.886084] systemd[1]: Starting linger-users.service... machine # [ 68.926196] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 68.946964] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 68.949939] systemd[1]: Finished linger-users.service. machine # [ 69.207222] nixos[4590]: finished switching to system configuration /nix/store/w4id3z1vbq7s1k8r1hmrh863g3jgg6is-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.82 seconds) machine # [ 69.251087] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 69.478386] nixos[4737]: switching to system configuration /nix/store/pma3xfdgq771rzks9invgrmsqbx0z0ak-nixos-system-machine-test machine # [ 69.480904] systemd[1]: Stopped target Remote File Systems. machine # [ 69.483226] systemd[1]: Stopped target Local File Systems. machine # [ 69.784510] systemd[1]: Reload requested from client PID 4737 ('.switch-to-conf') (unit backdoor.service)... machine # [ 69.786595] systemd[1]: Reloading... machine # [ 70.126806] systemd[1]: Reloading finished in 338 ms. machine # [ 70.215391] systemd[572]: Reexecution requested from client PID 4806 ('switch-to-confi')... machine # [ 70.219872] systemd[572]: Reexecuting. machine # [ 70.275675] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.392583] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.400146] systemd[572]: Reload requested from client PID 4806 ('switch-to-confi')... machine # [ 70.401675] systemd[572]: Reloading... machine # [ 70.509512] systemd[572]: Reloading finished in 106 ms. machine # [ 70.528181] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.538762] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 70.541699] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 70.543964] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 70.576398] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 70.580579] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 70.583484] systemd[1]: Stopping Reactivate sysinit units... machine # [ 70.585218] systemd[1]: Reached target Reactivate sysinit units. machine # [ 70.586902] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.590971] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 70.597943] systemd[1]: Reached target Local File Systems. machine # [ 70.598836] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 70.604999] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 70.605953] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 70.607248] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 70.618563] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 70.621532] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.622888] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.625468] systemd[1]: Reached target Remote File Systems. machine # [ 70.781661] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 70.786367] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.788544] systemd[1]: Started autorestart.service. machine # [ 70.793544] systemd[1]: Starting linger-users.service... machine # [ 70.830123] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 70.835191] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 70.853998] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 70.855747] systemd[1]: Finished linger-users.service. machine # [ 71.134758] nixos[4737]: switching to system configuration /nix/store/pma3xfdgq771rzks9invgrmsqbx0z0ak-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.88 seconds) (finished: subtest: failing units, in 9.42 seconds) subtest: unit file parser machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 71.349293] nixos[4880]: switching to system configuration /nix/store/89hgfl7546jyh2d52psxkwdh6yzfzl81-nixos-system-machine-test machine # [ 71.352068] systemd[1]: Stopped target Local File Systems. machine # [ 71.355991] systemd[1]: Stopped autorestart.service. machine # [ 71.356912] systemd[1]: Stopped target Remote File Systems. machine # [ 71.639386] systemd[1]: Reload requested from client PID 4880 ('.switch-to-conf') (unit backdoor.service)... machine # [ 71.641851] systemd[1]: Reloading... machine # [ 71.953177] systemd[1]: Reloading finished in 309 ms. machine # [ 72.037526] systemd[572]: Reexecution requested from client PID 4949 ('switch-to-confi')... machine # [ 72.041693] systemd[572]: Reexecuting. machine # [ 72.099894] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.216624] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.223626] systemd[572]: Reload requested from client PID 4949 ('switch-to-confi')... machine # [ 72.227285] systemd[572]: Reloading... machine # [ 72.332972] systemd[572]: Reloading finished in 106 ms. machine # [ 72.348177] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.358032] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 72.360507] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 72.362690] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 72.396433] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 72.401096] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 72.402613] systemd[1]: Stopping Reactivate sysinit units... machine # [ 72.403483] systemd[1]: Reached target Reactivate sysinit units. machine # [ 72.408784] systemd[1]: Reached target Remote File Systems. machine # [ 72.412121] systemd[1]: Starting linger-users.service... machine # [ 72.415377] systemd[1]: Starting test.service... machine # [ 72.424354] systemd[1]: Reached target Local File Systems. machine # [ 72.432607] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.434044] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 72.438977] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 72.449357] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 72.450309] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 72.462615] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 72.471459] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 72.479090] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.486905] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.493938] systemd[1]: Finished test.service. machine # [ 72.527072] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 72.531379] systemd[1]: Finished linger-users.service. machine # [ 72.667469] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 72.671079] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 72.926272] nixos[4880]: finished switching to system configuration /nix/store/89hgfl7546jyh2d52psxkwdh6yzfzl81-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.79 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 73.166731] nixos[5022]: switching to system configuration /nix/store/cqhvhkk6k0zv5q4c9s16qdlk3yy2ldl6-nixos-system-machine-test machine # [ 73.172390] systemd[1]: Stopped target Remote File Systems. machine # [ 73.173341] systemd[1]: Stopped target Local File Systems. machine # [ 73.477821] systemd[1]: Reload requested from client PID 5022 ('.switch-to-conf') (unit backdoor.service)... machine # [ 73.479848] systemd[1]: Reloading... machine # [ 73.805856] systemd[1]: Reloading finished in 324 ms. machine # [ 73.899427] systemd[572]: Reexecution requested from client PID 5091 ('switch-to-confi')... machine # [ 73.902062] systemd[572]: Reexecuting. machine # [ 73.960917] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.084187] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.091307] systemd[572]: Reload requested from client PID 5091 ('switch-to-confi')... machine # [ 74.094235] systemd[572]: Reloading... machine # [ 74.205806] systemd[572]: Reloading finished in 110 ms. machine # [ 74.220225] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.230983] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 74.233707] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 74.236710] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 74.275645] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 74.281202] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 74.282266] systemd[1]: Stopping Reactivate sysinit units... machine # [ 74.283101] systemd[1]: Reached target Reactivate sysinit units. machine # [ 74.286524] systemd[1]: test.service: Deactivated successfully. machine # [ 74.290232] systemd[1]: Stopped test.service. machine # [ 74.291074] systemd[1]: Stopping test.service... machine # [ 74.294476] systemd[1]: Starting test.service... machine # [ 74.322056] systemd[1]: Finished test.service. machine # [ 74.326878] systemd[1]: Reached target Remote File Systems. machine # [ 74.331263] systemd[1]: Starting linger-users.service... machine # [ 74.343110] systemd[1]: Reached target Local File Systems. machine # [ 74.345907] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.347351] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 74.351457] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 74.361742] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 74.362720] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 74.367762] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 74.374475] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 74.379572] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.383179] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.428856] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 74.432513] systemd[1]: Finished linger-users.service. machine # [ 74.571840] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 74.573893] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 74.831326] nixos[5022]: finished switching to system configuration /nix/store/cqhvhkk6k0zv5q4c9s16qdlk3yy2ldl6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.91 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 75.074456] nixos[5164]: switching to system configuration /nix/store/0if8ap48y7crpsfs866y3mmjsjs1djvb-nixos-system-machine-test machine # [ 75.077257] systemd[1]: Stopped target Remote File Systems. machine # [ 75.079746] systemd[1]: Stopped target Local File Systems. machine # [ 75.390203] systemd[1]: Reload requested from client PID 5164 ('.switch-to-conf') (unit backdoor.service)... machine # [ 75.392470] systemd[1]: Reloading... machine # [ 75.717887] systemd[1]: Reloading finished in 323 ms. machine # [ 75.807562] systemd[572]: Reexecution requested from client PID 5233 ('switch-to-confi')... machine # [ 75.811375] systemd[572]: Reexecuting. machine # [ 75.863978] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.981831] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.988572] systemd[572]: Reload requested from client PID 5233 ('switch-to-confi')... machine # [ 75.992072] systemd[572]: Reloading... machine # [ 76.102068] systemd[572]: Reloading finished in 110 ms. machine # [ 76.120184] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.130842] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 76.133395] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 76.135713] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 76.168123] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 76.172106] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 76.176592] systemd[1]: Stopping Reactivate sysinit units... machine # [ 76.177531] systemd[1]: Reached target Reactivate sysinit units. machine # [ 76.178402] systemd[1]: test.service: Deactivated successfully. machine # [ 76.179274] systemd[1]: Stopped test.service. machine # [ 76.180862] systemd[1]: Stopping test.service... machine # [ 76.182587] systemd[1]: Starting test.service... machine # [ 76.209544] systemd[1]: Finished test.service. machine # [ 76.215175] systemd[1]: Reached target Local File Systems. machine # [ 76.221154] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 76.222763] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 76.223591] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 76.237733] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 76.241798] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 76.243518] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.245091] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.246343] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.247710] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 76.249920] systemd[1]: Reached target Remote File Systems. machine # [ 76.407559] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 76.412206] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 76.414362] systemd[1]: Starting linger-users.service... machine # [ 76.458866] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 76.461396] systemd[1]: Finished linger-users.service. machine # [ 76.717994] nixos[5164]: finished switching to system configuration /nix/store/0if8ap48y7crpsfs866y3mmjsjs1djvb-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.89 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 76.956699] nixos[5306]: switching to system configuration /nix/store/89hgfl7546jyh2d52psxkwdh6yzfzl81-nixos-system-machine-test machine # [ 76.959239] systemd[1]: Stopped target Remote File Systems. machine # [ 76.961759] systemd[1]: Stopped target Local File Systems. machine # [ 77.256350] systemd[1]: Reload requested from client PID 5306 ('.switch-to-conf') (unit backdoor.service)... machine # [ 77.257977] systemd[1]: Reloading... machine # [ 77.582481] systemd[1]: Reloading finished in 322 ms. machine # [ 77.672449] systemd[572]: Reexecution requested from client PID 5375 ('switch-to-confi')... machine # [ 77.676117] systemd[572]: Reexecuting. machine # [ 77.736085] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.857213] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.865045] systemd[572]: Reload requested from client PID 5375 ('switch-to-confi')... machine # [ 77.866452] systemd[572]: Reloading... machine # [ 77.979564] systemd[572]: Reloading finished in 111 ms. machine # [ 77.996348] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.008115] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 78.009221] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 78.012131] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 78.045088] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 78.049206] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 78.051256] systemd[1]: Stopping Reactivate sysinit units... machine # [ 78.055374] systemd[1]: Reached target Reactivate sysinit units. machine # [ 78.056691] systemd[1]: test.service: Deactivated successfully. machine # [ 78.057703] systemd[1]: Stopped test.service. machine # [ 78.058371] systemd[1]: Stopping test.service... machine # [ 78.059999] systemd[1]: Starting test.service... machine # [ 78.087319] systemd[1]: Finished test.service. machine # [ 78.095450] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.099080] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 78.103260] systemd[1]: Reached target Local File Systems. machine # [ 78.104561] systemd[1]: Reached target Remote File Systems. machine # [ 78.109863] systemd[1]: Starting linger-users.service... machine # [ 78.116819] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 78.124293] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 78.125258] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 78.126531] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 78.136637] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 78.138404] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.139819] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.208821] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 78.213226] systemd[1]: Finished linger-users.service. machine # [ 78.345241] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 78.348494] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 78.604269] nixos[5306]: finished switching to system configuration /nix/store/89hgfl7546jyh2d52psxkwdh6yzfzl81-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.89 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 78.842673] nixos[5448]: switching to system configuration /nix/store/5f88nm5yhgcfci103bzpsnqd85v4l82b-nixos-system-machine-test machine # [ 78.845824] systemd[1]: Stopped target Remote File Systems. machine # [ 78.848653] systemd[1]: Stopped target Local File Systems. machine # [ 79.152464] systemd[1]: Reload requested from client PID 5448 ('.switch-to-conf') (unit backdoor.service)... machine # [ 79.154556] systemd[1]: Reloading... machine # [ 79.498080] systemd[1]: Reloading finished in 341 ms. machine # [ 79.599440] systemd[572]: Reexecution requested from client PID 5517 ('switch-to-confi')... machine # [ 79.601897] systemd[572]: Reexecuting. machine # [ 79.659531] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.781075] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.788124] systemd[572]: Reload requested from client PID 5517 ('switch-to-confi')... machine # [ 79.792272] systemd[572]: Reloading... machine # [ 79.901627] systemd[572]: Reloading finished in 110 ms. machine # [ 79.920232] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.932187] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 79.934777] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 79.937289] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 79.970686] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 79.975768] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 79.979846] systemd[1]: Stopping Reactivate sysinit units... machine # [ 79.984690] systemd[1]: Reached target Reactivate sysinit units. machine # [ 79.985679] systemd[1]: Reached target Remote File Systems. machine # [ 79.989609] systemd[1]: Starting linger-users.service... machine # [ 79.998890] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.004668] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 80.013608] systemd[1]: Reached target Local File Systems. machine # [ 80.014576] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 80.023740] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 80.028216] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 80.031545] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 80.038919] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 80.044896] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.051241] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.098619] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 80.103704] systemd[1]: Finished linger-users.service. machine # [ 80.257744] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 80.259899] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 80.517540] nixos[5448]: finished switching to system configuration /nix/store/5f88nm5yhgcfci103bzpsnqd85v4l82b-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.91 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 80.761737] nixos[5588]: switching to system configuration /nix/store/f7x7r7b0sbq3akafyp7mnam7wkwq20dg-nixos-system-machine-test machine # [ 80.767740] systemd[1]: Stopped target Remote File Systems. machine # [ 80.770298] systemd[1]: Stopped target Local File Systems. machine # [ 81.069101] systemd[1]: Reload requested from client PID 5588 ('.switch-to-conf') (unit backdoor.service)... machine # [ 81.071151] systemd[1]: Reloading... machine # [ 81.422419] systemd[1]: Reloading finished in 349 ms. machine # [ 81.516481] systemd[572]: Reexecution requested from client PID 5657 ('switch-to-confi')... machine # [ 81.520375] systemd[572]: Reexecuting. machine # [ 81.584235] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.706041] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.713634] systemd[572]: Reload requested from client PID 5657 ('switch-to-confi')... machine # [ 81.718118] systemd[572]: Reloading... machine # [ 81.831558] systemd[572]: Reloading finished in 114 ms. machine # [ 81.848178] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.858238] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 81.860810] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 81.862997] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 81.898852] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 81.903361] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 81.905187] systemd[1]: Stopping Reactivate sysinit units... machine # [ 81.906054] systemd[1]: Reached target Reactivate sysinit units. machine # [ 81.910112] systemd[1]: test.service: Deactivated successfully. machine # [ 81.911075] systemd[1]: Stopped test.service. machine # [ 81.911750] systemd[1]: Stopping test.service... machine # [ 81.914790] systemd[1]: Starting test.service... machine # [ 81.938397] systemd[1]: Finished test.service. machine # [ 81.943029] systemd[1]: Reached target Remote File Systems. machine # [ 81.951293] systemd[1]: Starting linger-users.service... machine # [ 81.956859] systemd[1]: Reached target Local File Systems. machine # [ 81.960442] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.961878] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 81.969087] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 81.977646] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 81.978566] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 81.979964] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 81.989238] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 81.992725] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.995133] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.042135] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 82.043934] systemd[1]: Finished linger-users.service. machine # [ 82.189861] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 82.192733] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 82.450261] nixos[5588]: finished switching to system configuration /nix/store/f7x7r7b0sbq3akafyp7mnam7wkwq20dg-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.93 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 82.689629] nixos[5730]: switching to system configuration /nix/store/30v6341dy5z6wxlrk1aprw0gjjlgl61k-nixos-system-machine-test machine # [ 82.692959] systemd[1]: Stopped target Local File Systems. machine # [ 82.695471] systemd[1]: Stopped target Remote File Systems. machine # [ 82.991512] systemd[1]: Reload requested from client PID 5730 ('.switch-to-conf') (unit backdoor.service)... machine # [ 82.993910] systemd[1]: Reloading... machine # [ 83.335305] systemd[1]: Reloading finished in 339 ms. machine # [ 83.422855] systemd[572]: Reexecution requested from client PID 5799 ('switch-to-confi')... machine # [ 83.427069] systemd[572]: Reexecuting. machine # [ 83.483525] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.596229] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.602697] systemd[572]: Reload requested from client PID 5799 ('switch-to-confi')... machine # [ 83.606498] systemd[572]: Reloading... machine # [ 83.711076] systemd[572]: Reloading finished in 105 ms. machine # [ 83.732182] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.743493] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 83.744701] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 83.746920] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 83.780761] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 83.784704] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 83.786647] systemd[1]: Stopping Reactivate sysinit units... machine # [ 83.787542] systemd[1]: Reached target Reactivate sysinit units. machine # [ 83.789717] systemd[1]: test.service: Deactivated successfully. machine # [ 83.792328] systemd[1]: Stopped test.service. machine # [ 83.793091] systemd[1]: Stopping test.service... machine # [ 83.795304] systemd[1]: Starting test.service... machine # [ 83.821203] systemd[1]: Finished test.service. machine # [ 83.825083] systemd[1]: Reached target Remote File Systems. machine # [ 83.830344] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.833575] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 83.836667] systemd[1]: Reached target Local File Systems. machine # [ 83.841742] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 83.847939] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 83.850121] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 83.851446] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 83.858356] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 83.860322] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.861663] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.026148] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 84.029487] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 84.033629] systemd[1]: Starting linger-users.service... machine # [ 84.074572] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 84.078061] systemd[1]: Finished linger-users.service. machine # [ 84.332344] nixos[5730]: finished switching to system configuration /nix/store/30v6341dy5z6wxlrk1aprw0gjjlgl61k-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.88 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 84.569399] nixos[5872]: switching to system configuration /nix/store/2g711v7a5dp9dhxs7f21qxp884cfariz-nixos-system-machine-test machine # [ 84.572762] systemd[1]: Stopped target Local File Systems. machine # [ 84.574893] systemd[1]: Stopped target Remote File Systems. machine # [ 84.861700] systemd[1]: Reload requested from client PID 5872 ('.switch-to-conf') (unit backdoor.service)... machine # [ 84.863756] systemd[1]: Reloading... machine # [ 85.190808] systemd[1]: Reloading finished in 325 ms. machine # [ 85.278848] systemd[572]: Reexecution requested from client PID 5941 ('switch-to-confi')... machine # [ 85.283399] systemd[572]: Reexecuting. machine # [ 85.339769] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.457897] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.464936] systemd[572]: Reload requested from client PID 5941 ('switch-to-confi')... machine # [ 85.468299] systemd[572]: Reloading... machine # [ 85.576185] systemd[572]: Reloading finished in 108 ms. machine # [ 85.592173] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.601813] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 85.604364] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 85.606502] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 85.639732] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 85.644882] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 85.645893] systemd[1]: Stopping Reactivate sysinit units... machine # [ 85.646726] systemd[1]: Reached target Reactivate sysinit units. machine # [ 85.648963] systemd[1]: test.service: Deactivated successfully. machine # [ 85.652202] systemd[1]: Stopped test.service. machine # [ 85.652951] systemd[1]: Stopping test.service... machine # [ 85.654677] systemd[1]: Starting test.service... machine # [ 85.680863] systemd[1]: Finished test.service. machine # [ 85.684528] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.688756] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 85.692357] systemd[1]: Reached target Remote File Systems. machine # [ 85.695924] systemd[1]: Starting linger-users.service... machine # [ 85.700549] systemd[1]: Reached target Local File Systems. machine # [ 85.711234] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 85.721193] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 85.722130] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 85.723395] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 85.733011] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 85.736543] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.738369] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.787149] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 85.789907] systemd[1]: Finished linger-users.service. machine # [ 85.925303] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 85.928984] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 86.183247] nixos[5872]: finished switching to system configuration /nix/store/2g711v7a5dp9dhxs7f21qxp884cfariz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 1.85 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 86.411423] nixos[6014]: switching to system configuration /nix/store/89hgfl7546jyh2d52psxkwdh6yzfzl81-nixos-system-machine-test machine # [ 86.415237] systemd[1]: Stopped target Remote File Systems. machine # [ 86.417094] systemd[1]: Stopped target Local File Systems. machine # [ 86.702336] systemd[1]: Reload requested from client PID 6014 ('.switch-to-conf') (unit backdoor.service)... machine # [ 86.704595] systemd[1]: Reloading... machine # [ 87.027053] systemd[1]: Reloading finished in 321 ms. machine # [ 87.120600] systemd[572]: Reexecution requested from client PID 6083 ('switch-to-confi')... machine # [ 87.123494] systemd[572]: Reexecuting. machine # [ 87.185039] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.307925] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.316229] systemd[572]: Reload requested from client PID 6083 ('switch-to-confi')... machine # [ 87.317770] systemd[572]: Reloading... machine # [ 87.434569] systemd[572]: Reloading finished in 115 ms. machine # [ 87.452199] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.462313] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 87.464854] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 87.467131] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 87.502691] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 87.506869] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 87.508533] systemd[1]: Stopping Reactivate sysinit units... machine # [ 87.509453] systemd[1]: Reached target Reactivate sysinit units. machine # [ 87.512392] systemd[1]: test.service: Deactivated successfully. machine # [ 87.513388] systemd[1]: Stopped test.service. machine # [ 87.514060] systemd[1]: Stopping test.service... machine # [ 87.518439] systemd[1]: Starting test.service... machine # [ 87.546279] systemd[1]: Finished test.service. machine # [ 87.552188] systemd[1]: Reached target Local File Systems. machine # [ 87.554254] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.555788] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 87.559525] systemd[1]: Reached target Remote File Systems. machine # [ 87.566092] systemd[1]: Starting linger-users.service... machine # [ 87.578415] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 87.589221] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 87.590157] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 87.591433] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 87.599919] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 87.606750] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.611777] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.655539] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 87.660625] systemd[1]: Finished linger-users.service. machine # [ 87.807796] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 87.811509] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 88.065685] nixos[6014]: finished switching to system configuration /nix/store/89hgfl7546jyh2d52psxkwdh6yzfzl81-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.88 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 88.322958] nixos[6156]: switching to system configuration /nix/store/k6g5yaclvin488sysz1yy3z4l6h2s6zk-nixos-system-machine-test machine # [ 88.325676] systemd[1]: Stopped target Local File Systems. machine # [ 88.328155] systemd[1]: Stopped target Remote File Systems. machine # [ 88.642558] systemd[1]: Reload requested from client PID 6156 ('.switch-to-conf') (unit backdoor.service)... machine # [ 88.644830] systemd[1]: Reloading... machine # [ 88.989550] systemd[1]: Reloading finished in 342 ms. machine # [ 89.080426] systemd[572]: Reexecution requested from client PID 6225 ('switch-to-confi')... machine # [ 89.081885] systemd[572]: Reexecuting. machine # [ 89.139851] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.255933] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.263303] systemd[572]: Reload requested from client PID 6225 ('switch-to-confi')... machine # [ 89.266033] systemd[572]: Reloading... machine # [ 89.376819] systemd[572]: Reloading finished in 109 ms. machine # [ 89.392184] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.402053] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 89.404679] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 89.406913] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 89.440891] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 89.444475] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 89.448351] systemd[1]: Stopping Reactivate sysinit units... machine # [ 89.449263] systemd[1]: Reached target Reactivate sysinit units. machine # [ 89.451782] systemd[1]: Reloading test.service... machine # [ 89.477145] systemd[1]: Reloaded test.service. machine # [ 89.480264] systemd[1]: Reached target Remote File Systems. machine # [ 89.486206] systemd[1]: Reached target Local File Systems. machine # [ 89.487105] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 89.493095] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 89.494003] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 89.495277] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 89.503183] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 89.514618] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.516987] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.520392] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.521796] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 89.678744] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 89.683094] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 89.688357] systemd[1]: Starting linger-users.service... machine # [ 89.726619] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 89.729970] systemd[1]: Finished linger-users.service. machine # [ 89.984269] nixos[6156]: finished switching to system configuration /nix/store/k6g5yaclvin488sysz1yy3z4l6h2s6zk-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.92 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 90.223279] nixos[6298]: switching to system configuration /nix/store/g4ni3fh3psz3y0l6j219nfvlf2xn6565-nixos-system-machine-test machine # [ 90.229561] systemd[1]: Stopped target Remote File Systems. machine # [ 90.230483] systemd[1]: Stopped target Local File Systems. machine # [ 90.536121] systemd[1]: Reload requested from client PID 6298 ('.switch-to-conf') (unit backdoor.service)... machine # [ 90.538409] systemd[1]: Reloading... machine # [ 90.870840] systemd[1]: Reloading finished in 331 ms. machine # [ 90.955276] systemd[572]: Reexecution requested from client PID 6367 ('switch-to-confi')... machine # [ 90.959699] systemd[572]: Reexecuting. machine # [ 91.016791] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.130270] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.137145] systemd[572]: Reload requested from client PID 6367 ('switch-to-confi')... machine # [ 91.138470] systemd[572]: Reloading... machine # [ 91.246447] systemd[572]: Reloading finished in 106 ms. machine # [ 91.264197] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.274739] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 91.277117] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 91.279321] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 91.312146] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 91.317128] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 91.318120] systemd[1]: Stopping Reactivate sysinit units... machine # [ 91.324166] systemd[1]: Reached target Reactivate sysinit units. machine # [ 91.328394] systemd[1]: Reloading test.service... machine # [ 91.349328] systemd[1]: Reloaded test.service. machine # [ 91.355167] systemd[1]: Reached target Remote File Systems. machine # [ 91.361214] systemd[1]: Starting linger-users.service... machine # [ 91.365934] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.367356] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 91.376841] systemd[1]: Reached target Local File Systems. machine # [ 91.377697] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 91.384853] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 91.385832] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 91.387151] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 91.396550] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 91.398380] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.407426] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.454274] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 91.458647] systemd[1]: Finished linger-users.service. machine # [ 91.592485] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 91.596411] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 91.850705] nixos[6298]: finished switching to system configuration /nix/store/g4ni3fh3psz3y0l6j219nfvlf2xn6565-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.87 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 92.102153] nixos[6440]: switching to system configuration /nix/store/yzh31zcgca0s5snv4c6hp2j51vcnbvys-nixos-system-machine-test machine # [ 92.104947] systemd[1]: Stopped target Remote File Systems. machine # [ 92.107498] systemd[1]: Stopped target Local File Systems. machine # [ 92.418151] systemd[1]: Reload requested from client PID 6440 ('.switch-to-conf') (unit backdoor.service)... machine # [ 92.420354] systemd[1]: Reloading... machine # [ 92.757556] systemd[1]: Reloading finished in 334 ms. machine # [ 92.846008] systemd[572]: Reexecution requested from client PID 6509 ('switch-to-confi')... machine # [ 92.850331] systemd[572]: Reexecuting. machine # [ 92.899315] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.013801] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.021609] systemd[572]: Reload requested from client PID 6509 ('switch-to-confi')... machine # [ 93.023043] systemd[572]: Reloading... machine # [ 93.134216] systemd[572]: Reloading finished in 109 ms. machine # [ 93.148194] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.158458] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 93.161233] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 93.163761] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 93.198111] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 93.202518] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 93.204961] systemd[1]: Stopping Reactivate sysinit units... machine # [ 93.205917] systemd[1]: Reached target Reactivate sysinit units. machine # [ 93.210398] systemd[1]: test.service: Deactivated successfully. machine # [ 93.216279] systemd[1]: Stopped test.service. machine # [ 93.217097] systemd[1]: Stopping test.service... machine # [ 93.217800] systemd[1]: Starting test.service... machine # [ 93.244617] systemd[1]: Finished test.service. machine # [ 93.249989] systemd[1]: Reached target Local File Systems. machine # [ 93.254151] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 93.259203] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 93.263606] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 93.268871] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 93.271227] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 93.283354] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.285080] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.286391] systemd[1]: Reached target Remote File Systems. machine # [ 93.287212] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.289048] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 93.463627] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 93.468632] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 93.471857] systemd[1]: Starting linger-users.service... machine # [ 93.518444] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 93.520521] systemd[1]: Finished linger-users.service. machine # [ 93.776806] nixos[6440]: finished switching to system configuration /nix/store/yzh31zcgca0s5snv4c6hp2j51vcnbvys-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.93 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 94.003401] nixos[6582]: switching to system configuration /nix/store/f7x7r7b0sbq3akafyp7mnam7wkwq20dg-nixos-system-machine-test machine # [ 94.006202] systemd[1]: Stopped target Local File Systems. machine # [ 94.008709] systemd[1]: Stopped target Remote File Systems. machine # [ 94.299998] systemd[1]: Reload requested from client PID 6582 ('.switch-to-conf') (unit backdoor.service)... machine # [ 94.302122] systemd[1]: Reloading... machine # [ 94.625073] systemd[1]: Reloading finished in 321 ms. machine # [ 94.716238] systemd[572]: Reexecution requested from client PID 6651 ('switch-to-confi')... machine # [ 94.720088] systemd[572]: Reexecuting. machine # [ 94.776807] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.889367] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.897088] systemd[572]: Reload requested from client PID 6651 ('switch-to-confi')... machine # [ 94.900304] systemd[572]: Reloading... machine # [ 95.018254] systemd[572]: Reloading finished in 116 ms. machine # [ 95.040282] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.051660] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 95.054349] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 95.057024] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 95.089518] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 95.093853] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 95.096253] systemd[1]: Stopping Reactivate sysinit units... machine # [ 95.097156] systemd[1]: Reached target Reactivate sysinit units. machine # [ 95.100294] systemd[1]: Reached target Remote File Systems. machine # [ 95.106941] systemd[1]: Starting linger-users.service... machine # [ 95.116661] systemd[1]: Reached target Local File Systems. machine # [ 95.117548] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 95.130441] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 95.131367] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 95.133777] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 95.137227] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 95.138889] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.143845] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.147043] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.151597] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 95.198274] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 95.201451] systemd[1]: Finished linger-users.service. machine # [ 95.337142] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 95.340814] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 95.594982] nixos[6582]: finished switching to system configuration /nix/store/f7x7r7b0sbq3akafyp7mnam7wkwq20dg-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.82 seconds) (finished: subtest: unit file parser, in 24.46 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 95.817610] nixos[6722]: switching to system configuration /nix/store/94mf2bvp763s7jynh1fw6p32r84z3kxk-nixos-system-machine-test machine # [ 95.820856] systemd[1]: Stopped target Remote File Systems. machine # [ 95.823551] systemd[1]: Stopped target Local File Systems. machine # [ 96.102888] systemd[1]: Reload requested from client PID 6722 ('.switch-to-conf') (unit backdoor.service)... machine # [ 96.105102] systemd[1]: Reloading... machine # [ 96.407636] systemd[1]: Reloading finished in 301 ms. machine # [ 96.493990] systemd[572]: Reexecution requested from client PID 6791 ('switch-to-confi')... machine # [ 96.497670] systemd[572]: Reexecuting. machine # [ 96.543144] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.650419] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.657186] systemd[572]: Reload requested from client PID 6791 ('switch-to-confi')... machine # [ 96.661019] systemd[572]: Reloading... machine # [ 96.764321] systemd[572]: Reloading finished in 104 ms. machine # [ 96.780190] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.791413] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 96.792763] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 96.794972] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 96.826584] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 96.830995] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 96.833262] systemd[1]: Stopping Reactivate sysinit units... machine # [ 96.834132] systemd[1]: Reached target Reactivate sysinit units. machine # [ 96.838254] systemd[1]: Reached target Local File Systems. machine # [ 96.841524] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 96.844144] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 96.845021] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 96.853868] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 96.860379] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 96.862031] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.863301] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.868180] systemd[1]: Reached target Remote File Systems. machine # [ 96.869019] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.870278] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 97.021900] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 97.026963] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 97.029337] systemd[1]: Starting linger-users.service... machine # [ 97.068519] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 97.070705] systemd[1]: Finished linger-users.service. machine # [ 97.326398] nixos[6722]: finished switching to system configuration /nix/store/94mf2bvp763s7jynh1fw6p32r84z3kxk-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.73 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 97.553858] nixos[6862]: switching to system configuration /nix/store/66z1hr66r4qr3v7glkkz8y6q5als56mb-nixos-system-machine-test machine # [ 97.556599] systemd[1]: Stopped target Remote File Systems. machine # [ 97.560159] systemd[1]: test.service: Deactivated successfully. machine # [ 97.561082] systemd[1]: Stopped test.service. machine # [ 97.561770] systemd[1]: Stopped target Local File Systems. machine # [ 97.854270] systemd[1]: Reload requested from client PID 6862 ('.switch-to-conf') (unit backdoor.service)... machine # [ 97.856979] systemd[1]: Reloading... machine # [ 98.193585] systemd[1]: Reloading finished in 333 ms. machine # [ 98.288736] systemd[572]: Reexecution requested from client PID 6932 ('switch-to-confi')... machine # [ 98.291249] systemd[572]: Reexecuting. machine # [ 98.348400] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.465411] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.472518] systemd[572]: Reload requested from client PID 6932 ('switch-to-confi')... machine # [ 98.476154] systemd[572]: Reloading... machine # [ 98.588231] systemd[572]: Reloading finished in 112 ms. machine # [ 98.604212] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.613571] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 98.616155] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 98.618422] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 98.654085] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 98.658446] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 98.660931] systemd[1]: Stopping Reactivate sysinit units... machine # [ 98.661873] systemd[1]: Reached target Reactivate sysinit units. machine # [ 98.668265] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 98.672704] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 98.692649] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 98.702777] systemd[1]: Starting simple-restart-service.service... machine # [ 98.703850] systemd[1]: Reached target Local File Systems. machine # [ 98.720700] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 98.721806] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 98.722984] systemd[1]: Reached target Remote File Systems. machine # [ 98.742838] systemd[1]: Starting linger-users.service... machine # [ 98.743868] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 98.764292] systemd[1]: Starting reload-triggers.service... machine # [ 98.787990] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 98.812344] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 98.813608] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 98.849560] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 98.850830] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 98.890752] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 98.924826] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 98.943226] systemd[1]: Starting no-restart-service.service... machine # [ 98.959895] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 98.984304] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 99.004198] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 99.018860] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 99.036455] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 99.038311] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.039659] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.041510] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 99.042804] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.050089] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 99.051606] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 99.058131] systemd[1]: Finished simple-restart-service.service. machine # [ 99.059104] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 99.065505] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 99.066507] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 99.067758] systemd[1]: Finished reload-triggers.service. machine # [ 99.074918] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 99.080846] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 99.082011] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 99.083150] systemd[1]: Finished no-restart-service.service. machine # [ 99.086795] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 99.089005] systemd[1]: Finished linger-users.service. machine # [ 99.228194] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 99.231215] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 99.235415] systemd[1]: Starting simple-reload-service.service... machine # [ 99.244452] systemd[1]: Starting simple-service.service... machine # [ 99.245389] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 99.263863] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 99.319275] systemd[1]: Finished simple-reload-service.service. machine # [ 99.323206] systemd[1]: Finished simple-service.service. machine # [ 99.324379] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 99.325479] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 99.578762] nixos[6862]: finished switching to system configuration /nix/store/66z1hr66r4qr3v7glkkz8y6q5als56mb-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.25 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 99.846559] nixos[7033]: switching to system configuration /nix/store/66z1hr66r4qr3v7glkkz8y6q5als56mb-nixos-system-machine-test machine # [ 99.850690] systemd[1]: Stopped target Local File Systems. machine # [ 99.851797] systemd[1]: Stopped target Remote File Systems. machine # [ 100.167929] systemd[1]: Reload requested from client PID 7033 ('.switch-to-conf') (unit backdoor.service)... machine # [ 100.170201] systemd[1]: Reloading... machine # [ 100.507664] systemd[1]: Reloading finished in 335 ms. machine # [ 100.604576] systemd[572]: Reexecution requested from client PID 7104 ('switch-to-confi')... machine # [ 100.608342] systemd[572]: Reexecuting. machine # [ 100.667442] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 100.786860] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 100.794008] systemd[572]: Reload requested from client PID 7104 ('switch-to-confi')... machine # [ 100.798316] systemd[572]: Reloading... machine # [ 100.910024] systemd[572]: Reloading finished in 112 ms. machine # [ 100.924220] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 100.935329] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 100.936550] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 100.939132] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 100.975416] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 100.980164] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 100.983236] systemd[1]: Stopping Reactivate sysinit units... machine # [ 100.987929] systemd[1]: Reached target Reactivate sysinit units. machine # [ 100.992282] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 100.997324] systemd[1]: Reloading reload-triggers.service... machine # [ 101.008400] systemd[1]: Reloading simple-reload-service.service... machine # [ 101.020550] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 101.036185] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 101.037440] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 101.109724] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 101.118960] systemd[1]: Reloaded simple-reload-service.service. machine # [ 101.125807] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 101.126852] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 101.127871] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 101.132973] systemd[1]: Reloaded reload-triggers.service. machine # [ 101.136463] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 101.140434] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 101.141538] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 101.143986] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 101.148634] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 101.149792] systemd[1]: Stopped simple-restart-service.service. machine # [ 101.150677] systemd[1]: Stopping simple-restart-service.service... machine # [ 101.153776] systemd[1]: Starting simple-restart-service.service... machine # [ 101.165037] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 101.177522] systemd[1]: Stopped simple-service.service. machine # [ 101.178409] systemd[1]: Stopping simple-service.service... machine # [ 101.179213] systemd[1]: Starting simple-service.service... machine # [ 101.203869] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 101.209277] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 101.210604] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 101.230316] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 101.231846] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 101.255073] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 101.268169] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 101.285315] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 101.294046] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 101.296479] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 101.297564] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 101.298554] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 101.299653] systemd[1]: Finished simple-service.service. machine # [ 101.307779] systemd[1]: Finished simple-restart-service.service. machine # [ 101.313993] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 101.315021] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 101.323233] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 101.328229] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 101.329296] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.330665] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 101.340640] systemd[1]: Reached target Local File Systems. machine # [ 101.341544] systemd[1]: Reached target Remote File Systems. machine # [ 101.342370] systemd[1]: Starting linger-users.service... machine # [ 101.343150] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 101.345045] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 101.345920] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 101.347184] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 101.355074] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 101.360873] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.367120] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.412878] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 101.417491] systemd[1]: Finished linger-users.service. machine # [ 101.550178] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 101.553387] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 101.810288] nixos[7033]: finished switching to system configuration /nix/store/66z1hr66r4qr3v7glkkz8y6q5als56mb-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.23 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 102.088414] nixos[7199]: switching to system configuration /nix/store/z7ywqnghkyfp29q7wwi4fnbngiallrsi-nixos-system-machine-test machine # [ 102.091028] systemd[1]: Stopped target Remote File Systems. machine # [ 102.093300] systemd[1]: Stopped target Local File Systems. machine # [ 102.404411] systemd[1]: Reload requested from client PID 7199 ('.switch-to-conf') (unit backdoor.service)... machine # [ 102.406464] systemd[1]: Reloading... machine # [ 102.753000] systemd[1]: Reloading finished in 345 ms. machine # [ 102.849463] systemd[572]: Reexecution requested from client PID 7269 ('switch-to-confi')... machine # [ 102.853949] systemd[572]: Reexecuting. machine # [ 102.920945] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.042725] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.049992] systemd[572]: Reload requested from client PID 7269 ('switch-to-confi')... machine # [ 103.054332] systemd[572]: Reloading... machine # [ 103.164522] systemd[572]: Reloading finished in 111 ms. machine # [ 103.180203] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.190233] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 103.193050] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 103.195350] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 103.232958] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 103.237578] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 103.243116] systemd[1]: Stopping Reactivate sysinit units... machine # [ 103.244508] systemd[1]: Reached target Reactivate sysinit units. machine # [ 103.246534] systemd[1]: Reloading reload-triggers.service... machine # [ 103.252678] systemd[1]: Reloading simple-reload-service.service... machine # [ 103.263983] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 103.276248] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 103.329509] systemd[1]: Reloaded reload-triggers.service. machine # [ 103.332245] systemd[1]: Reloaded simple-reload-service.service. machine # [ 103.335360] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 103.337182] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 103.340636] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 103.341924] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 103.342910] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 103.350279] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 103.351419] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 103.368373] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 103.369383] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 103.370348] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 103.371326] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 103.402191] systemd[1]: Stopped simple-restart-service.service. machine # [ 103.403176] systemd[1]: Stopping simple-restart-service.service... machine # [ 103.414120] systemd[1]: Starting simple-restart-service.service... machine # [ 103.415177] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 103.438291] systemd[1]: Stopped simple-service.service. machine # [ 103.453031] systemd[1]: Stopping simple-service.service... machine # [ 103.465572] systemd[1]: Starting simple-service.service... machine # [ 103.475869] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 103.498050] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 103.516571] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 103.518147] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 103.519524] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 103.529858] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 103.531106] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 103.533104] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 103.534293] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 103.535576] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 103.539892] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 103.541594] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 103.543324] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 103.545388] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 103.546356] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 103.547361] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 103.550011] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 103.551037] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 103.554781] systemd[1]: Finished simple-restart-service.service. machine # [ 103.555802] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 103.564768] systemd[1]: Finished simple-service.service. machine # [ 103.565677] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 103.566786] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 103.567886] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 103.581719] systemd[1]: Reached target Local File Systems. machine # [ 103.582601] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.583929] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 103.594585] systemd[1]: Reached target Remote File Systems. machine # [ 103.595523] systemd[1]: Starting linger-users.service... machine # [ 103.599344] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 103.604675] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 103.609729] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 103.613561] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 103.615835] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 103.625470] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.626842] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.663415] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 103.667385] systemd[1]: Finished linger-users.service. machine # [ 103.797082] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 103.800979] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 104.055518] nixos[7199]: finished switching to system configuration /nix/store/z7ywqnghkyfp29q7wwi4fnbngiallrsi-nixos-system-machine-test machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.25 seconds) machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-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/njjs6j83qrbp95dm8can43b8r9q8sz2p-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.82 seconds) (finished: run the VM test script, in 105.19 seconds) test script finished in 105.26s cleanup kill QemuMachine (pid 45) machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lq2fsnmg0q3y0vlxn91w8s8wvj1m6fld-python3-3.14.8/bin/python3.14) machine # [2026-10-22T03:00:01Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-22T03:00:01Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-22T03:00:01Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.15 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