vm-test-run-switch-test-services
checks.aarch64-linux.switchTest
· build #63
· raw
1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7machine: waiting for unit multi-user.target8machine: waiting for the VM to finish booting9machine: starting vm10machine: QEMU running (pid 45)11machine # Disk image does not exist, creating the virtualisation disk image...12machine # Formatting '/build/vm-state-machine/tmp.Zj5QTTfqNt', fmt=raw size=107374182413machine # mke2fs 1.47.4 (6-Mar-2025)14machine # Discarding device blocks: 0/262144 done15machine # Creating filesystem with 262144 4k blocks and 65536 inodes16machine # Filesystem UUID: 50be2061-2819-4b4a-99a1-9668a36e189d17machine # Superblock backups stored on blocks:18machine # 32768, 98304, 163840, 22937619machine # 20machine # Allocating group tables: 0/8 done21machine # Writing inode tables: 0/8 done22machine # Creating journal (8192 blocks): done23machine # Writing superblocks and filesystem accounting information: 0/8 done24machine # 25machine # Virtualisation disk image created.26machine # Starting virtiofs daemons...27machine # [2026-10-21T03:00:44Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)28machine # [2026-10-21T03:00:44Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether29machine # [2026-10-21T03:00:44Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)30machine # [2026-10-21T03:00:44Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether31machine # [2026-10-21T03:00:44Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)32machine # [2026-10-21T03:00:44Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether33machine # [2026-10-21T03:00:44Z INFO virtiofsd] Waiting for vhost-user socket connection...34machine # [2026-10-21T03:00:44Z INFO virtiofsd] Waiting for vhost-user socket connection...35machine # [2026-10-21T03:00:44Z INFO virtiofsd] Waiting for vhost-user socket connection...36machine # [2026-10-21T03:00:44Z INFO virtiofsd] Client connected, servicing requests37machine # [2026-10-21T03:00:44Z INFO virtiofsd] Client connected, servicing requests38machine # [2026-10-21T03:00:44Z INFO virtiofsd] Client connected, servicing requests39machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]40machine # [ 0.000000] Linux version 6.18.57 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT @179205830041machine # [ 0.000000] KASLR enabled42machine # [ 0.000000] random: crng init done43machine # [ 0.000000] Machine model: linux,dummy-virt44machine # [ 0.000000] efi: UEFI not found.45machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT46machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]47machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f]48machine # [ 0.000000] Zone ranges:49machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]50machine # [ 0.000000] DMA32 empty51machine # [ 0.000000] Normal empty52machine # [ 0.000000] Device empty53machine # [ 0.000000] Movable zone start for each node54machine # [ 0.000000] Early memory node ranges55machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]56machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]57machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc0000058machine # [ 0.000000] psci: probing for conduit method from DT.59machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.60machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs61machine # [ 0.000000] psci: Trusted OS migration not required62machine # [ 0.000000] psci: SMC Calling Convention v1.163machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)64machine # [ 0.000000] percpu: Embedded 76 pages/cpu s187672 r8192 d115432 u31129665machine # [ 0.000000] Detected PIPT I-cache on CPU066machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)67machine # [ 0.000000] CPU features: detected: GICv3 CPU interface68machine # [ 0.000000] CPU features: detected: Spectre-v469machine # [ 0.000000] CPU features: detected: Spectre-BHB70machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_3871machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_2372machine # [ 0.000000] alternatives: applying boot alternatives73machine # [ 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/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/init regInfo=/nix/.ro-store/js11mcz8xjvm55msxbsi4x0vjlgvm62b-closure-info/registration console=ttyAMA0,115200n8 console=tty074machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/js11mcz8xjvm55msxbsi4x0vjlgvm62b-closure-info/registration", will be passed to user space.75machine # [ 0.000000] printk: log buffer data + meta data: 1048576 + 3670016 = 4718592 bytes76machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)77machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)78machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB79machine # [ 0.000000] software IO TLB: area num 1.80machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)81machine # [ 0.000000] Fallback order for Node 0: 082machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 26214483machine # [ 0.000000] Policy zone: DMA84machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off85machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=186machine # [ 0.000000] allocated 2097152 bytes of page_ext87machine # [ 0.000000] ftrace: allocating 75301 entries in 296 pages88machine # [ 0.000000] ftrace: allocated 296 pages with 3 groups89machine # [ 0.000000] rcu: Hierarchical RCU implementation.90machine # [ 0.000000] rcu: RCU event tracing is enabled.91machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1.92machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.93machine # [ 0.000000] Rude variant of Tasks RCU enabled.94machine # [ 0.000000] Tracing variant of Tasks RCU enabled.95machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.96machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=197machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.98machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.99machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.100machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0101machine # [ 0.000000] GICv3: 256 SPIs implemented102machine # [ 0.000000] GICv3: 0 Extended SPIs implemented103machine # [ 0.000000] Root IRQ handler: gic_handle_irq104machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI105machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0106machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000107machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]108machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @450e0000 (indirect, esz 8, psz 64K, shr 1)109machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @450f0000 (flat, esz 8, psz 64K, shr 1)110machine # [ 0.000000] GICv3: using LPI property table @0x0000000045100000111machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000045120000112machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.113machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns114machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).115machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns116machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns117machine # [ 0.000034] arm-pv: using stolen time PV118machine # [ 0.000469] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)119machine # [ 0.000695] Console: colour dummy device 80x25120machine # [ 0.000706] printk: legacy console [tty0] enabled121machine # [ 0.000907] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)122machine # [ 0.000915] pid_max: default: 32768 minimum: 301123machine # [ 0.001001] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima124machine # [ 0.001138] landlock: Up and running.125machine # [ 0.001141] Yama: becoming mindful.126machine # [ 0.001671] LSM support for eBPF active127machine # [ 0.001803] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)128machine # [ 0.001824] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)129machine # [ 0.003991] rcu: Hierarchical SRCU implementation.130machine # [ 0.004029] rcu: Max phase no-delay instances is 1000.131machine # [ 0.005315] fsl-mc MSI: its@8080000 domain created132machine # [ 0.005443] EFI services will not be available.133machine # [ 0.005571] smp: Bringing up secondary CPUs ...134machine # [ 0.005582] smp: Brought up 1 node, 1 CPU135machine # [ 0.005585] SMP: Total of 1 processors activated.136machine # [ 0.005588] CPU: All CPU(s) started at EL1137machine # [ 0.005599] CPU features: detected: Branch Target Identification138machine # [ 0.005603] CPU features: detected: ARMv8.4 Translation Table Level139machine # [ 0.005606] CPU features: detected: Instruction cache invalidation not required for I/D coherence140machine # [ 0.005610] CPU features: detected: Data cache clean to the PoU not required for I/D coherence141machine # [ 0.005619] CPU features: detected: Common not Private translations142machine # [ 0.005622] CPU features: detected: CRC32 instructions143machine # [ 0.005625] CPU features: detected: Data cache clean to Point of Deep Persistence144machine # [ 0.005628] CPU features: detected: Data cache clean to Point of Persistence145machine # [ 0.005631] CPU features: detected: Data independent timing control (DIT)146machine # [ 0.005634] CPU features: detected: E0PD147machine # [ 0.005637] CPU features: detected: Enhanced Counter Virtualization148machine # [ 0.005640] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)149machine # [ 0.005643] CPU features: detected: Enhanced Virtualization Traps150machine # [ 0.005646] CPU features: detected: Fine Grained Traps151machine # [ 0.005650] CPU features: detected: Generic authentication (architected QARMA5 algorithm)152machine # [ 0.005655] CPU features: detected: RCpc load-acquire (LDAPR)153machine # [ 0.005658] CPU features: detected: LSE atomic instructions154machine # [ 0.005661] CPU features: detected: Privileged Access Never155machine # [ 0.005663] CPU features: detected: PMUv3156machine # [ 0.005666] CPU features: detected: RAS Extension Support157machine # [ 0.005669] CPU features: detected: RASv1p1 Extension Support158machine # [ 0.005672] CPU features: detected: Random Number Generator159machine # [ 0.005677] CPU features: detected: Speculation barrier (SB)160machine # [ 0.005680] CPU features: detected: Stage-2 Force Write-Back161machine # [ 0.005683] CPU features: detected: TLB range maintenance instructions162machine # [ 0.005688] CPU features: detected: Speculative Store Bypassing Safe (SSBS)163machine # [ 0.005731] alternatives: applying system-wide alternatives164machine # [ 0.008809] CPU features: detected: BBM Level 2 without TLB conflict abort165machine # [ 0.009004] Memory: 886648K/1048576K available (24640K kernel code, 10246K rwdata, 26664K rodata, 7808K init, 2086K bss, 120612K reserved, 32768K cma-reserved)166machine # [ 0.009358] devtmpfs: initialized167machine # [ 0.011303] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)168machine # [ 0.011327] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).169machine # [ 0.011513] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL170machine # [ 0.011518] 0 pages in range for non-PLT usage171machine # [ 0.011519] 506368 pages in range for PLT usage172machine # [ 0.011643] pinctrl core: initialized pinctrl subsystem173machine # [ 0.012472] DMI not present or invalid.174machine # [ 0.015782] NET: Registered PF_NETLINK/PF_ROUTE protocol family175machine # [ 0.018217] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations176machine # [ 0.018449] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations177machine # [ 0.018609] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations178machine # [ 0.018634] audit: initializing netlink subsys (disabled)179machine # [ 0.019266] thermal_sys: Registered thermal governor 'fair_share'180machine # [ 0.019269] thermal_sys: Registered thermal governor 'bang_bang'181machine # [ 0.019273] thermal_sys: Registered thermal governor 'step_wise'182machine # [ 0.019275] thermal_sys: Registered thermal governor 'user_space'183machine # [ 0.019278] thermal_sys: Registered thermal governor 'power_allocator'184machine # [ 0.019315] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1185machine # [ 0.019324] cpuidle: using governor ladder186machine # [ 0.019331] cpuidle: using governor menu187machine # [ 0.019515] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.188machine # [ 0.019533] ASID allocator initialised with 65536 entries189machine # [ 0.020772] Serial: AMBA PL011 UART driver190machine # [ 0.026604] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1191machine # [ 0.026751] printk: console [ttyAMA0] enabled192machine # [ 0.157660] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages193machine # [ 0.157670] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page194machine # [ 0.157673] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages195machine # [ 0.157676] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page196machine # [ 0.157679] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages197machine # [ 0.157682] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page198machine # [ 0.157688] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages199machine # [ 0.157690] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page200machine # [ 0.158993] fbcon: Taking over console201machine # [ 0.159004] ACPI: Interpreter disabled.202machine # [ 0.169083] iommu: Default domain type: Translated203machine # [ 0.169090] iommu: DMA domain TLB invalidation policy: strict mode204machine # [ 0.169506] SCSI subsystem initialized205machine # [ 0.169723] usbcore: registered new interface driver usbfs206machine # [ 0.169757] usbcore: registered new interface driver hub207machine # [ 0.169772] usbcore: registered new device driver usb208machine # [ 0.170100] pps_core: LinuxPPS API ver. 1 registered209machine # [ 0.170104] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>210machine # [ 0.170113] PTP clock support registered211machine # [ 0.170152] EDAC MC: Ver: 3.0.0212machine # [ 0.182433] scmi_core: SCMI protocol bus registered213machine # [ 0.182823] FPGA manager framework214machine # [ 0.183352] vgaarb: loaded215machine # [ 0.183612] clocksource: Switched to clocksource arch_sys_counter216machine # [ 0.186471] VFS: Disk quotas dquot_6.6.0217machine # [ 0.186507] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)218machine # [ 0.192430] netfs: FS-Cache loaded219machine # [ 0.192548] pnp: PnP ACPI: disabled220machine # [ 0.196946] NET: Registered PF_INET protocol family221machine # [ 0.197106] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)222machine # [ 0.228071] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)223machine # [ 0.228109] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)224machine # [ 0.228133] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)225machine # [ 0.228174] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)226machine # [ 0.228248] TCP: Hash tables configured (established 8192 bind 8192)227machine # [ 0.228339] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)228machine # [ 0.228381] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)229machine # [ 0.228436] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)230machine # [ 0.228524] NET: Registered PF_UNIX/PF_LOCAL protocol family231machine # [ 0.228613] NET: Registered PF_XDP protocol family232machine # [ 0.228630] PCI: CLS 0 bytes, default 64233machine # [ 0.228876] Trying to unpack rootfs image as initramfs...234machine # [ 0.241984] kvm [1]: HYP mode not available235machine # [ 0.349655] Initialise system trusted keyrings236machine # [ 0.349698] Key type blacklist registered237machine # [ 0.349831] workingset: timestamp_bits=42 max_order=18 bucket_order=0238machine # [ 0.350235] squashfs: version 4.0 (2009/01/31) Phillip Lougher239machine # [ 0.350285] 9p: Installing v9fs 9p2000 file system support240machine # [ 0.350414] integrity: Platform Keyring initialized241machine # [ 0.350423] integrity: Machine keyring initialized242machine # [ 0.375098] Key type asymmetric registered243machine # [ 0.375116] Asymmetric key parser 'x509' registered244machine # [ 0.375202] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)245machine # [ 0.385850] io scheduler mq-deadline registered246machine # [ 0.385862] io scheduler kyber registered247machine # [ 0.391576] pl061_gpio 9030000.pl061: PL061 GPIO chip registered248machine # [ 0.393000] ledtrig-cpu: registered to indicate activity on CPUs249machine # [ 0.393395] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:250machine # [ 0.393410] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000251machine # [ 0.393424] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000252machine # [ 0.393430] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000253machine # [ 0.393450] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits254machine # [ 0.393473] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]255machine # [ 0.393550] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00256machine # [ 0.393557] pci_bus 0000:00: root bus resource [bus 00-ff]257machine # [ 0.393561] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]258machine # [ 0.393564] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]259machine # [ 0.393568] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]260machine # [ 0.393625] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint261machine # [ 0.394081] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint262machine # [ 0.394271] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]263machine # [ 0.394283] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]264machine # [ 0.394383] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]265machine # [ 0.394395] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]266machine # [ 0.394861] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint267machine # [ 0.395045] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]268machine # [ 0.395056] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]269machine # [ 0.395082] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]270machine # [ 0.395533] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint271machine # [ 0.423793] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]272machine # [ 0.423816] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]273machine # [ 0.423845] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]274machine # [ 0.424396] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint275machine # [ 0.424592] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]276machine # [ 0.424604] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]277machine # [ 0.424630] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]278machine # [ 0.424642] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]279machine # [ 0.425108] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint280machine # [ 0.425299] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]281machine # [ 0.425325] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]282machine # [ 0.425788] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint283machine # [ 0.425980] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]284machine # [ 0.426006] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]285machine # [ 0.426483] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint286machine # [ 0.426668] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]287machine # [ 0.426929] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint288machine # [ 0.427121] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]289machine # [ 0.427146] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]290machine # [ 0.427611] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint291machine # [ 0.445654] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]292machine # [ 0.445681] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]293machine # [ 0.446187] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint294machine # [ 0.446404] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]295machine # [ 0.446431] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]296machine # [ 0.446912] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint297machine # [ 0.447223] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]298machine # [ 0.447240] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]299machine # [ 0.447266] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]300machine # [ 0.459849] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint301machine # [ 0.460057] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]302machine # [ 0.460070] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]303machine # [ 0.460098] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]304machine # [ 0.460749] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned305machine # [ 0.460756] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned306machine # [ 0.460760] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned307machine # [ 0.460806] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned308machine # [ 0.460851] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned309machine # [ 0.460896] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned310machine # [ 0.460944] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned311machine # [ 0.460998] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned312machine # [ 0.461043] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned313machine # [ 0.461089] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned314machine # [ 0.461137] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned315machine # [ 0.461182] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned316machine # [ 0.461303] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned317machine # [ 0.461346] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned318machine # [ 0.461364] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned319machine # [ 0.461381] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned320machine # [ 0.461399] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned321machine # [ 0.461417] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned322machine # [ 0.461435] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned323machine # [ 0.461453] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned324machine # [ 0.461472] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned325machine # [ 0.461490] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned326machine # [ 0.461509] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned327machine # [ 0.461527] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned328machine # [ 0.461546] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned329machine # [ 0.461563] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned330machine # [ 0.461580] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned331machine # [ 0.461598] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned332machine # [ 0.461615] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned333machine # [ 0.461632] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned334machine # [ 0.461650] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned335machine # [ 0.461672] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]336machine # [ 0.461677] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]337machine # [ 0.461681] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]338machine # [ 0.462578] pci 0000:00:07.0: enabling device (0000 -> 0002)339machine # [ 0.527928] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)340machine # [ 0.530109] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)341machine # [ 0.540341] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)342machine # [ 0.542551] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)343machine # [ 0.552868] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)344machine # [ 0.555190] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)345machine # [ 0.558494] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)346machine # [ 0.568271] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)347machine # [ 0.570243] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)348machine # [ 0.573952] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)349machine # [ 0.584326] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)350machine # [ 0.590800] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled351machine # [ 0.600819] msm_serial: driver initialized352machine # [ 0.600980] SuperH (H)SCI(F) driver initialized353machine # [ 0.601040] STM32 USART driver initialized354machine # [ 0.632985] loop: module loaded355machine # [ 0.633200] virtio_blk virtio2: 1/0/0 default/read/poll queues356machine # [ 0.634079] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)357machine # [ 0.638483] megasas: 07.734.00.00-rc1358machine # [ 0.639261] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]359machine # [ 0.652750] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000360machine # [ 0.652789] Intel/Sharp Extended Query Table at 0x0031361machine # [ 0.654520] Using buffer write method362machine # [ 0.654556] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]363machine # [ 0.668467] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000364machine # [ 0.668485] Intel/Sharp Extended Query Table at 0x0031365machine # [ 0.670158] Using buffer write method366machine # [ 0.670174] Concatenating MTD devices:367machine # [ 0.670176] (0): "0.flash"368machine # [ 0.670178] (1): "0.flash"369machine # [ 0.670180] into device "0.flash"370machine # [ 0.948452] Freeing initrd memory: 26072K371machine # [ 0.954202] tun: Universal TUN/TAP device driver, 1.6372machine # [ 0.958734] thunder_xcv, ver 1.0373machine # [ 0.958785] thunder_bgx, ver 1.0374machine # [ 0.958804] nicpf, ver 1.0375machine # [ 0.959405] e1000: Intel(R) PRO/1000 Network Driver376machine # [ 0.959410] e1000: Copyright (c) 1999-2006 Intel Corporation.377machine # [ 0.959437] e1000e: Intel(R) PRO/1000 Network Driver378machine # [ 0.959445] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.379machine # [ 0.959469] igb: Intel(R) Gigabit Ethernet Network Driver380machine # [ 0.959473] igb: Copyright (c) 2007-2014 Intel Corporation.381machine # [ 0.959493] igbvf: Intel(R) Gigabit Virtual Function Network Driver382machine # [ 0.959501] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.383machine # [ 0.966787] sky2: driver version 1.30384machine # [ 0.968984] usbcore: registered new interface driver usb-storage385machine # [ 0.969142] usbcore: registered new interface driver usbserial_generic386machine # [ 0.969154] usbserial: USB Serial support registered for generic387machine # [ 0.969765] hv_vmbus: registering driver hyperv_keyboard388machine # [ 0.971057] ehci-pci 0000:00:07.0: EHCI Host Controller389machine # [ 0.971078] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1390machine # [ 0.971289] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000391machine # [ 0.977122] rtc-pl031 9010000.pl031: registered as rtc0392machine # [ 0.977143] rtc-pl031 9010000.pl031: setting system clock to 2026-10-21T03:00:45 UTC (1792551645)393machine # [ 0.977527] i2c_dev: i2c /dev entries driver394machine # [ 0.979677] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00395machine # [ 0.980064] hub 1-0:1.0: USB hub found396machine # [ 0.980079] hub 1-0:1.0: 6 ports detected397machine # [ 0.986056] sdhci: Secure Digital Host Controller Interface driver398machine # [ 0.986062] sdhci: Copyright(c) Pierre Ossman399machine # [ 0.986431] Synopsys Designware Multimedia Card Interface Driver400machine # [ 0.986817] sdhci-pltfm: SDHCI platform and OF driver helper401machine # [ 0.991439] hid: raw HID events driver (C) Jiri Kosina402machine # [ 0.992444] usbcore: registered new interface driver usbhid403machine # [ 0.992449] usbhid: USB HID core driver404machine # [ 0.993678] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available405machine # [ 0.995315] drop_monitor: Initializing network drop monitor service406machine # [ 0.995477] NET: Registered PF_INET6 protocol family407machine # [ 1.000322] Segment Routing with IPv6408machine # [ 1.000348] In-situ OAM (IOAM) with IPv6409machine # [ 1.000375] NET: Registered PF_PACKET protocol family410machine # [ 1.000439] 9pnet: Installing 9P2000 support411machine # [ 1.000480] Key type dns_resolver registered412machine # [ 1.009742] registered taskstats version 1413machine # [ 1.009884] Loading compiled-in X.509 certificates414machine # [ 1.018760] Demotion targets for Node 0: null415machine # [ 1.018869] Key type .fscrypt registered416machine # [ 1.018873] Key type fscrypt-provisioning registered417machine # [ 1.018969] ima: No TPM chip found, activating TPM-bypass!418machine # [ 1.018992] ima: Allocated hash algorithm: sha1419machine # [ 1.019013] ima: No architecture policies found420machine # [ 1.023337] input: gpio-keys as /devices/platform/gpio-keys/input/input0421machine # [ 1.042953] clk: Disabling unused clocks422machine # [ 1.042969] PM: genpd: Disabling unused power domains423machine # [ 1.049124] Freeing unused kernel memory: 7808K424machine # [ 1.049355] Run /init as init process425machine # [ 1.066986] fuse: module verification failed: signature and/or required key missing - tainting kernel426machine # [ 1.070953] fuse: init (API version 7.45)427machine # [ 1.074607] virtiofs virtio6: discovered new tag: nix-store428machine # [ 1.075373] virtiofs virtio6: virtio_fs_setup_dax: No cache capability429machine # [ 1.089311] virtiofs virtio7: discovered new tag: shared430machine # [ 1.090075] virtiofs virtio7: virtio_fs_setup_dax: No cache capability431machine # [ 1.091425] virtiofs virtio8: discovered new tag: xchg432machine # [ 1.094468] virtiofs virtio8: virtio_fs_setup_dax: No cache capability433machine # [ 1.106586] systemd[1]: Successfully made /usr/ read-only.434machine # [ 1.107102] systemd[1]: systemd 263-cb90bff 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)435machine # [ 1.107118] systemd[1]: Detected virtualization qemu.436machine # [ 1.107152] systemd[1]: Detected architecture arm64.437machine # [ 1.107159] systemd[1]: Running in initrd.438machine # [ 1.107436] systemd[1]: Initializing machine ID from random generator.439machine # [ 1.107533] systemd[1]: Hostname set to <machine>.440machine # [ 1.207082] systemd[1]: bpf-restrict-fs: LSM BPF program attached441machine # [ 1.235704] usb 1-1: new high-speed USB device number 2 using ehci-pci442machine # [ 1.263852] systemd[1]: Queued start job for default target Initrd Default Target.443machine # [ 1.270878] systemd[1]: Created slice Slice /system/modprobe.444machine # [ 1.271075] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.445machine # [ 1.271101] systemd[1]: Expecting device /dev/disk/by-label/nixos...446machine # [ 1.271123] systemd[1]: Reached target Path Units.447machine # [ 1.271137] systemd[1]: Reached target Slice Units.448machine # [ 1.271151] systemd[1]: Reached target Swaps.449machine # [ 1.271165] systemd[1]: Reached target Timer Units.450machine # [ 1.271319] systemd[1]: Listening on D-Bus System Message Bus Socket.451machine # [ 1.271463] systemd[1]: Listening on Journal Socket (/dev/log).452machine # [ 1.271580] systemd[1]: Listening on Journal Sockets.453machine # [ 1.279087] systemd[1]: Listening on udev Kernel Socket.454machine # [ 1.279304] systemd[1]: Listening on udev Varlink Socket.455machine # [ 1.279321] systemd[1]: Reached target Socket Units.456machine # [ 1.282940] systemd[1]: Starting Create List of Static Device Nodes...457machine # [ 1.283004] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs458machine # [ 1.288509] systemd[1]: Mounting Kernel Configuration File System...459machine # [ 1.302459] systemd[1]: Starting Journal Service...460machine # [ 1.309655] systemd[1]: Starting Load Kernel Modules...461machine # [ 1.309752] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os462machine # [ 1.323807] systemd[1]: Starting Coldplug All udev Devices...463machine # [ 1.340420] systemd[1]: Finished Create List of Static Device Nodes.464machine # [ 1.347440] systemd-journald[71]: Collecting audit messages is disabled.465machine # [ 1.371992] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...466machine # [ 1.372715] systemd[1]: Mounted Kernel Configuration File System.467machine # [ 1.408073] 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/input1468machine # [ 1.422341] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.469machine # [ 1.431975] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.470machine # [ 1.433711] systemd[1]: Starting Create Static Device Nodes in /dev...471machine # [ 1.439690] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev472machine # [ 1.456964] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0473machine # [ 1.457220] [drm] features: -virgl +edid -resource_blob -host_visible474machine # [ 1.457226] [drm] features: -context_init475machine # [ 1.457999] [drm] number of scanouts: 1476machine # [ 1.458014] [drm] number of cap sets: 0477machine # [ 1.480093] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic478machine # [ 1.480114] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0479machine # [ 1.500116] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0480machine # [ 1.500516] systemd[1]: Finished Create Static Device Nodes in /dev.481machine # [ 1.500776] systemd[1]: Reached target Preparation for Local File Systems.482machine # [ 1.500801] systemd[1]: Reached target Local File Systems.483machine # [ 1.508354] systemd[1]: Starting Rule-based Manager for Device Events and Files...484machine # [ 1.520968] Console: switching to colour frame buffer device 160x50485machine # [ 1.536323] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device486machine # [ 1.524669] systemd-modules-load[72]: Inserted module 'dm_mod'487machine # [ 1.529474] systemd-modules-load[72]: Module 'virtio_balloon' is built in488machine # [ 1.530725] systemd-modules-load[72]: Module 'virtio_console' is built in489machine # [ 1.547944] systemd[1]: Started Journal Service.490machine # [ 1.544616] systemd-modules-load[72]: Inserted module 'virtio_gpu'491machine # [ 1.548294] systemd-modules-load[72]: Module 'virtio_rng' is built in492machine # [ 1.552338] systemd[1]: Starting Create System Files and Directories...493machine # [ 1.557488] systemd[1]: Finished Load Kernel Modules.494machine # [ 1.597849] systemd[1]: Starting Apply Kernel Variables...495machine # [ 1.619741] usb 1-2: new high-speed USB device number 3 using ehci-pci496machine # [ 1.616493] systemd-udevd[78]: Using default interface naming scheme 'v261'.497machine # [ 1.636160] systemd[1]: Finished Create System Files and Directories.498machine # [ 1.638513] systemd[1]: Finished Apply Kernel Variables.499machine # [ 1.662666] systemd[1]: Started Rule-based Manager for Device Events and Files.500machine # [ 1.744328] systemd[1]: Starting Virtual Console Setup...501machine # [ 1.779410] 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/input2502machine # [ 1.782638] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0503machine # [ 1.838467] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones.504machine # [ 1.848343] systemd[1]: Finished Virtual Console Setup.505machine # [ 2.499926] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.506machine # [ 2.541472] (udev-worker)[91]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.507machine # [ 2.552184] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line.508machine # [ 2.592200] systemd[1]: Finished Coldplug All udev Devices.509machine # [ 2.594046] systemd[1]: Reached target System Initialization.510machine # [ 2.597525] systemd[1]: Reached target Basic System.511machine # [ 2.611294] systemd[1]: Found device /dev/disk/by-label/nixos.512machine # [ 2.612915] systemd[1]: Reached target Initrd Root Device.513machine # [ 2.617290] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...514machine # [ 2.656704] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks515machine # [ 2.663749] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.516machine # [ 2.668757] systemd[1]: Mounting /sysroot...517machine # [ 2.722036] EXT4-fs (vda): mounted filesystem 50be2061-2819-4b4a-99a1-9668a36e189d r/w with ordered data mode. Quota mode: none.518machine # [ 2.706655] systemd[1]: Mounted /sysroot.519machine # [ 2.709563] systemd[1]: Reached target Initrd Root File System.520machine # [ 2.714523] systemd[1]: Starting Mountpoints Configured in the Real Root...521machine # [ 2.750188] systemd-sysroot-fstab-check[119]: /sysroot should be mounted in the initrd, will request daemon-reload.522machine # [ 2.753788] systemd[1]: Reload requested from client PID 119 ('systemd-sysroot') (unit initrd-parse-etc.service)...523machine # [ 2.756768] systemd[1]: Reloading...524machine # [ 2.954393] systemd[1]: Reloading finished in 198 ms.525machine # [ 2.985508] systemd-sysroot-fstab-check[119]: Requesting initrd-fs.target/start/replace...526machine # [ 2.990302] systemd-sysroot-fstab-check[119]: Requesting swap.target/start/replace...527machine # [ 3.000128] systemd[1]: initrd-parse-etc.service: Deactivated successfully.528machine # [ 3.001697] systemd[1]: Finished Mountpoints Configured in the Real Root.529machine # [ 3.004115] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.530machine # [ 3.310864] systemd[1]: Mounting /sysroot/nix/.ro-store...531machine # [ 3.328158] systemd[1]: Mounting /sysroot/nix/.rw-store...532machine # [ 3.340106] systemd[1]: Mounting /sysroot/run...533machine # [ 3.351528] systemd[1]: Mounting /sysroot/tmp/shared...534machine # [ 3.382430] systemd[1]: Mounting /sysroot/tmp/xchg...535machine # [ 3.417610] systemd[1]: Mounted /sysroot/nix/.rw-store.536machine # [ 3.439150] systemd[1]: Mounted /sysroot/nix/.ro-store.537machine # [ 3.447814] systemd[1]: Mounted /sysroot/run.538machine # [ 3.455341] systemd[1]: Mounted /sysroot/tmp/shared.539machine # [ 3.475698] systemd[1]: Starting rw-sysroot-nix-store.service...540machine # [ 3.480261] systemd[1]: Mounted /sysroot/tmp/xchg.541machine # [ 3.505069] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.542machine # [ 3.506622] systemd[1]: Finished rw-sysroot-nix-store.service.543machine # [ 3.845456] (udev-worker)[92]: mtd0ro: Failed to find and pin callout binary "/nix/store/qxvgvvwldpjx75dk3nq89xjz7vvsyq6l-systemd-263-cb90bff/lib/udev/mtd_probe": No such file or directory544machine # [ 3.851042] (udev-worker)[92]: 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 directory545machine # [ 3.877062] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.546machine # [ 3.881965] systemd[1]: Stopped Virtual Console Setup.547machine # [ 3.884432] systemd[1]: Stopping Virtual Console Setup...548machine # [ 3.888166] systemd[1]: Starting Virtual Console Setup...549machine # [ 3.902294] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.550machine # [ 3.903624] systemd[1]: Stopped Virtual Console Setup.551machine # [ 3.908260] systemd[1]: Starting Virtual Console Setup...552machine # [ 3.929476] systemd-vconsole-setup[151]: Configuration of first virtual console was skipped, ignoring remaining ones.553machine # [ 3.933697] systemd[1]: Finished Virtual Console Setup.554machine # [ 4.309947] systemd[1]: Mounting /sysroot/nix/store...555machine # [ 4.356863] systemd[1]: Mounted /sysroot/nix/store.556machine # [ 4.360548] systemd[1]: Reached target Initrd File Systems.557machine # [ 4.364650] systemd[1]: Starting Find NixOS closure...558machine # [ 4.376473] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...559machine # [ 4.417816] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.560machine # [ 4.424252] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.561machine # [ 4.433665] systemd[1]: Finished Find NixOS closure.562machine # [ 4.436319] systemd[1]: Reached target Initrd Default Target.563machine # [ 4.439237] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...564machine # [ 4.468541] systemd[1]: Stopped target Initrd Default Target.565machine # [ 4.469953] systemd[1]: Stopped target Basic System.566machine # [ 4.472320] systemd[1]: Stopped target Initrd Root Device.567machine # [ 4.473454] systemd[1]: Stopped target Path Units.568machine # [ 4.476464] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.569machine # [ 4.478991] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.570machine # [ 4.481120] systemd[1]: Stopped target Slice Units.571machine # [ 4.481959] systemd[1]: Stopped target Socket Units.572machine # [ 4.482792] systemd[1]: Stopped target System Initialization.573machine # [ 4.483693] systemd[1]: Stopped target Swaps.574machine # [ 4.494377] systemd[1]: Stopped target Timer Units.575machine # [ 4.495387] systemd[1]: dbus.socket: Deactivated successfully.576machine # [ 4.499062] systemd[1]: Closed D-Bus System Message Bus Socket.577machine # [ 4.505983] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.578machine # [ 4.507330] systemd[1]: Stopped Find NixOS closure.579machine # [ 4.508431] systemd[1]: Starting rw-sysroot-nix-store.service...580machine # [ 4.511331] systemd[1]: systemd-sysctl.service: Deactivated successfully.581machine # [ 4.514528] systemd[1]: Stopped Apply Kernel Variables.582machine # [ 4.516962] systemd[1]: systemd-modules-load.service: Deactivated successfully.583machine # [ 4.518195] systemd[1]: Stopped Load Kernel Modules.584machine # [ 4.519379] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.585machine # [ 4.528427] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.586machine # [ 4.529698] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.587machine # [ 4.531130] systemd[1]: Stopped Create System Files and Directories.588machine # [ 4.540175] systemd[1]: Stopped target Local File Systems.589machine # [ 4.541413] systemd[1]: Stopped target Preparation for Local File Systems.590machine # [ 4.543130] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.591machine # [ 4.548450] systemd[1]: Stopped Coldplug All udev Devices.592machine # [ 4.549396] systemd[1]: Stopping Rule-based Manager for Device Events and Files...593machine # [ 4.550547] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.594machine # [ 4.551688] systemd[1]: Stopped Virtual Console Setup.595machine # [ 4.555497] systemd[1]: initrd-cleanup.service: Deactivated successfully.596machine # [ 4.558559] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.597machine # [ 4.559649] systemd[1]: systemd-udevd.service: Deactivated successfully.598machine # [ 4.562055] systemd[1]: Stopped Rule-based Manager for Device Events and Files.599machine # [ 4.563216] systemd[1]: systemd-udevd.service: Consumed 1.306s CPU time over 3.036s wall clock time, 25.6M memory peak.600machine # [ 4.565040] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully.601machine # [ 4.566112] systemd[1]: Closed udev Varlink Socket.602machine # [ 4.566895] systemd[1]: Starting Cleanup udev Database...603machine # [ 4.567738] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.604machine # [ 4.572337] systemd[1]: Stopped Create Static Device Nodes in /dev.605machine # [ 4.573358] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.606machine # [ 4.577516] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.607machine # [ 4.580323] systemd[1]: kmod-static-nodes.service: Deactivated successfully.608machine # [ 4.581444] systemd[1]: Stopped Create List of Static Device Nodes.609machine # [ 4.584209] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.610machine # [ 4.588288] systemd[1]: Finished rw-sysroot-nix-store.service.611machine # [ 4.623759] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.612machine # [ 4.627946] systemd[1]: Finished Cleanup udev Database.613machine # [ 4.629313] systemd[1]: Reached target Switch Root.614machine # [ 4.630630] systemd[1]: Starting NixOS Activation...615machine # [ 4.727093] initrd-nixos-activation-start[174]: booting system configuration /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test616machine # [ 4.765358] initrd-nixos-activation-start[174]: running activation script...617machine # [ 5.003741] initrd-nixos-activation-start[197]: setting up /etc...618machine # [ 5.125052] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.619machine # [ 5.128207] systemd[1]: Finished NixOS Activation.620machine # [ 5.129451] systemd[1]: Starting Switch Root...621machine # [ 5.153112] systemd[1]: Switching root.622machine # [ 5.345242] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).623machine # [ 5.440758] NET: Registered PF_VSOCK protocol family624machine # [ 5.510658] systemd[1]: systemd 263-cb90bff 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)625machine # [ 5.519282] systemd[1]: Detected virtualization qemu.626machine # [ 5.519411] systemd[1]: Detected architecture arm64.627machine # [ 5.522930] systemd[1]: Detected first boot.628machine # [ 5.525684] systemd[1]: Initializing machine ID from random generator.629machine # [ 5.649656] systemd[1]: bpf-restrict-fs: LSM BPF program attached630machine # [ 5.822513] systemd[1]: Applying preset policy.631machine # [ 6.029905] systemd[1]: Populated /etc with preset unit settings.632machine # [ 6.227413] systemd[1]: initrd-switch-root.service: Deactivated successfully.633machine # [ 6.229875] systemd[1]: Stopped initrd-switch-root.service.634machine # [ 6.232522] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.635machine # [ 6.234117] systemd[1]: Created slice Slice /system/getty.636machine # [ 6.234982] systemd[1]: Created slice User and Session Slice.637machine # [ 6.235109] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.638machine # [ 6.235190] systemd[1]: Started Forward Password Requests to Wall Directory Watch.639machine # [ 6.235599] systemd[1]: Expecting device /dev/hvc0...640machine # [ 6.242241] systemd[1]: Expecting device /dev/ttyAMA0...641machine # [ 6.242730] systemd[1]: Reached target Local Encrypted Volumes.642machine # [ 6.243515] systemd[1]: Stopped target initrd-fs.target.643machine # [ 6.246464] systemd[1]: Stopped target initrd-root-fs.target.644machine # [ 6.247109] systemd[1]: Stopped target initrd-switch-root.target.645machine # [ 6.249889] systemd[1]: Reached target Virtual Machines and Containers.646machine # [ 6.250322] systemd[1]: Reached target Path Units.647machine # [ 6.250958] systemd[1]: Reached target Remote File Systems.648machine # [ 6.251564] systemd[1]: Reached target Slice Units.649machine # [ 6.254994] systemd[1]: Reached target Swaps.650machine # [ 6.258360] systemd[1]: Listening on Query the User Interactively for a Password.651machine # [ 6.261557] systemd[1]: Listening on Process Core Dump Socket.652machine # [ 6.263076] systemd[1]: Listening on Credential Encryption/Decryption.653machine # [ 6.266795] systemd[1]: Listening on Factory Reset Management.654machine # [ 6.267360] systemd[1]: Listening on Hostname Service Socket.655machine # [ 6.273155] systemd[1]: Starting Journal Log Access Socket...656machine # [ 6.275059] systemd[1]: Listening on Journal Audit Socket.657machine # [ 6.279512] systemd[1]: Listening on Console Output Muting Service Socket.658machine # [ 6.281342] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.659machine # [ 6.282800] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os660machine # [ 6.283420] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki661machine # [ 6.291155] systemd[1]: Listening on Disk Repartitioning Service Socket.662machine # [ 6.293275] systemd[1]: Listening on udev Varlink Socket.663machine # [ 6.297245] systemd[1]: Mounting Huge Pages File System...664machine # [ 6.301543] systemd[1]: Mounting POSIX Message Queue File System...665machine # [ 6.316591] systemd[1]: Mounting Kernel Debug File System...666machine # [ 6.327343] systemd[1]: Mounting Kernel Trace File System...667machine # [ 6.341886] systemd[1]: Starting Create List of Static Device Nodes...668machine # [ 6.342492] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs669machine # [ 6.360348] systemd[1]: Mounting Kernel Configuration File System...670machine # [ 6.361787] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm671machine # [ 6.371854] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore672machine # [ 6.372439] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse673machine # [ 6.399955] systemd[1]: Mounting FUSE Control File System...674machine # [ 6.400408] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67675machine # [ 6.437581] systemd[1]: Starting Journal Service...676machine # [ 6.456400] systemd[1]: Starting Load Kernel Modules...677machine # [ 6.481909] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...678machine # [ 6.497038] systemd[1]: Starting Remount Root and Kernel File Systems...679machine # [ 6.497444] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os680machine # [ 6.518619] systemd[1]: Starting Coldplug All udev Devices...681machine # [ 6.523232] systemd-journald[268]: Collecting audit messages is enabled.682machine # [ 6.511419] systemd[1]: Queued start job for default target Multi-User System.683machine # [ 6.521010] systemd[1]: Unnecessary job was removed for /sys/devices/platform/9000000.pl011/9000000.pl011:0/9000000.pl011:0.0/tty/ttyAMA0.684machine # [ 6.523133] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0.685machine # [ 6.550528] systemd[1]: Started Journal Service.686machine # [ 6.539805] systemd[1]: systemd-journald.service: Deactivated successfully.687machine # [ 6.548268] systemd-modules-load[269]: Module 'atkbd' is built in688machine # [ 6.552514] systemd-modules-load[269]: Module 'loop' is built in689machine # [ 6.553624] systemd[1]: Listening on Journal Log Access Socket.690machine # [ 6.554612] systemd[1]: Mounted Huge Pages File System.691machine # [ 6.568380] systemd[1]: Mounted POSIX Message Queue File System.692machine # [ 6.573691] systemd[1]: Mounted Kernel Debug File System.693machine # [ 6.576363] systemd[1]: Mounted Kernel Trace File System.694machine # [ 6.582073] systemd[1]: Finished Create List of Static Device Nodes.695machine # [ 6.583180] systemd[1]: Finished Load Kernel Modules.696machine # [ 6.641274] EXT4-fs (vda): re-mounted 50be2061-2819-4b4a-99a1-9668a36e189d.697machine # [ 6.639800] systemd[1]: Starting Firewall...698machine # [ 6.647353] systemd-oomd[271]: No swap; memory pressure usage will be degraded699machine # [ 6.654857] systemd[1]: Starting Apply Kernel Variables...700machine # [ 6.664174] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...701machine # [ 6.665388] systemd[1]: Mounted Kernel Configuration File System.702machine # [ 6.668820] systemd[1]: Finished Remount Root and Kernel File Systems.703machine # [ 6.685349] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.704machine # [ 6.697456] systemd[1]: Mounted FUSE Control File System.705machine # [ 6.702267] systemd[1]: Listening on Disk Image Download Service Socket.706machine # [ 6.722508] systemd[1]: Starting Flush Journal to Persistent Storage...707machine # [ 6.730970] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore708machine # [ 6.737718] systemd[1]: Starting Load/Save OS Random Seed...709machine # [ 6.738694] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os710machine # [ 6.857676] systemd-journald[268]: Received client request to flush runtime journal.711machine # [ 6.919694] systemd[1]: Finished Load/Save OS Random Seed.712machine # [ 6.925202] systemd[1]: Reached target First Boot Complete.713machine # [ 6.926136] systemd[1]: Finished Apply Kernel Variables.714machine # [ 6.927109] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.715machine # [ 6.932937] systemd[1]: Starting Create Static Device Nodes in /dev...716machine # [ 6.933949] systemd[1]: Finished Flush Journal to Persistent Storage.717machine # [ 7.108490] systemd[1]: Finished Create Static Device Nodes in /dev.718machine # [ 7.111615] systemd[1]: Reached target Preparation for Local File Systems.719machine # [ 7.117612] systemd[1]: Starting Rule-based Manager for Device Events and Files...720machine # [ 7.217304] systemd[1]: Mounting /run/wrappers...721machine # [ 7.274363] systemd-udevd[307]: Using default interface naming scheme 'v261'.722machine # [ 7.284698] systemd[1]: Mounted /run/wrappers.723machine # [ 7.285558] systemd[1]: Reached target Local File Systems.724machine # [ 7.292129] systemd[1]: Listening on Boot Loader Control Service Socket.725machine # [ 7.299585] systemd[1]: Starting Create SUID/SGID Wrappers...726machine # [ 7.303189] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.727machine # [ 7.311032] systemd[1]: Starting Save Transient machine-id to Disk...728machine # [ 7.323659] systemd[1]: Starting Create System Files and Directories...729machine # [ 7.452106] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.730machine # [ 7.465400] systemd[1]: Finished Save Transient machine-id to Disk.731machine # [ 7.493714] systemd[1]: Started Rule-based Manager for Device Events and Files.732machine # [ 7.536446] systemd[1]: Finished Create System Files and Directories.733machine # [ 7.561359] systemd[1]: Starting Rebuild Journal Catalog...734machine # [ 7.568161] systemd[1]: Starting Record System Boot/Shutdown in UTMP...735machine # [ 7.669494] systemd[1]: Finished Record System Boot/Shutdown in UTMP.736machine # [ 7.724231] systemd[1]: Finished Rebuild Journal Catalog.737machine # [ 7.734956] systemd[1]: Starting Update is Completed...738machine # [ 7.800382] systemd[1]: Finished Update is Completed.739machine # [ 8.004484] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs740machine # [ 8.059068] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse741machine # [ 8.124137] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.742machine # [ 8.131040] systemd[1]: Finished Create SUID/SGID Wrappers.743machine # [ 8.305708] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.744machine # [ 8.340287] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.745machine # [ 8.366411] systemd[1]: Finished Coldplug All udev Devices.746machine # [ 8.369537] systemd[1]: Reached target System Initialization.747machine # [ 8.370504] systemd[1]: Started Discard unused filesystem blocks once a week.748machine # [ 8.371575] systemd[1]: Started Daily Cleanup of Temporary Directories.749machine # [ 8.380453] systemd[1]: Reached target Timer Units.750machine # [ 8.381222] systemd[1]: Listening on D-Bus System Message Bus Socket.751machine # [ 8.382131] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.752machine # [ 8.383414] systemd[1]: Reached target Socket Units.753machine # [ 8.394520] systemd[1]: Reached target Basic System.754machine # [ 8.395341] systemd[1]: Started backdoor.service.755machine # [ 8.402381] systemd[1]: Starting Import lastlog data into lastlog2 database...756machine # [ 8.403507] systemd[1]: Starting Name Service Cache Daemon (nsncd)...757machine # [ 8.411600] systemd[1]: Starting Post-Boot Actions...758machine # [ 8.429589] systemd[1]: Started Reset console on configuration changes.759machine # [ 8.493755] systemd[1]: Starting resolvconf update...760machine # connecting to host...761machine # [ 8.598473] (udev-worker)[404]: Network interface NamePolicy= disabled on kernel command line.762machine # [ 8.621120] systemd[1]: Starting D-Bus System Message Bus...763machine # [ 8.624814] systemd[1]: Finished Post-Boot Actions.764machine: Guest shell says: b'Spawning backdoor root shell...\n'765machine: connected to guest root shell766machine: (connecting took 8.96 seconds)767machine: (finished: waiting for the VM to finish booting, in 9.38 seconds)768machine # [ 8.690918] nsncd[430]: Oct 21 03:00:53.229 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"769machine # [ 8.712661] systemd[1]: Started Name Service Cache Daemon (nsncd).770machine # [ 8.724411] systemd[1]: Reached target Host and Network Name Lookups.771machine # [ 8.725469] systemd[1]: Reached target User and Group Name Lookups.772machine # [ 8.742355] (udev-worker)[338]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.773machine # [ 8.756778] systemd[1]: Starting User Login Management...774machine # [ 8.757659] (udev-worker)[338]: Network interface NamePolicy= disabled on kernel command line.775machine # [ 8.758879] systemd[1]: Finished Import lastlog data into lastlog2 database.776machine # [ 8.851362] dbus-broker-launch[445]: Looking up NSS user entry for 'systemd-timesync'...777machine # [ 8.949989] dbus-broker-launch[445]: NSS returned no entry for 'systemd-timesync'778machine # [ 8.951308] dbus-broker-launch[445]: Invalid user-name in /nix/store/hi2awyip155pp6lbgmqp52dshc41z2n6-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"779machine # [ 8.995199] systemd-logind[468]: New seat seat0.780machine # [ 9.009709] systemd[1]: Started User Login Management.781machine # [ 9.010601] systemd[1]: Started D-Bus System Message Bus.782machine # [ 9.025561] systemd[1]: Starting linger-users.service...783machine # [ 9.069737] dbus-broker-launch[445]: Ready784machine # [ 9.081574] systemd[1]: Stopped target Host and Network Name Lookups.785machine # [ 9.082641] systemd[1]: Stopping Host and Network Name Lookups...786machine # [ 9.083509] systemd[1]: Stopped target User and Group Name Lookups.787machine # [ 9.100259] systemd[1]: Stopping User and Group Name Lookups...788machine # [ 9.101311] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...789machine # [ 9.108336] systemd[1]: nscd.service: Deactivated successfully.790machine # [ 9.109346] systemd[1]: Stopped Name Service Cache Daemon (nsncd).791machine # [ 9.162078] systemd[1]: Starting Name Service Cache Daemon (nsncd)...792machine # [ 9.219712] systemd[1]: Created slice Slice /user/1001.793machine # [ 9.230494] systemd[1]: Starting User Runtime Directory /run/user/1001...794machine # [ 9.272611] nsncd[541]: Oct 21 03:00:53.810 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"795machine # [ 9.274803] systemd[1]: Started Name Service Cache Daemon (nsncd).796machine # [ 9.292853] systemd[1]: Reached target Host and Network Name Lookups.797machine # [ 9.293941] systemd[1]: Reached target User and Group Name Lookups.798machine # [ 9.294939] systemd[1]: linger-users.service: Deactivated successfully.799machine # [ 9.309494] systemd[1]: Finished linger-users.service.800machine # [ 9.351004] systemd[1]: Finished resolvconf update.801machine # [ 9.356174] systemd[1]: Finished User Runtime Directory /run/user/1001.802machine # [ 9.370915] systemd[1]: Starting DHCP Client...803machine # [ 9.404072] systemd[1]: Starting User Manager for UID 1001...804machine # [ 9.440503] systemd[1]: Condition check resulted in Virtio network device being skipped.805machine # [ 9.441752] systemd[1]: Condition check resulted in Virtio network device being skipped.806machine # [ 9.485588] systemd-logind[468]: Watching system buttons on /dev/input/event0 (gpio-keys)807machine # [ 9.564683] (systemd)[578]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0)808machine # [ 9.602150] mousedev: PS/2 mouse device common for all mice809machine # [ 9.595486] systemd-logind[468]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'.810machine # [ 9.668551] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy811machine # [ 9.939097] systemd-logind[468]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)812machine # [ 9.980335] systemd[578]: Queued start job for default target Main User Target.813machine # [ 10.019851] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy814machine # [ 10.073086] systemd[578]: Created slice User Application Slice.815machine # [ 10.074199] systemd[578]: Started Daily Cleanup of User's Temporary Directories.816machine # [ 10.129264] systemd[578]: Reached target Paths.817machine # [ 10.165266] systemd[578]: Reached target Timers.818machine # [ 10.179817] systemd[578]: Starting D-Bus User Message Bus Socket...819machine # [ 10.203543] systemd[578]: Starting Create User Files and Directories...820machine # [ 10.235352] systemd[578]: Finished Create User Files and Directories.821machine # [ 10.256165] systemd[578]: Listening on D-Bus User Message Bus Socket.822machine # [ 10.257186] systemd[578]: Reached target Sockets.823machine # [ 10.258079] systemd[578]: Reached target Basic System.824machine # [ 10.259201] systemd[1]: Started User Manager for UID 1001.825machine # [ 10.283388] systemd[578]: Starting Run user-specific NixOS activation...826machine # [ 10.288641] systemd[578]: Finished Run user-specific NixOS activation.827machine # [ 10.289658] systemd[578]: Reached target Main User Target.828machine # [ 10.290473] systemd[578]: Startup finished in 531ms.829machine # [ 10.291233] systemd[1]: Finished Firewall.830machine # [ 10.291880] systemd[1]: Reached target Preparation for Network.831machine # [ 10.319369] systemd[1]: Starting Address configuration of eth1...832machine # [ 10.329733] systemd[1]: Starting Extra networking commands....833machine # [ 10.442468] dhcpcd[594]: dhcpcd-10.3.2 starting834machine # [ 10.464199] dhcpcd[628]: dev: loaded udev835machine # [ 10.520857] 8021q: 802.1Q VLAN Support v1.8836machine # [ 10.521232] 8021q: adding VLAN 0 to HW filter on device eth1837machine # [ 10.597007] network-addresses-eth1-start[610]: adding address 192.168.1.1/24... done838machine # [ 10.645169] cfg80211: Loading compiled-in X.509 certificates for regulatory database839machine # [ 10.647226] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'840machine # [ 10.650793] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'841machine # [ 10.653705] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2842machine # [ 10.654008] cfg80211: failed to load regulatory.db843machine # [ 10.689204] network-addresses-eth1-start[610]: adding address 2001:db8:1::1/64... done844machine # [ 10.798093] systemd[1]: Finished Address configuration of eth1.845machine # [ 10.961725] dhcpcd[663]: /nix/store/48w99jvsb41hnyml943xqzrklzdb5fww-openresolv-3.17.4/sbin/.resolvconf-wrapped: line 1250: kill: (619) - Operation not permitted846machine # [ 10.963781] dhcpcd[663]: .resolvconf-wrapped: clearing stale lock pid 619847machine # [ 11.030680] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3848machine # [ 11.264564] 8021q: adding VLAN 0 to HW filter on device eth0849machine # [ 11.252773] dhcpcd[628]: eth0: waiting for carrier850machine # [ 11.253647] dhcpcd[628]: eth0: carrier acquired851machine # [ 11.340589] dhcpcd[628]: DUID 00:01:00:01:32:6a:e7:67:52:54:00:12:34:56852machine # [ 11.356550] dhcpcd[628]: eth0: IAID 00:12:34:56853machine # [ 11.357328] dhcpcd[628]: eth0: adding address fe80::5054:ff:fe12:3456854machine # [ 11.398379] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.855machine # [ 11.431269] systemd[1]: Starting Virtual Console Setup...856machine # [ 11.437632] systemd[1]: Finished Extra networking commands..857machine # [ 11.438560] systemd[1]: Reached target Network.858machine # [ 11.453478] systemd[1]: Starting Permit User Sessions...859machine # [ 11.470728] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.860machine # [ 11.471859] systemd[1]: Stopped Virtual Console Setup.861machine # [ 11.480917] systemd[1]: Starting Virtual Console Setup...862machine # [ 11.492457] systemd-logind[468]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)863machine # [ 11.542278] systemd[1]: Finished Permit User Sessions.864machine # [ 11.544385] systemd[1]: Started Getty on tty1.865machine # [ 11.547722] systemd[1]: Reached target Login Prompts.866machine # [ 11.660053] systemd-vconsole-setup[710]: Configuration of first virtual console was skipped, ignoring remaining ones.867machine # [ 11.665803] systemd[1]: Finished Virtual Console Setup.868machine # [ 13.012333] dhcpcd[628]: eth0: soliciting a DHCP lease869machine # [ 13.014469] dhcpcd[628]: eth0: offered 10.0.2.15 from 10.0.2.2870machine # [ 13.024366] dhcpcd[628]: eth0: probing address 10.0.2.15/24871machine # [ 13.489620] dhcpcd[628]: eth0: soliciting an IPv6 router872machine # [ 13.491985] dhcpcd[628]: eth0: Router Advertisement from fe80::2873machine # [ 13.493472] dhcpcd[628]: eth0: adding address fec0::5054:ff:fe12:3456/64874machine # [ 13.494991] dhcpcd[628]: eth0: adding route to fec0::/64875machine # [ 13.496270] dhcpcd[628]: eth0: adding default route via fe80::2876machine # [ 17.731736] dhcpcd[628]: eth0: leased 10.0.2.15 for 86400 seconds877machine # [ 17.734104] dhcpcd[628]: eth0: adding route to 10.0.2.0/24878machine # [ 17.735434] dhcpcd[628]: eth0: adding default route via 10.0.2.2879machine # [ 17.841979] systemd[1]: Started DHCP Client.880machine # [ 17.844310] systemd[1]: Reached target Multi-User System.881machine # [ 17.845295] systemd[1]: Startup finished in 1.034s (kernel) + 4.367s (initrd) + 12.441s (userspace) = 17.843s.882machine: (finished: waiting for unit multi-user.target, in 18.73 seconds)883machine: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/bin/switch-to-configuration test884machine # Checking switch inhibitors... done885machine # [ 18.200727] nixos[836]: switching to system configuration /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test886machine # activating the configuration...887machine # [ 18.205131] systemd[1]: Stopped target Local File Systems.888machine # [ 18.206037] systemd[1]: Stopped target Remote File Systems.889machine # setting up /etc...890machine # [ 18.515509] systemd[1]: Reload requested from client PID 836 ('.switch-to-conf') (unit backdoor.service)...891machine # [ 18.517817] systemd[1]: Reloading...892machine # [ 18.842776] systemd[1]: Reloading finished in 322 ms.893machine # reloading user units for usertest...894machine # [ 18.896400] systemd[578]: Created slice User Core Session Slice.895machine # [ 18.899654] systemd[578]: Starting D-Bus User Message Bus...896machine # [ 18.930844] dbus-broker-launch[906]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/hi2awyip155pp6lbgmqp52dshc41z2n6-system-path/share/dbus-1/services/org.freedesktop.import1.service'897machine # [ 18.934188] dbus-broker-launch[906]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/hi2awyip155pp6lbgmqp52dshc41z2n6-system-path/share/dbus-1/services/org.freedesktop.machine1.service'898machine # [ 18.937223] dbus-broker-launch[906]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/hi2awyip155pp6lbgmqp52dshc41z2n6-system-path/share/dbus-1/services/org.freedesktop.portable1.service'899machine # [ 18.940333] dbus-broker-launch[906]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/hi2awyip155pp6lbgmqp52dshc41z2n6-system-path/share/dbus-1/services/org.freedesktop.systemd1.service'900machine # [ 18.945873] dbus-broker-launch[906]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored901machine # [ 18.947832] dbus-broker-launch[906]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored902machine # [ 18.950032] systemd[578]: Started D-Bus User Message Bus.903machine # [ 18.954027] dbus-broker-launch[906]: Ready904machine # [ 18.995492] systemd[578]: Reexecution requested from client PID 905 ('switch-to-confi')...905machine # [ 18.998190] systemd[578]: Reexecuting.906machine # [ 19.056142] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy907machine # [ 19.166378] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy908machine # [ 19.173341] systemd[578]: Reload requested from client PID 905 ('switch-to-confi')...909machine # [ 19.175929] systemd[578]: Reloading...910machine # [ 19.281185] systemd[578]: Reloading finished in 104 ms.911machine # [ 19.297710] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy912machine # restarting the following user units: nixos-activation.service913machine # [ 19.307882] systemd[578]: Stopped Run user-specific NixOS activation.914machine # [ 19.310356] systemd[578]: Stopping Run user-specific NixOS activation...915machine # [ 19.312474] systemd[578]: Starting Run user-specific NixOS activation...916machine # [ 19.345478] systemd[578]: Finished Run user-specific NixOS activation.917machine # restarting sysinit-reactivation.target918machine # [ 19.356797] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....919machine # [ 19.441805] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..920machine # [ 19.443073] systemd[1]: Reached target Reactivate sysinit units.921machine # [ 19.449658] systemd[1]: Reached target Local File Systems.922machine # [ 19.452761] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore923machine # [ 19.457977] systemd[1]: Starting Create SUID/SGID Wrappers...924machine # [ 19.458971] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.925machine # [ 19.466411] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67926machine # [ 19.474374] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore927machine # [ 19.478362] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os928machine # [ 19.479797] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os929machine # [ 19.481138] systemd[1]: Reached target Remote File Systems.930machine # [ 19.481971] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os931machine # [ 19.483281] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki932machine # [ 19.642648] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.933machine # [ 19.643799] systemd[1]: Finished Create SUID/SGID Wrappers.934machine # [ 19.648349] systemd[1]: Starting linger-users.service...935machine # [ 19.686866] systemd[1]: linger-users.service: Deactivated successfully.936machine # [ 19.689677] systemd[1]: Finished linger-users.service.937machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service938machine # [ 19.947270] nixos[836]: finished switching to system configuration /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test939machine: (finished: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/bin/switch-to-configuration test, in 1.95 seconds)940machine: must succeed: rm /etc/NIXOS941machine: (finished: must succeed: rm /etc/NIXOS, in 0.03 seconds)942machine: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/miybgfqh6c31k35kpb8izvqp13m4634j-nixos-system-other-test/bin/switch-to-configuration test943machine # this should succeed (config: /nix/store/miybgfqh6c31k35kpb8izvqp13m4634j-nixos-system-other-test, action: test)944machine # Checking switch inhibitors... done945machine # [ 20.203673] nixos[983]: switching to system configuration /nix/store/miybgfqh6c31k35kpb8izvqp13m4634j-nixos-system-other-test946machine # activating the configuration...947machine # [ 20.209666] systemd[1]: Stopped target Local File Systems.948machine # [ 20.210641] systemd[1]: Stopped target Remote File Systems.949machine # removing user ‘usertest’950machine # setting up /etc...951machine # [ 20.536146] systemd[1]: Reload requested from client PID 983 ('.switch-to-conf') (unit backdoor.service)...952machine # [ 20.538160] systemd[1]: Reloading...953machine # [ 20.866160] systemd[1]: Reloading finished in 326 ms.954machine # reloading user units for usertest...955machine # [ 20.960532] systemd[578]: Reexecution requested from client PID 1055 ('switch-to-confi')...956machine # [ 20.962007] systemd[578]: Reexecuting.957machine # [ 21.023581] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy958machine # [ 21.143602] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy959machine # [ 21.150207] systemd[578]: Reload requested from client PID 1055 ('switch-to-confi')...960machine # [ 21.154179] systemd[578]: Reloading...961machine # [ 21.257279] systemd[578]: Reloading finished in 104 ms.962machine # [ 21.273687] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy963machine # restarting the following user units: nixos-activation.service964machine # [ 21.284328] systemd[578]: Stopped Run user-specific NixOS activation.965machine # [ 21.286624] systemd[578]: Stopping Run user-specific NixOS activation...966machine # [ 21.288713] systemd[578]: Starting Run user-specific NixOS activation...967machine # [ 21.320054] systemd[578]: Finished Run user-specific NixOS activation.968machine # restarting sysinit-reactivation.target969machine # [ 21.324434] systemd[1]: Stopped target Reactivate sysinit units.970machine # reloading the following units: dbus-broker.service971machine # [ 21.329391] systemd[1]: Stopping Reactivate sysinit units...972machine # [ 21.331041] systemd[1]: Reached target Reactivate sysinit units.973machine # [ 21.332194] systemd[1]: Reloading D-Bus System Message Bus...974machine # [ 21.333372] dbus-broker-launch[445]: Caught SIGHUP, trigger reload.975machine # [ 21.338067] dbus-broker-launch[445]: Looking up NSS user entry for 'systemd-timesync'...976machine # [ 21.341997] dbus-broker-launch[445]: NSS returned no entry for 'systemd-timesync'977machine # [ 21.343202] dbus-broker-launch[445]: Invalid user-name in /nix/store/3a5x2ri1v5a895rksnf2x58dawh39zhm-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"978machine # [ 21.356479] systemd[1]: Reloaded D-Bus System Message Bus.979machine # restarting the following units: network-addresses-eth1.service980machine # [ 21.363012] systemd[1]: Stopping Address configuration of eth1...981machine # [ 21.394495] network-addresses-eth1-pre-stop[1067]: deleting address 192.168.1.1/24... done982machine # [ 21.400800] network-addresses-eth1-pre-stop[1067]: deleting address 2001:db8:1::1/64... done983machine # [ 21.407467] systemd[1]: network-addresses-eth1.service: Deactivated successfully.984machine # [ 21.411826] systemd[1]: Stopped Address configuration of eth1.985machine # [ 21.414137] systemd[1]: Starting Address configuration of eth1...986machine # [ 21.452539] network-addresses-eth1-start[1072]: adding address 192.168.1.2/24... done987machine # [ 21.459173] network-addresses-eth1-start[1072]: adding address 2001:db8:1::2/64... done988machine # [ 21.468655] systemd[1]: Finished Address configuration of eth1.989machine # [ 21.474236] systemd[1]: Reached target Remote File Systems.990machine # [ 21.477505] systemd[1]: Reached target Local File Systems.991machine # [ 21.483057] systemd[1]: Starting linger-users.service...992machine # [ 21.495271] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore993machine # [ 21.505239] systemd[1]: Starting Create SUID/SGID Wrappers...994machine # [ 21.506162] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.995machine # [ 21.507667] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67996machine # [ 21.517281] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore997machine # [ 21.519037] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os998machine # [ 21.527901] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os999machine # [ 21.532880] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1000machine # [ 21.534248] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1001machine # [ 21.549636] linger-users-start[1086]: id: ‘usertest’: no such user1002machine # [ 21.551874] linger-users-start[1083]: Removing linger for missing user usertest1003machine # [ 21.562048] systemd[1]: linger-users.service: Deactivated successfully.1004machine # [ 21.565950] systemd[1]: Finished linger-users.service.1005machine # [ 21.724645] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1006machine # [ 21.726813] systemd[1]: Finished Create SUID/SGID Wrappers.1007machine # [ 21.983468] nixos[983]: finished switching to system configuration /nix/store/miybgfqh6c31k35kpb8izvqp13m4634j-nixos-system-other-test1008machine: (finished: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/miybgfqh6c31k35kpb8izvqp13m4634j-nixos-system-other-test/bin/switch-to-configuration test, in 2.01 seconds)1009subtest: services1010machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/bin/switch-to-configuration test 2>&11011machine # [ 22.197112] nixos[1150]: switching to system configuration /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test1012machine # [ 22.199749] systemd[1]: Stopped target Remote File Systems.1013machine # [ 22.202142] systemd[1]: Stopped target Local File Systems.1014machine # [ 22.483474] systemd[1]: Reload requested from client PID 1150 ('.switch-to-conf') (unit backdoor.service)...1015machine # [ 22.485675] systemd[1]: Reloading...1016machine # [ 22.800625] systemd[1]: Reloading finished in 313 ms.1017machine # [ 22.886004] systemd[578]: Reexecution requested from client PID 1219 ('switch-to-confi')...1018machine # [ 22.887612] systemd[578]: Reexecuting.1019machine # [ 22.948074] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1020machine # [ 23.060218] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1021machine # [ 23.066950] systemd[578]: Reload requested from client PID 1219 ('switch-to-confi')...1022machine # [ 23.069522] systemd[578]: Reloading...1023machine # [ 23.174111] systemd[578]: Reloading finished in 103 ms.1024machine # [ 23.188198] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1025machine # [ 23.198851] systemd[578]: Stopped Run user-specific NixOS activation.1026machine # [ 23.201366] systemd[578]: Stopping Run user-specific NixOS activation...1027machine # [ 23.203503] systemd[578]: Starting Run user-specific NixOS activation...1028machine # [ 23.235804] systemd[578]: Finished Run user-specific NixOS activation.1029machine # [ 23.240124] systemd[1]: Stopped target Reactivate sysinit units.1030machine # [ 23.245760] systemd[1]: Stopping Reactivate sysinit units...1031machine # [ 23.247281] systemd[1]: Reached target Reactivate sysinit units.1032machine # [ 23.248398] systemd[1]: Reloading D-Bus System Message Bus...1033machine # [ 23.249560] dbus-broker-launch[445]: Caught SIGHUP, trigger reload.1034machine # [ 23.252694] dbus-broker-launch[445]: Looking up NSS user entry for 'systemd-timesync'...1035machine # [ 23.254938] dbus-broker-launch[445]: NSS returned no entry for 'systemd-timesync'1036machine # [ 23.255998] dbus-broker-launch[445]: Invalid user-name in /nix/store/hi2awyip155pp6lbgmqp52dshc41z2n6-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1037machine # [ 23.280422] systemd[1]: Reloaded D-Bus System Message Bus.1038machine # [ 23.286203] systemd[1]: Stopping Address configuration of eth1...1039machine # [ 23.315844] network-addresses-eth1-pre-stop[1231]: deleting address 192.168.1.2/24... done1040machine # [ 23.323192] network-addresses-eth1-pre-stop[1231]: deleting address 2001:db8:1::2/64... done1041machine # [ 23.331024] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1042machine # [ 23.333938] systemd[1]: Stopped Address configuration of eth1.1043machine # [ 23.339715] systemd[1]: Starting Address configuration of eth1...1044machine # [ 23.385632] network-addresses-eth1-start[1236]: adding address 192.168.1.1/24... done1045machine # [ 23.393298] network-addresses-eth1-start[1236]: adding address 2001:db8:1::1/64... done1046machine # [ 23.404630] systemd[1]: Finished Address configuration of eth1.1047machine # [ 23.411387] systemd[1]: Reached target Remote File Systems.1048machine # [ 23.419599] systemd[1]: Starting linger-users.service...1049machine # [ 23.428375] systemd[1]: Reached target Local File Systems.1050machine # [ 23.432176] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1051machine # [ 23.438782] systemd[1]: Starting Create SUID/SGID Wrappers...1052machine # [ 23.439770] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1053machine # [ 23.451604] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671054machine # [ 23.459949] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1055machine # [ 23.466509] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1056machine # [ 23.467949] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1057machine # [ 23.473098] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1058machine # [ 23.474566] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1059machine # [ 23.504315] systemd[1]: linger-users.service: Deactivated successfully.1060machine # [ 23.507124] systemd[1]: Finished linger-users.service.1061machine # [ 23.673378] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1062machine # [ 23.676475] systemd[1]: Finished Create SUID/SGID Wrappers.1063machine # [ 23.932599] nixos[1150]: finished switching to system configuration /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test1064machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.95 seconds)1065machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/bin/switch-to-configuration test 2>&11066machine # [ 24.141775] nixos[1306]: switching to system configuration /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test1067machine # [ 24.144526] systemd[1]: Stopped target Remote File Systems.1068machine # [ 24.147385] systemd[1]: Stopped target Local File Systems.1069machine # [ 24.424198] systemd[1]: Reload requested from client PID 1306 ('.switch-to-conf') (unit backdoor.service)...1070machine # [ 24.426234] systemd[1]: Reloading...1071machine # [ 24.736089] systemd[1]: Reloading finished in 308 ms.1072machine # [ 24.826893] systemd[578]: Reexecution requested from client PID 1375 ('switch-to-confi')...1073machine # [ 24.831595] systemd[578]: Reexecuting.1074machine # [ 24.891572] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1075machine # [ 25.009548] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1076machine # [ 25.016335] systemd[578]: Reload requested from client PID 1375 ('switch-to-confi')...1077machine # [ 25.020100] systemd[578]: Reloading...1078machine # [ 25.126261] systemd[578]: Reloading finished in 107 ms.1079machine # [ 25.140168] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1080machine # [ 25.149648] systemd[578]: Stopped Run user-specific NixOS activation.1081machine # [ 25.152125] systemd[578]: Stopping Run user-specific NixOS activation...1082machine # [ 25.154286] systemd[578]: Starting Run user-specific NixOS activation...1083machine # [ 25.187652] systemd[578]: Finished Run user-specific NixOS activation.1084machine # [ 25.191259] systemd[1]: Stopped target Reactivate sysinit units.1085machine # [ 25.194082] systemd[1]: Stopping Reactivate sysinit units...1086machine # [ 25.194966] systemd[1]: Reached target Reactivate sysinit units.1087machine # [ 25.196740] systemd[1]: Reached target Local File Systems.1088machine # [ 25.199931] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1089machine # [ 25.208516] systemd[1]: Starting Create SUID/SGID Wrappers...1090machine # [ 25.209423] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1091machine # [ 25.210691] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671092machine # [ 25.224566] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1093machine # [ 25.226252] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1094machine # [ 25.227575] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1095machine # [ 25.229036] systemd[1]: Reached target Remote File Systems.1096machine # [ 25.229884] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1097machine # [ 25.231264] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1098machine # [ 25.384629] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1099machine # [ 25.386543] systemd[1]: Finished Create SUID/SGID Wrappers.1100machine # [ 25.391774] systemd[1]: Starting linger-users.service...1101machine # [ 25.433192] systemd[1]: linger-users.service: Deactivated successfully.1102machine # [ 25.436531] systemd[1]: Finished linger-users.service.1103machine # [ 25.690606] nixos[1306]: finished switching to system configuration /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test1104machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.76 seconds)1105machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11106machine # [ 25.911791] nixos[1446]: switching to system configuration /nix/store/la9nbpk2h8r7r7ng8avzxzrj2qml2a51-nixos-system-machine-test1107machine # [ 25.914753] systemd[1]: Stopped target Remote File Systems.1108machine # [ 25.917131] systemd[1]: Stopped target Local File Systems.1109machine # [ 26.196795] systemd[1]: Reload requested from client PID 1446 ('.switch-to-conf') (unit backdoor.service)...1110machine # [ 26.198887] systemd[1]: Reloading...1111machine # [ 26.533104] systemd[1]: Reloading finished in 332 ms.1112machine # [ 26.625814] systemd[578]: Reexecution requested from client PID 1515 ('switch-to-confi')...1113machine # [ 26.629618] systemd[578]: Reexecuting.1114machine # [ 26.687551] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1115machine # [ 26.806212] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1116machine # [ 26.813446] systemd[578]: Reload requested from client PID 1515 ('switch-to-confi')...1117machine # [ 26.817378] systemd[578]: Reloading...1118machine # [ 26.927985] systemd[578]: Reloading finished in 111 ms.1119machine # [ 26.944211] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1120machine # [ 26.954500] systemd[578]: Stopped Run user-specific NixOS activation.1121machine # [ 26.957808] systemd[578]: Stopping Run user-specific NixOS activation...1122machine # [ 26.960242] systemd[578]: Starting Run user-specific NixOS activation...1123machine # [ 26.993385] systemd[578]: Finished Run user-specific NixOS activation.1124machine # [ 26.998892] systemd[1]: Stopped target Reactivate sysinit units.1125machine # [ 27.000994] systemd[1]: Stopping Reactivate sysinit units...1126machine # [ 27.001879] systemd[1]: Reached target Reactivate sysinit units.1127machine # [ 27.006269] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1128machine # [ 27.009124] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1129machine # [ 27.012243] systemd[1]: Reached target Remote File Systems.1130machine # [ 27.017920] systemd[1]: Starting linger-users.service...1131machine # [ 27.021887] systemd[1]: Starting test.service...1132machine # [ 27.036715] systemd[1]: Reached target Local File Systems.1133machine # [ 27.037650] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1134machine # [ 27.049784] systemd[1]: Starting Create SUID/SGID Wrappers...1135machine # [ 27.050811] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1136machine # [ 27.057947] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671137machine # [ 27.066179] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1138machine # [ 27.074438] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1139machine # [ 27.082246] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1140machine # [ 27.100971] systemd[1]: Finished test.service.1141machine # [ 27.157412] systemd[1]: linger-users.service: Deactivated successfully.1142machine # [ 27.162816] systemd[1]: Finished linger-users.service.1143machine # [ 27.323874] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1144machine # [ 27.327296] systemd[1]: Finished Create SUID/SGID Wrappers.1145machine # [ 27.585153] nixos[1446]: finished switching to system configuration /nix/store/la9nbpk2h8r7r7ng8avzxzrj2qml2a51-nixos-system-machine-test1146machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.89 seconds)1147machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11148machine # [ 27.807127] nixos[1589]: switching to system configuration /nix/store/la9nbpk2h8r7r7ng8avzxzrj2qml2a51-nixos-system-machine-test1149machine # [ 27.812182] systemd[1]: Stopped target Remote File Systems.1150machine # [ 27.813073] systemd[1]: Stopped target Local File Systems.1151machine # [ 28.106877] systemd[1]: Reload requested from client PID 1589 ('.switch-to-conf') (unit backdoor.service)...1152machine # [ 28.109134] systemd[1]: Reloading...1153machine # [ 28.435900] systemd[1]: Reloading finished in 325 ms.1154machine # [ 28.526156] systemd[578]: Reexecution requested from client PID 1657 ('switch-to-confi')...1155machine # [ 28.527694] systemd[578]: Reexecuting.1156machine # [ 28.588274] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1157machine # [ 28.706635] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1158machine # [ 28.713462] systemd[578]: Reload requested from client PID 1657 ('switch-to-confi')...1159machine # [ 28.716322] systemd[578]: Reloading...1160machine # [ 28.828881] systemd[578]: Reloading finished in 111 ms.1161machine # [ 28.840180] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1162machine # [ 28.852047] systemd[578]: Stopped Run user-specific NixOS activation.1163machine # [ 28.854667] systemd[578]: Stopping Run user-specific NixOS activation...1164machine # [ 28.856988] systemd[578]: Starting Run user-specific NixOS activation...1165machine # [ 28.888863] systemd[578]: Finished Run user-specific NixOS activation.1166machine # [ 28.893000] systemd[1]: Stopped target Reactivate sysinit units.1167machine # [ 28.895314] systemd[1]: Stopping Reactivate sysinit units...1168machine # [ 28.897270] systemd[1]: Reached target Reactivate sysinit units.1169machine # [ 28.900496] systemd[1]: Reached target Remote File Systems.1170machine # [ 28.903470] systemd[1]: Starting linger-users.service...1171machine # [ 28.913063] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1172machine # [ 28.914506] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1173machine # [ 28.921418] systemd[1]: Reached target Local File Systems.1174machine # [ 28.923307] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1175machine # [ 28.931613] systemd[1]: Starting Create SUID/SGID Wrappers...1176machine # [ 28.936384] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1177machine # [ 28.937883] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671178machine # [ 28.953649] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1179machine # [ 28.955387] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1180machine # [ 28.960134] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1181machine # [ 29.001774] systemd[1]: linger-users.service: Deactivated successfully.1182machine # [ 29.004621] systemd[1]: Finished linger-users.service.1183machine # [ 29.153018] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1184machine # [ 29.156908] systemd[1]: Finished Create SUID/SGID Wrappers.1185machine # [ 29.411082] nixos[1589]: finished switching to system configuration /nix/store/la9nbpk2h8r7r7ng8avzxzrj2qml2a51-nixos-system-machine-test1186machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.83 seconds)1187machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&11188machine # [ 29.658616] nixos[1729]: switching to system configuration /nix/store/cy4gixw36idyj326pgh44f3hjqc9q0ii-nixos-system-machine-test1189machine # [ 29.661466] systemd[1]: Stopped target Local File Systems.1190machine # [ 29.664245] systemd[1]: Stopped target Remote File Systems.1191machine # [ 29.977198] systemd[1]: Reload requested from client PID 1729 ('.switch-to-conf') (unit backdoor.service)...1192machine # [ 29.979466] systemd[1]: Reloading...1193machine # [ 30.451982] systemd[1]: Reloading finished in 470 ms.1194machine # [ 30.588432] systemd[578]: Reexecution requested from client PID 1798 ('switch-to-confi')...1195machine # [ 30.591518] systemd[578]: Reexecuting.1196machine # [ 30.651775] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1197machine # [ 30.770100] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1198machine # [ 30.777064] systemd[578]: Reload requested from client PID 1798 ('switch-to-confi')...1199machine # [ 30.781009] systemd[578]: Reloading...1200machine # [ 30.891123] systemd[578]: Reloading finished in 111 ms.1201machine # [ 30.908213] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1202machine # [ 30.919299] systemd[578]: Stopped Run user-specific NixOS activation.1203machine # [ 30.921824] systemd[578]: Stopping Run user-specific NixOS activation...1204machine # [ 30.924395] systemd[578]: Starting Run user-specific NixOS activation...1205machine # [ 30.956309] systemd[578]: Finished Run user-specific NixOS activation.1206machine # [ 30.960510] systemd[1]: Stopped target Reactivate sysinit units.1207machine # [ 30.963656] systemd[1]: Stopping Reactivate sysinit units...1208machine # [ 30.966351] systemd[1]: Reached target Reactivate sysinit units.1209machine # [ 30.967393] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1210machine # [ 30.969553] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1211machine # [ 30.971476] systemd[1]: Reached target Local File Systems.1212machine # [ 30.976638] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1213machine # [ 30.982163] systemd[1]: Starting Create SUID/SGID Wrappers...1214machine # [ 30.983297] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1215machine # [ 30.989089] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671216machine # [ 30.991547] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1217machine # [ 31.001008] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1218machine # [ 31.002389] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1219machine # [ 31.003663] systemd[1]: Reached target Remote File Systems.1220machine # [ 31.168170] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1221machine # [ 31.172472] systemd[1]: Finished Create SUID/SGID Wrappers.1222machine # [ 31.175826] systemd[1]: Starting linger-users.service...1223machine # [ 31.219372] systemd[1]: linger-users.service: Deactivated successfully.1224machine # [ 31.222534] systemd[1]: Finished linger-users.service.1225machine # [ 31.478375] nixos[1729]: finished switching to system configuration /nix/store/cy4gixw36idyj326pgh44f3hjqc9q0ii-nixos-system-machine-test1226machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 2.07 seconds)1227machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11228machine # [ 31.717065] nixos[1870]: switching to system configuration /nix/store/35gjk3hx1frn0d9b60pl2wqyvrpp65sa-nixos-system-machine-test1229machine # [ 31.720458] systemd[1]: Stopped target Remote File Systems.1230machine # [ 31.724214] systemd[1]: test.service: Deactivated successfully.1231machine # [ 31.725164] systemd[1]: Stopped Test unit.1232machine # [ 31.726590] systemd[1]: Stopped target Local File Systems.1233machine # [ 32.046786] systemd[1]: Reload requested from client PID 1870 ('.switch-to-conf') (unit backdoor.service)...1234machine # [ 32.048932] systemd[1]: Reloading...1235machine # [ 32.392669] systemd[1]: Reloading finished in 342 ms.1236machine # [ 32.483541] systemd[578]: Reexecution requested from client PID 1939 ('switch-to-confi')...1237machine # [ 32.485688] systemd[578]: Reexecuting.1238machine # [ 32.535355] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1239machine # [ 32.649528] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1240machine # [ 32.656892] systemd[578]: Reload requested from client PID 1939 ('switch-to-confi')...1241machine # [ 32.660145] systemd[578]: Reloading...1242machine # [ 32.770718] systemd[578]: Reloading finished in 111 ms.1243machine # [ 32.788185] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1244machine # [ 32.801335] systemd[578]: Stopped Run user-specific NixOS activation.1245machine # [ 32.803852] systemd[578]: Stopping Run user-specific NixOS activation...1246machine # [ 32.806058] systemd[578]: Starting Run user-specific NixOS activation...1247machine # [ 32.836123] systemd[578]: Finished Run user-specific NixOS activation.1248machine # [ 32.841008] systemd[1]: Stopped target Reactivate sysinit units.1249machine # [ 32.845347] systemd[1]: Stopping Reactivate sysinit units...1250machine # [ 32.846259] systemd[1]: Reached target Reactivate sysinit units.1251machine # [ 32.847210] systemd[1]: Reached target Remote File Systems.1252machine # [ 32.854334] systemd[1]: Starting linger-users.service...1253machine # [ 32.861248] systemd[1]: Starting test.service...1254machine # [ 32.862073] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1255machine # [ 32.863493] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1256machine # [ 32.883620] systemd[1]: Reached target Local File Systems.1257machine # [ 32.892213] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1258machine # [ 32.893815] systemd[1]: Starting Create SUID/SGID Wrappers...1259machine # [ 32.894729] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1260machine # [ 32.895973] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671261machine # [ 32.905596] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1262machine # [ 32.907335] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1263machine # [ 32.919870] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1264machine # [ 32.939863] systemd[1]: Finished test.service.1265machine # [ 32.974334] systemd[1]: linger-users.service: Deactivated successfully.1266machine # [ 32.977248] systemd[1]: Finished linger-users.service.1267machine # [ 33.111004] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1268machine # [ 33.113577] systemd[1]: Finished Create SUID/SGID Wrappers.1269machine # [ 33.369994] nixos[1870]: finished switching to system configuration /nix/store/35gjk3hx1frn0d9b60pl2wqyvrpp65sa-nixos-system-machine-test1270machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.89 seconds)1271machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&11272machine # [ 33.622495] nixos[2012]: switching to system configuration /nix/store/0sg6l6yd37qb4nivbl7aqfjx0v1rx4di-nixos-system-machine-test1273machine # [ 33.625183] systemd[1]: Stopped target Remote File Systems.1274machine # [ 33.627842] systemd[1]: Stopped target Local File Systems.1275machine # [ 34.004592] systemd[1]: Reload requested from client PID 2012 ('.switch-to-conf') (unit backdoor.service)...1276machine # [ 34.006724] systemd[1]: Reloading...1277machine # [ 34.351719] systemd[1]: Reloading finished in 343 ms.1278machine # [ 34.445299] systemd[578]: Reexecution requested from client PID 2082 ('switch-to-confi')...1279machine # [ 34.449683] systemd[578]: Reexecuting.1280machine # [ 34.503600] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1281machine # [ 34.625484] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1282machine # [ 34.632502] systemd[578]: Reload requested from client PID 2082 ('switch-to-confi')...1283machine # [ 34.636085] systemd[578]: Reloading...1284machine # [ 34.752874] systemd[578]: Reloading finished in 117 ms.1285machine # [ 34.768208] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1286machine # [ 34.778437] systemd[578]: Stopped Run user-specific NixOS activation.1287machine # [ 34.781022] systemd[578]: Stopping Run user-specific NixOS activation...1288machine # [ 34.783305] systemd[578]: Starting Run user-specific NixOS activation...1289machine # [ 34.818014] systemd[578]: Finished Run user-specific NixOS activation.1290machine # [ 34.822351] systemd[1]: Stopped target Reactivate sysinit units.1291machine # [ 34.828680] systemd[1]: Stopping Reactivate sysinit units...1292machine # [ 34.829647] systemd[1]: Reached target Reactivate sysinit units.1293machine # [ 34.830657] systemd[1]: test.service: Deactivated successfully.1294machine # [ 34.831527] systemd[1]: Stopped test.service.1295machine # [ 34.832368] systemd[1]: Stopping test.service...1296machine # [ 34.834497] systemd[1]: Starting test.service...1297machine # [ 34.864443] systemd[1]: Finished test.service.1298machine # [ 34.871394] systemd[1]: Reached target Local File Systems.1299machine # [ 34.875948] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1300machine # [ 34.881280] systemd[1]: Starting Create SUID/SGID Wrappers...1301machine # [ 34.882233] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1302machine # [ 34.883530] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671303machine # [ 34.893040] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1304machine # [ 34.894850] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1305machine # [ 34.905865] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1306machine # [ 34.907381] systemd[1]: Reached target Remote File Systems.1307machine # [ 34.909563] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1308machine # [ 34.910973] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1309machine # [ 35.099973] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1310machine # [ 35.103630] systemd[1]: Finished Create SUID/SGID Wrappers.1311machine # [ 35.108945] systemd[1]: Starting linger-users.service...1312machine # [ 35.153753] systemd[1]: linger-users.service: Deactivated successfully.1313machine # [ 35.157208] systemd[1]: Finished linger-users.service.1314machine # [ 35.413620] nixos[2012]: finished switching to system configuration /nix/store/0sg6l6yd37qb4nivbl7aqfjx0v1rx4di-nixos-system-machine-test1315machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.04 seconds)1316machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&11317machine # [ 35.671842] nixos[2155]: switching to system configuration /nix/store/dpypnqp8hpmr6kk76jq5vwc0szgar608-nixos-system-machine-test1318machine # [ 35.674682] systemd[1]: Stopped target Remote File Systems.1319machine # [ 35.677530] systemd[1]: Stopped target Local File Systems.1320machine # [ 35.992620] systemd[1]: Reload requested from client PID 2155 ('.switch-to-conf') (unit backdoor.service)...1321machine # [ 35.994763] systemd[1]: Reloading...1322machine # [ 36.344740] systemd[1]: Reloading finished in 347 ms.1323machine # [ 36.444470] systemd[578]: Reexecution requested from client PID 2224 ('switch-to-confi')...1324machine # [ 36.448543] systemd[578]: Reexecuting.1325machine # [ 36.507824] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1326machine # [ 36.631266] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1327machine # [ 36.638192] systemd[578]: Reload requested from client PID 2224 ('switch-to-confi')...1328machine # [ 36.642033] systemd[578]: Reloading...1329machine # [ 36.757635] systemd[578]: Reloading finished in 116 ms.1330machine # [ 36.772193] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1331machine # [ 36.783908] systemd[578]: Stopped Run user-specific NixOS activation.1332machine # [ 36.785160] systemd[578]: Stopping Run user-specific NixOS activation...1333machine # [ 36.787536] systemd[578]: Starting Run user-specific NixOS activation...1334machine # [ 36.823172] systemd[578]: Finished Run user-specific NixOS activation.1335machine # [ 36.827457] systemd[1]: Stopped target Reactivate sysinit units.1336machine # [ 36.832266] systemd[1]: Stopping Reactivate sysinit units...1337machine # [ 36.833128] systemd[1]: Reached target Reactivate sysinit units.1338machine # [ 36.835504] systemd[1]: Reloading test.service...1339machine # [ 36.861525] systemd[1]: Reloaded test.service.1340machine # [ 36.865550] systemd[1]: Reached target Local File Systems.1341machine # [ 36.869699] systemd[1]: Reached target Remote File Systems.1342machine # [ 36.872282] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1343machine # [ 36.879233] systemd[1]: Starting Create SUID/SGID Wrappers...1344machine # [ 36.883065] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1345machine # [ 36.889463] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671346machine # [ 36.891810] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1347machine # [ 36.902192] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1348machine # [ 36.903655] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1349machine # [ 36.905146] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1350machine # [ 36.906540] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1351machine # [ 37.084296] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1352machine # [ 37.093738] systemd[1]: Finished Create SUID/SGID Wrappers.1353machine # [ 37.098148] systemd[1]: Starting linger-users.service...1354machine # [ 37.198734] systemd[1]: linger-users.service: Deactivated successfully.1355machine # [ 37.201218] systemd[1]: Finished linger-users.service.1356machine # [ 37.459265] nixos[2155]: finished switching to system configuration /nix/store/dpypnqp8hpmr6kk76jq5vwc0szgar608-nixos-system-machine-test1357machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 2.05 seconds)1358machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&11359machine # [ 37.727259] nixos[2298]: switching to system configuration /nix/store/mdgh5kkm1h4krzkf966x6qsr6n4hs0mz-nixos-system-machine-test1360machine # [ 37.730524] systemd[1]: Stopped target Remote File Systems.1361machine # [ 37.733250] systemd[1]: Stopped target Local File Systems.1362machine # [ 38.084935] systemd[1]: Reload requested from client PID 2298 ('.switch-to-conf') (unit backdoor.service)...1363machine # [ 38.087221] systemd[1]: Reloading...1364machine # [ 38.468453] systemd[1]: Reloading finished in 379 ms.1365machine # [ 38.571698] systemd[578]: Reexecution requested from client PID 2367 ('switch-to-confi')...1366machine # [ 38.574633] systemd[578]: Reexecuting.1367machine # [ 38.632154] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1368machine # [ 38.755145] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1369machine # [ 38.763173] systemd[578]: Reload requested from client PID 2367 ('switch-to-confi')...1370machine # [ 38.766948] systemd[578]: Reloading...1371machine # [ 38.884694] systemd[578]: Reloading finished in 119 ms.1372machine # [ 38.900206] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1373machine # [ 38.910453] systemd[578]: Stopped Run user-specific NixOS activation.1374machine # [ 38.913006] systemd[578]: Stopping Run user-specific NixOS activation...1375machine # [ 38.915388] systemd[578]: Starting Run user-specific NixOS activation...1376machine # [ 38.949926] systemd[578]: Finished Run user-specific NixOS activation.1377machine # [ 38.955430] systemd[1]: Stopped target Reactivate sysinit units.1378machine # [ 38.957709] systemd[1]: Stopping Reactivate sysinit units...1379machine # [ 38.958722] systemd[1]: Reached target Reactivate sysinit units.1380machine # [ 38.962947] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1381machine # [ 38.966324] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1382machine # [ 38.967844] systemd[1]: Reached target Remote File Systems.1383machine # [ 38.971235] systemd[1]: Reached target Local File Systems.1384machine # [ 38.976527] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1385machine # [ 38.984672] systemd[1]: Starting Create SUID/SGID Wrappers...1386machine # [ 38.985676] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1387machine # [ 38.986993] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671388machine # [ 38.998072] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1389machine # [ 38.999896] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1390machine # [ 39.001726] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1391machine # [ 39.212160] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1392machine # [ 39.214787] systemd[1]: Finished Create SUID/SGID Wrappers.1393machine # [ 39.222096] systemd[1]: Starting linger-users.service...1394machine # [ 39.271219] systemd[1]: linger-users.service: Deactivated successfully.1395machine # [ 39.273299] systemd[1]: Finished linger-users.service.1396machine # [ 39.531195] nixos[2298]: finished switching to system configuration /nix/store/mdgh5kkm1h4krzkf966x6qsr6n4hs0mz-nixos-system-machine-test1397machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 2.07 seconds)1398machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&11399machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.30 seconds)1400machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/bin/switch-to-configuration test 2>&11401machine # [ 40.017263] nixos[2448]: switching to system configuration /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test1402machine # [ 40.020884] systemd[1]: test.service: Deactivated successfully.1403machine # [ 40.021844] systemd[1]: Stopped test.service.1404machine # [ 40.023460] systemd[1]: Stopped target Local File Systems.1405machine # [ 40.026462] systemd[1]: Stopped target Remote File Systems.1406machine # [ 40.296950] systemd[1]: Reload requested from client PID 2448 ('.switch-to-conf') (unit backdoor.service)...1407machine # [ 40.298984] systemd[1]: Reloading...1408machine # [ 40.611388] systemd[1]: Reloading finished in 310 ms.1409machine # [ 40.732764] systemd[578]: Reexecution requested from client PID 2517 ('switch-to-confi')...1410machine # [ 40.736894] systemd[578]: Reexecuting.1411machine # [ 40.795582] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1412machine # [ 40.907135] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1413machine # [ 40.913578] systemd[578]: Reload requested from client PID 2517 ('switch-to-confi')...1414machine # [ 40.917299] systemd[578]: Reloading...1415machine # [ 41.018737] systemd[578]: Reloading finished in 102 ms.1416machine # [ 41.036201] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1417machine # [ 41.046799] systemd[578]: Stopped Run user-specific NixOS activation.1418machine # [ 41.049178] systemd[578]: Stopping Run user-specific NixOS activation...1419machine # [ 41.051223] systemd[578]: Starting Run user-specific NixOS activation...1420machine # [ 41.083125] systemd[578]: Finished Run user-specific NixOS activation.1421machine # [ 41.087282] systemd[1]: Stopped target Reactivate sysinit units.1422machine # [ 41.090698] systemd[1]: Stopping Reactivate sysinit units...1423machine # [ 41.091597] systemd[1]: Reached target Reactivate sysinit units.1424machine # [ 41.096848] systemd[1]: Reached target Local File Systems.1425machine # [ 41.097699] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1426machine # [ 41.109390] systemd[1]: Starting Create SUID/SGID Wrappers...1427machine # [ 41.110448] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1428machine # [ 41.111683] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671429machine # [ 41.120201] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1430machine # [ 41.121885] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1431machine # [ 41.123186] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1432machine # [ 41.124450] systemd[1]: Reached target Remote File Systems.1433machine # [ 41.125244] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1434machine # [ 41.126628] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1435machine # [ 41.278988] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1436machine # [ 41.280969] systemd[1]: Finished Create SUID/SGID Wrappers.1437machine # [ 41.285621] systemd[1]: Starting linger-users.service...1438machine # [ 41.323174] systemd[1]: linger-users.service: Deactivated successfully.1439machine # [ 41.326317] systemd[1]: Finished linger-users.service.1440machine # [ 41.580123] nixos[2448]: finished switching to system configuration /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test1441machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.75 seconds)1442machine: must succeed: /nix/store/wqjac3hbzivgxiha9g7y012nzwjxiwn7-separate-activation-script/bin/switch-to-configuration test 2>&11443machine # [ 41.784135] nixos[2589]: switching to system configuration /nix/store/vydri52gs9s2zkllb907fjz2127x4i58-nixos-system-machine-test1444machine # [ 41.787923] systemd[1]: Stopped target Local File Systems.1445machine # [ 41.790172] systemd[1]: Stopped target Remote File Systems.1446machine # [ 42.069958] systemd[1]: Reload requested from client PID 2589 ('.switch-to-conf') (unit backdoor.service)...1447machine # [ 42.072297] systemd[1]: Reloading...1448machine # [ 42.376760] systemd[1]: Reloading finished in 302 ms.1449machine # [ 42.467621] systemd[578]: Stopped Run user-specific NixOS activation.1450machine # [ 42.471802] systemd[578]: Reexecution requested from client PID 2658 ('switch-to-confi')...1451machine # [ 42.474197] systemd[578]: Reexecuting.1452machine # [ 42.515287] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1453machine # [ 42.621449] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1454machine # [ 42.628535] systemd[578]: Reload requested from client PID 2658 ('switch-to-confi')...1455machine # [ 42.629865] systemd[578]: Reloading...1456machine # [ 42.732881] systemd[578]: Reloading finished in 101 ms.1457machine # [ 42.748181] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1458machine # [ 42.759770] systemd[1]: Stopped target Reactivate sysinit units.1459machine # [ 42.761527] systemd[1]: Stopping Reactivate sysinit units...1460machine # [ 42.762579] systemd[1]: Reached target Reactivate sysinit units.1461machine # [ 42.765776] systemd[1]: Reached target Remote File Systems.1462machine # [ 42.774693] systemd[1]: Starting linger-users.service...1463machine # [ 42.779959] systemd[1]: Starting test.service...1464machine # [ 42.781169] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1465machine # [ 42.782696] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1466machine # [ 42.800290] systemd[1]: Reached target Local File Systems.1467machine # [ 42.801249] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1468machine # [ 42.807050] systemd[1]: Starting Create SUID/SGID Wrappers...1469machine # [ 42.807992] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1470machine # [ 42.811045] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671471machine # [ 42.824527] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1472machine # [ 42.831297] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1473machine # [ 42.838471] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1474machine # [ 42.849698] systemd[1]: Finished test.service.1475machine # [ 42.882548] systemd[1]: linger-users.service: Deactivated successfully.1476machine # [ 42.885539] systemd[1]: Finished linger-users.service.1477machine # [ 43.026757] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1478machine # [ 43.029822] systemd[1]: Finished Create SUID/SGID Wrappers.1479machine # [ 43.285431] nixos[2589]: finished switching to system configuration /nix/store/vydri52gs9s2zkllb907fjz2127x4i58-nixos-system-machine-test1480machine: (finished: must succeed: /nix/store/wqjac3hbzivgxiha9g7y012nzwjxiwn7-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.70 seconds)1481machine: must succeed: ! test -e /run/current-system/activate1482machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.02 seconds)1483machine: must succeed: ! test -e /run/current-system/dry-activate1484machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.02 seconds)1485machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration1486machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.02 seconds)1487machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&11488machine # [ 43.563182] nixos[2737]: switching to system configuration /nix/store/sygpxb1yg2k9j4q015d01daa4640w4sa-nixos-system-machine-test1489machine # [ 43.566863] systemd[1]: test.service: Deactivated successfully.1490machine # [ 43.567823] systemd[1]: Stopped test.service.1491machine # [ 43.569578] systemd[1]: Stopped target Local File Systems.1492machine # [ 43.572091] systemd[1]: Stopped target Remote File Systems.1493machine # [ 43.923862] systemd[1]: Reload requested from client PID 2737 ('.switch-to-conf') (unit backdoor.service)...1494machine # [ 43.926224] systemd[1]: Reloading...1495machine # [ 44.238278] systemd[1]: Reloading finished in 311 ms.1496machine # [ 44.323641] systemd[578]: Reexecution requested from client PID 2807 ('switch-to-confi')...1497machine # [ 44.325989] systemd[578]: Reexecuting.1498machine # [ 44.387749] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1499machine # [ 44.502579] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1500machine # [ 44.509284] systemd[578]: Reload requested from client PID 2807 ('switch-to-confi')...1501machine # [ 44.513176] systemd[578]: Reloading...1502machine # [ 44.618808] systemd[578]: Reloading finished in 106 ms.1503machine # [ 44.636191] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1504machine # [ 44.647139] systemd[578]: Starting Run user-specific NixOS activation...1505machine # [ 44.680477] systemd[578]: Finished Run user-specific NixOS activation.1506machine # [ 44.685611] systemd[578]: Stopped Run user-specific NixOS activation.1507machine # [ 44.686831] systemd[578]: Stopping Run user-specific NixOS activation...1508machine # [ 44.692193] systemd[578]: Starting Run user-specific NixOS activation...1509machine # [ 44.699789] systemd[1]: Stopped target Reactivate sysinit units.1510machine # [ 44.701329] systemd[1]: Stopping Reactivate sysinit units...1511machine # [ 44.702183] systemd[1]: Reached target Reactivate sysinit units.1512machine # [ 44.717594] systemd[1]: Started test.service.1513machine # [ 44.731151] systemd[1]: Reached target Remote File Systems.1514machine # [ 44.739099] systemd[1]: Reached target Local File Systems.1515machine # [ 44.751263] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1516machine # [ 44.757156] systemd[1]: Starting Create SUID/SGID Wrappers...1517machine # [ 44.758645] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1518machine # [ 44.759946] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671519machine # [ 44.773091] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1520machine # [ 44.774944] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1521machine # [ 44.783778] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1522machine # [ 44.785912] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1523machine # [ 44.787263] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1524machine # [ 44.791815] systemd[578]: Finished Run user-specific NixOS activation.1525machine # [ 44.797908] systemd[1]: test.service: Deactivated successfully.1526machine # [ 44.953947] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1527machine # [ 44.957040] systemd[1]: Finished Create SUID/SGID Wrappers.1528machine # [ 44.961742] systemd[1]: Starting linger-users.service...1529machine # [ 45.001408] systemd[1]: linger-users.service: Deactivated successfully.1530machine # [ 45.004963] systemd[1]: Finished linger-users.service.1531machine # [ 45.259234] nixos[2737]: finished switching to system configuration /nix/store/sygpxb1yg2k9j4q015d01daa4640w4sa-nixos-system-machine-test1532machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.91 seconds)1533machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&11534machine # [ 45.491234] nixos[2883]: switching to system configuration /nix/store/klzgmqiifwz1qipq9d3ww8ivj2wqp431-nixos-system-machine-test1535machine # [ 45.493879] systemd[1]: Stopped target Local File Systems.1536machine # [ 45.496310] systemd[1]: Stopped target Remote File Systems.1537machine # [ 45.784659] systemd[1]: Reload requested from client PID 2883 ('.switch-to-conf') (unit backdoor.service)...1538machine # [ 45.786324] systemd[1]: Reloading...1539machine # [ 46.111015] systemd[1]: Reloading finished in 323 ms.1540machine # [ 46.199658] systemd[578]: Reexecution requested from client PID 2952 ('switch-to-confi')...1541machine # [ 46.201774] systemd[578]: Reexecuting.1542machine # [ 46.259824] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1543machine # [ 46.373439] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1544machine # [ 46.380170] systemd[578]: Reload requested from client PID 2952 ('switch-to-confi')...1545machine # [ 46.382854] systemd[578]: Reloading...1546machine # [ 46.487405] systemd[578]: Reloading finished in 103 ms.1547machine # [ 46.504184] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1548machine # [ 46.513338] systemd[578]: Stopped Run user-specific NixOS activation.1549machine # [ 46.515638] systemd[578]: Stopping Run user-specific NixOS activation...1550machine # [ 46.517860] systemd[578]: Starting Run user-specific NixOS activation...1551machine # [ 46.547255] systemd[578]: Finished Run user-specific NixOS activation.1552machine # [ 46.551255] systemd[1]: Stopped target Reactivate sysinit units.1553machine # [ 46.553841] systemd[1]: Stopping Reactivate sysinit units...1554machine # [ 46.554730] systemd[1]: Reached target Reactivate sysinit units.1555machine # [ 46.556349] systemd[1]: Reached target Local File Systems.1556machine # [ 46.561870] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1557machine # [ 46.567241] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1558machine # [ 46.568780] systemd[1]: Reached target Remote File Systems.1559machine # [ 46.571873] systemd[1]: Starting escaped\x2ddash.service...1560machine # [ 46.575605] systemd[1]: Starting linger-users.service...1561machine # [ 46.588231] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1562machine # [ 46.595475] systemd[1]: Starting Create SUID/SGID Wrappers...1563machine # [ 46.600675] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1564machine # [ 46.602009] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671565machine # [ 46.604460] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1566machine # [ 46.606061] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1567machine # [ 46.607408] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1568machine # [ 46.641336] systemd[1]: Finished escaped\x2ddash.service.1569machine # [ 46.677142] systemd[1]: linger-users.service: Deactivated successfully.1570machine # [ 46.681301] systemd[1]: Finished linger-users.service.1571machine # [ 46.801908] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1572machine # [ 46.805570] systemd[1]: Finished Create SUID/SGID Wrappers.1573machine # [ 47.060485] nixos[2883]: finished switching to system configuration /nix/store/klzgmqiifwz1qipq9d3ww8ivj2wqp431-nixos-system-machine-test1574machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 1.80 seconds)1575machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&11576machine # [ 47.283274] nixos[3025]: switching to system configuration /nix/store/xgxvjl405bqf28wl62h4cwy1zhghhs5p-nixos-system-machine-test1577machine # [ 47.285904] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1578machine # [ 47.290167] systemd[1]: Stopped escaped\x2ddash.service.1579machine # [ 47.292539] systemd[1]: Stopped target Local File Systems.1580machine # [ 47.293812] systemd[1]: Stopped target Remote File Systems.1581machine # [ 47.570837] systemd[1]: Reload requested from client PID 3025 ('.switch-to-conf') (unit backdoor.service)...1582machine # [ 47.572980] systemd[1]: Reloading...1583machine # [ 47.935774] systemd[1]: Reloading finished in 360 ms.1584machine # [ 48.033155] systemd[578]: Reexecution requested from client PID 3094 ('switch-to-confi')...1585machine # [ 48.038125] systemd[578]: Reexecuting.1586machine # [ 48.091644] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1587machine # [ 48.207938] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1588machine # [ 48.214750] systemd[578]: Reload requested from client PID 3094 ('switch-to-confi')...1589machine # [ 48.217282] systemd[578]: Reloading...1590machine # [ 48.319554] systemd[578]: Reloading finished in 101 ms.1591machine # [ 48.336175] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1592machine # [ 48.346511] systemd[578]: Stopped Run user-specific NixOS activation.1593machine # [ 48.348842] systemd[578]: Stopping Run user-specific NixOS activation...1594machine # [ 48.351020] systemd[578]: Starting Run user-specific NixOS activation...1595machine # [ 48.382482] systemd[578]: Finished Run user-specific NixOS activation.1596machine # [ 48.386356] systemd[1]: Stopped target Reactivate sysinit units.1597machine # [ 48.388338] systemd[1]: Stopping Reactivate sysinit units...1598machine # [ 48.389232] systemd[1]: Reached target Reactivate sysinit units.1599machine # [ 48.394523] systemd[1]: Reached target Remote File Systems.1600machine # [ 48.397519] systemd[1]: Reached target Local File Systems.1601machine # [ 48.399925] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1602machine # [ 48.408153] systemd[1]: Starting Create SUID/SGID Wrappers...1603machine # [ 48.409067] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1604machine # [ 48.410416] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671605machine # [ 48.422641] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1606machine # [ 48.424450] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1607machine # [ 48.425735] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1608machine # [ 48.426964] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1609machine # [ 48.428417] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1610machine # [ 48.583565] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1611machine # [ 48.588687] systemd[1]: Finished Create SUID/SGID Wrappers.1612machine # [ 48.591997] systemd[1]: Starting escaped\x2ddash.service...1613machine # [ 48.595263] systemd[1]: Starting linger-users.service...1614machine # [ 48.636285] systemd[1]: Finished escaped\x2ddash.service.1615machine # [ 48.654880] systemd[1]: linger-users.service: Deactivated successfully.1616machine # [ 48.657399] systemd[1]: Finished linger-users.service.1617machine # [ 48.913883] nixos[3025]: finished switching to system configuration /nix/store/xgxvjl405bqf28wl62h4cwy1zhghhs5p-nixos-system-machine-test1618machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 1.85 seconds)1619machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&11620machine # [ 49.138351] nixos[3167]: switching to system configuration /nix/store/6szzkf0lhfd4nnmj9jlb91m1awv05krl-nixos-system-machine-test1621machine # [ 49.141187] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1622machine # [ 49.145103] systemd[1]: Stopped escaped\x2ddash.service.1623machine # [ 49.146795] systemd[1]: Stopped target Remote File Systems.1624machine # [ 49.147621] systemd[1]: Stopped target Local File Systems.1625machine # [ 49.440625] systemd[1]: Reload requested from client PID 3167 ('.switch-to-conf') (unit backdoor.service)...1626machine # [ 49.442319] systemd[1]: Reloading...1627machine # [ 49.767510] systemd[1]: Reloading finished in 323 ms.1628machine # [ 49.862916] systemd[578]: Reexecution requested from client PID 3236 ('switch-to-confi')...1629machine # [ 49.865189] systemd[578]: Reexecuting.1630machine # [ 49.928394] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1631machine # [ 50.038365] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1632machine # [ 50.045047] systemd[578]: Reload requested from client PID 3236 ('switch-to-confi')...1633machine # [ 50.047717] systemd[578]: Reloading...1634machine # [ 50.157111] systemd[578]: Reloading finished in 108 ms.1635machine # [ 50.172183] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1636machine # [ 50.182830] systemd[578]: Stopped Run user-specific NixOS activation.1637machine # [ 50.185467] systemd[578]: Stopping Run user-specific NixOS activation...1638machine # [ 50.187807] systemd[578]: Starting Run user-specific NixOS activation...1639machine # [ 50.221112] systemd[578]: Finished Run user-specific NixOS activation.1640machine # [ 50.225681] systemd[1]: Stopped target Reactivate sysinit units.1641machine # [ 50.229471] systemd[1]: Stopping Reactivate sysinit units...1642machine # [ 50.230511] systemd[1]: Reached target Reactivate sysinit units.1643machine # [ 50.235281] systemd[1]: Reached target Remote File Systems.1644machine # [ 50.239384] systemd[1]: Starting -.service...1645machine # [ 50.242477] systemd[1]: Starting linger-users.service...1646machine # [ 50.257946] systemd[1]: Reached target Local File Systems.1647machine # [ 50.268663] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1648machine # [ 50.270511] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1649machine # [ 50.271946] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1650machine # [ 50.289631] systemd[1]: Starting Create SUID/SGID Wrappers...1651machine # [ 50.290609] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1652machine # [ 50.291874] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671653machine # [ 50.307881] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1654machine # [ 50.317854] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1655machine # [ 50.324569] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1656machine # [ 50.325930] systemd[1]: Finished -.service.1657machine # [ 50.356995] systemd[1]: linger-users.service: Deactivated successfully.1658machine # [ 50.359206] systemd[1]: Finished linger-users.service.1659machine # [ 50.499613] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1660machine # [ 50.502982] systemd[1]: Finished Create SUID/SGID Wrappers.1661machine # [ 50.760408] nixos[3167]: finished switching to system configuration /nix/store/6szzkf0lhfd4nnmj9jlb91m1awv05krl-nixos-system-machine-test1662machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.85 seconds)1663machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&11664machine # [ 51.004507] nixos[3309]: switching to system configuration /nix/store/i9hv61mqb26w5j8gbhrl2jd7kljij04c-nixos-system-machine-test1665machine # [ 51.008470] systemd[1]: Stopped target Local File Systems.1666machine # [ 51.009868] systemd[1]: Stopped target Remote File Systems.1667machine # [ 51.325221] systemd[1]: Reload requested from client PID 3309 ('.switch-to-conf') (unit backdoor.service)...1668machine # [ 51.327313] systemd[1]: Reloading...1669machine # [ 51.650894] systemd[1]: Reloading finished in 322 ms.1670machine # [ 51.740419] systemd[578]: Reexecution requested from client PID 3378 ('switch-to-confi')...1671machine # [ 51.744329] systemd[578]: Reexecuting.1672machine # [ 51.803818] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1673machine # [ 51.921431] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1674machine # [ 51.928333] systemd[578]: Reload requested from client PID 3378 ('switch-to-confi')...1675machine # [ 51.931232] systemd[578]: Reloading...1676machine # [ 52.040844] systemd[578]: Reloading finished in 108 ms.1677machine # [ 52.056442] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1678machine # [ 52.066827] systemd[578]: Stopped Run user-specific NixOS activation.1679machine # [ 52.069602] systemd[578]: Stopping Run user-specific NixOS activation...1680machine # [ 52.071977] systemd[578]: Starting Run user-specific NixOS activation...1681machine # [ 52.108213] systemd[578]: Finished Run user-specific NixOS activation.1682machine # [ 52.113379] systemd[1]: Stopped target Reactivate sysinit units.1683machine # [ 52.118833] systemd[1]: Stopping Reactivate sysinit units...1684machine # [ 52.119824] systemd[1]: Reached target Reactivate sysinit units.1685machine # [ 52.122575] systemd[1]: Reloading -.service...1686machine # [ 52.153364] systemd[1]: Reloaded -.service.1687machine # [ 52.156731] systemd[1]: Reached target Local File Systems.1688machine # [ 52.161419] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1689machine # [ 52.168642] systemd[1]: Starting Create SUID/SGID Wrappers...1690machine # [ 52.169529] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1691machine # [ 52.170783] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671692machine # [ 52.180912] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1693machine # [ 52.182732] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1694machine # [ 52.187492] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1695machine # [ 52.189850] systemd[1]: Reached target Remote File Systems.1696machine # [ 52.190807] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1697machine # [ 52.192206] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1698machine # [ 52.348315] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1699machine # [ 52.352447] systemd[1]: Finished Create SUID/SGID Wrappers.1700machine # [ 52.355873] systemd[1]: Starting linger-users.service...1701machine # [ 52.397537] systemd[1]: linger-users.service: Deactivated successfully.1702machine # [ 52.400965] systemd[1]: Finished linger-users.service.1703machine # [ 52.655179] nixos[3309]: finished switching to system configuration /nix/store/i9hv61mqb26w5j8gbhrl2jd7kljij04c-nixos-system-machine-test1704machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.90 seconds)1705machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&11706machine # [ 52.895290] nixos[3451]: switching to system configuration /nix/store/3silaj2x7s0ahws9nig1957sh7ylxi0c-nixos-system-machine-test1707machine # [ 52.899605] systemd[1]: -.service: Deactivated successfully.1708machine # [ 52.902583] systemd[1]: Stopped -.service.1709machine # [ 52.903303] systemd[1]: Stopped target Local File Systems.1710machine # [ 52.904709] systemd[1]: Stopped target Remote File Systems.1711machine # [ 53.201994] systemd[1]: Reload requested from client PID 3451 ('.switch-to-conf') (unit backdoor.service)...1712machine # [ 53.203671] systemd[1]: Reloading...1713machine # [ 53.539134] systemd[1]: Reloading finished in 333 ms.1714machine # [ 53.625851] systemd[578]: Reexecution requested from client PID 3520 ('switch-to-confi')...1715machine # [ 53.630377] systemd[578]: Reexecuting.1716machine # [ 53.687768] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1717machine # [ 53.802747] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1718machine # [ 53.810603] systemd[578]: Reload requested from client PID 3520 ('switch-to-confi')...1719machine # [ 53.814729] systemd[578]: Reloading...1720machine # [ 53.923580] systemd[578]: Reloading finished in 110 ms.1721machine # [ 53.940203] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1722machine # [ 53.950585] systemd[578]: Stopped Run user-specific NixOS activation.1723machine # [ 53.953136] systemd[578]: Stopping Run user-specific NixOS activation...1724machine # [ 53.955406] systemd[578]: Starting Run user-specific NixOS activation...1725machine # [ 53.988273] systemd[578]: Finished Run user-specific NixOS activation.1726machine # [ 53.993023] systemd[1]: Stopped target Reactivate sysinit units.1727machine # [ 53.994054] systemd[1]: Stopping Reactivate sysinit units...1728machine # [ 53.994917] systemd[1]: Reached target Reactivate sysinit units.1729machine # [ 53.999187] systemd[1]: Reached target Local File Systems.1730machine # [ 54.002770] systemd[1]: Reached target Remote File Systems.1731machine # [ 54.008276] systemd[1]: Starting linger-users.service...1732machine # [ 54.012412] systemd[1]: Starting required-service.service...1733machine # [ 54.020462] systemd[1]: Starting test-service.service...1734machine # [ 54.035946] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1735machine # [ 54.045382] systemd[1]: Starting Create SUID/SGID Wrappers...1736machine # [ 54.046444] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1737machine # [ 54.047765] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671738machine # [ 54.064893] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1739machine # [ 54.066680] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1740machine # [ 54.083322] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1741machine # [ 54.092145] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1742machine # [ 54.105251] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1743machine # [ 54.115560] systemd[1]: Finished required-service.service.1744machine # [ 54.119056] systemd[1]: Finished test-service.service.1745machine # [ 54.152844] systemd[1]: linger-users.service: Deactivated successfully.1746machine # [ 54.156817] systemd[1]: Finished linger-users.service.1747machine # [ 54.287765] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1748machine # [ 54.291658] systemd[1]: Finished Create SUID/SGID Wrappers.1749machine # [ 54.546842] nixos[3451]: finished switching to system configuration /nix/store/3silaj2x7s0ahws9nig1957sh7ylxi0c-nixos-system-machine-test1750machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.89 seconds)1751machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&11752machine # [ 54.777112] nixos[3595]: switching to system configuration /nix/store/3zfisrfsak4415hn19znbvsg6p6ndkv6-nixos-system-machine-test1753machine # [ 54.781440] systemd[1]: required-service.service: Deactivated successfully.1754machine # [ 54.782631] systemd[1]: Stopped required-service.service.1755machine # [ 54.783453] systemd[1]: test-service.service: Deactivated successfully.1756machine # [ 54.785569] systemd[1]: Stopped test-service.service.1757machine # [ 54.786387] systemd[1]: Stopped target Local File Systems.1758machine # [ 54.787656] systemd[1]: Stopped target Remote File Systems.1759machine # [ 55.068726] systemd[1]: Reload requested from client PID 3595 ('.switch-to-conf') (unit backdoor.service)...1760machine # [ 55.070809] systemd[1]: Reloading...1761machine # [ 55.383400] systemd[1]: Reloading finished in 311 ms.1762machine # [ 55.466992] systemd[578]: Reexecution requested from client PID 3664 ('switch-to-confi')...1763machine # [ 55.470874] systemd[578]: Reexecuting.1764machine # [ 55.527411] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1765machine # [ 55.638352] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1766machine # [ 55.645123] systemd[578]: Reload requested from client PID 3664 ('switch-to-confi')...1767machine # [ 55.648649] systemd[578]: Reloading...1768machine # [ 55.750380] systemd[578]: Reloading finished in 102 ms.1769machine # [ 55.764166] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1770machine # [ 55.775431] systemd[578]: Stopped Run user-specific NixOS activation.1771machine # [ 55.777712] systemd[578]: Stopping Run user-specific NixOS activation...1772machine # [ 55.779803] systemd[578]: Starting Run user-specific NixOS activation...1773machine # [ 55.810568] systemd[578]: Finished Run user-specific NixOS activation.1774machine # [ 55.814950] systemd[1]: Stopped target Reactivate sysinit units.1775machine # [ 55.815888] systemd[1]: Stopping Reactivate sysinit units...1776machine # [ 55.817262] systemd[1]: Reached target Reactivate sysinit units.1777machine # [ 55.822738] systemd[1]: Reached target Remote File Systems.1778machine # [ 55.827952] systemd[1]: Starting linger-users.service...1779machine # [ 55.831600] systemd[1]: Starting required-service.service...1780machine # [ 55.840507] systemd[1]: Starting test-service.service...1781machine # [ 55.841307] systemd[1]: Reached target Local File Systems.1782machine # [ 55.842119] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1783machine # [ 55.862105] systemd[1]: Starting Create SUID/SGID Wrappers...1784machine # [ 55.863119] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1785machine # [ 55.871334] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671786machine # [ 55.878294] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1787machine # [ 55.879977] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1788machine # [ 55.895837] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1789machine # [ 55.905914] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1790machine # [ 55.916542] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1791machine # [ 55.926143] systemd[1]: Finished test-service.service.1792machine # [ 55.927045] systemd[1]: Finished required-service.service.1793machine # [ 55.961912] systemd[1]: linger-users.service: Deactivated successfully.1794machine # [ 55.965231] systemd[1]: Finished linger-users.service.1795machine # [ 56.087492] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1796machine # [ 56.090690] systemd[1]: Finished Create SUID/SGID Wrappers.1797machine # [ 56.346552] nixos[3595]: finished switching to system configuration /nix/store/3zfisrfsak4415hn19znbvsg6p6ndkv6-nixos-system-machine-test1798machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.80 seconds)1799machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&11800machine # [ 56.568528] nixos[3739]: switching to system configuration /nix/store/yr31arszxwrxwbv5fidblw32idd938pk-nixos-system-machine-test1801machine # [ 56.571002] systemd[1]: Stopped target Remote File Systems.1802machine # [ 56.574737] systemd[1]: Stopped target Local File Systems.1803machine # [ 56.575595] systemd[1]: required-service.service: Deactivated successfully.1804machine # [ 56.576633] systemd[1]: Stopped required-service.service.1805machine # [ 56.577413] systemd[1]: test-service.service: Deactivated successfully.1806machine # [ 56.578335] systemd[1]: Stopped test-service.service.1807machine # [ 56.849995] systemd[1]: Reload requested from client PID 3739 ('.switch-to-conf') (unit backdoor.service)...1808machine # [ 56.851975] systemd[1]: Reloading...1809machine # [ 57.156236] systemd[1]: Reloading finished in 302 ms.1810machine # [ 57.240466] systemd[578]: Reexecution requested from client PID 3808 ('switch-to-confi')...1811machine # [ 57.244591] systemd[578]: Reexecuting.1812machine # [ 57.303259] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1813machine # [ 57.415216] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1814machine # [ 57.422312] systemd[578]: Reload requested from client PID 3808 ('switch-to-confi')...1815machine # [ 57.425776] systemd[578]: Reloading...1816machine # [ 57.526803] systemd[578]: Reloading finished in 101 ms.1817machine # [ 57.540311] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1818machine # [ 57.553542] systemd[578]: Stopped Run user-specific NixOS activation.1819machine # [ 57.554941] systemd[578]: Stopping Run user-specific NixOS activation...1820machine # [ 57.557183] systemd[578]: Starting Run user-specific NixOS activation...1821machine # [ 57.593347] systemd[578]: Finished Run user-specific NixOS activation.1822machine # [ 57.597929] systemd[1]: Stopped target Reactivate sysinit units.1823machine # [ 57.600684] systemd[1]: Stopping Reactivate sysinit units...1824machine # [ 57.601642] systemd[1]: Reached target Reactivate sysinit units.1825machine # [ 57.605795] systemd[1]: Reached target Local File Systems.1826machine # [ 57.606807] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1827machine # [ 57.614852] systemd[1]: Starting Create SUID/SGID Wrappers...1828machine # [ 57.615776] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1829machine # [ 57.625233] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671830machine # [ 57.627531] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1831machine # [ 57.636115] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1832machine # [ 57.637477] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1833machine # [ 57.638756] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1834machine # [ 57.640997] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1835machine # [ 57.643422] systemd[1]: Reached target Remote File Systems.1836machine # [ 57.789186] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1837machine # [ 57.791001] systemd[1]: Finished Create SUID/SGID Wrappers.1838machine # [ 57.795697] systemd[1]: Starting linger-users.service...1839machine # [ 57.800515] systemd[1]: Starting required-service.service...1840machine # [ 57.808421] systemd[1]: Starting test-service.service...1841machine # [ 57.853466] systemd[1]: Finished required-service.service.1842machine # [ 57.857609] systemd[1]: Finished test-service.service.1843machine # [ 57.874526] systemd[1]: linger-users.service: Deactivated successfully.1844machine # [ 57.877623] systemd[1]: Finished linger-users.service.1845machine # [ 58.131713] nixos[3739]: finished switching to system configuration /nix/store/yr31arszxwrxwbv5fidblw32idd938pk-nixos-system-machine-test1846machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.79 seconds)1847machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&11848machine # [ 58.355729] nixos[3883]: switching to system configuration /nix/store/pji40368w1vapgjv0m39w4611sw1wzy4-nixos-system-machine-test1849machine # [ 58.359380] systemd[1]: required-service.service: Deactivated successfully.1850machine # [ 58.362050] systemd[1]: Stopped required-service.service.1851machine # [ 58.362886] systemd[1]: test-service.service: Deactivated successfully.1852machine # [ 58.363808] systemd[1]: Stopped test-service.service.1853machine # [ 58.366597] systemd[1]: Stopped target Local File Systems.1854machine # [ 58.367429] systemd[1]: Stopped target Remote File Systems.1855machine # [ 58.647932] systemd[1]: Reload requested from client PID 3883 ('.switch-to-conf') (unit backdoor.service)...1856machine # [ 58.650077] systemd[1]: Reloading...1857machine # [ 58.965287] systemd[1]: Reloading finished in 313 ms.1858machine # [ 59.047785] systemd[578]: Reexecution requested from client PID 3952 ('switch-to-confi')...1859machine # [ 59.052179] systemd[578]: Reexecuting.1860machine # [ 59.107136] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1861machine # [ 59.210650] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1862machine # [ 59.217365] systemd[578]: Reload requested from client PID 3952 ('switch-to-confi')...1863machine # [ 59.220172] systemd[578]: Reloading...1864machine # [ 59.322889] systemd[578]: Reloading finished in 102 ms.1865machine # [ 59.341583] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1866machine # [ 59.349366] systemd[578]: Stopped Run user-specific NixOS activation.1867machine # [ 59.351777] systemd[578]: Stopping Run user-specific NixOS activation...1868machine # [ 59.354019] systemd[578]: Starting Run user-specific NixOS activation...1869machine # [ 59.386607] systemd[578]: Finished Run user-specific NixOS activation.1870machine # [ 59.390387] systemd[1]: Stopped target Reactivate sysinit units.1871machine # [ 59.392511] systemd[1]: Stopping Reactivate sysinit units...1872machine # [ 59.393399] systemd[1]: Reached target Reactivate sysinit units.1873machine # [ 59.395451] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1874machine # [ 59.397908] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1875machine # [ 59.399878] systemd[1]: Reached target Local File Systems.1876machine # [ 59.404988] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1877machine # [ 59.409803] systemd[1]: Starting Create SUID/SGID Wrappers...1878machine # [ 59.410719] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1879machine # [ 59.419998] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671880machine # [ 59.422399] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1881machine # [ 59.423989] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1882machine # [ 59.425923] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1883machine # [ 59.428417] systemd[1]: Reached target Remote File Systems.1884machine # [ 59.435261] systemd[1]: Created slice Slice /system/instantiated.1885machine # [ 59.587768] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1886machine # [ 59.589792] systemd[1]: Finished Create SUID/SGID Wrappers.1887machine # [ 59.596253] systemd[1]: Starting instantiated@one.service...1888machine # [ 59.600500] systemd[1]: Starting instantiated@two.service...1889machine # [ 59.604920] systemd[1]: Starting linger-users.service...1890machine # [ 59.655128] systemd[1]: Finished instantiated@one.service.1891machine # [ 59.658215] systemd[1]: Finished instantiated@two.service.1892machine # [ 59.675117] systemd[1]: linger-users.service: Deactivated successfully.1893machine # [ 59.677785] systemd[1]: Finished linger-users.service.1894machine # [ 59.934810] nixos[3883]: finished switching to system configuration /nix/store/pji40368w1vapgjv0m39w4611sw1wzy4-nixos-system-machine-test1895machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.80 seconds)1896machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&11897machine # [ 60.175337] nixos[4027]: switching to system configuration /nix/store/qr9zi1c9cpvbxnzkmn8w6285ic0yi079-nixos-system-machine-test1898machine # [ 60.182483] systemd[1]: Stopped target Local File Systems.1899machine # [ 60.183364] systemd[1]: Stopped target Remote File Systems.1900machine # [ 60.185362] systemd[1]: instantiated@one.service: Deactivated successfully.1901machine # [ 60.187987] systemd[1]: Stopped instantiated@one.service.1902machine # [ 60.188852] systemd[1]: instantiated@two.service: Deactivated successfully.1903machine # [ 60.189865] systemd[1]: Stopped instantiated@two.service.1904machine # [ 60.470257] systemd[1]: Reload requested from client PID 4027 ('.switch-to-conf') (unit backdoor.service)...1905machine # [ 60.472352] systemd[1]: Reloading...1906machine # [ 60.786796] systemd[1]: Reloading finished in 313 ms.1907machine # [ 60.875368] systemd[578]: Reexecution requested from client PID 4096 ('switch-to-confi')...1908machine # [ 60.877633] systemd[578]: Reexecuting.1909machine # [ 60.927309] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1910machine # [ 61.034765] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1911machine # [ 61.041560] systemd[578]: Reload requested from client PID 4096 ('switch-to-confi')...1912machine # [ 61.044120] systemd[578]: Reloading...1913machine # [ 61.150060] systemd[578]: Reloading finished in 104 ms.1914machine # [ 61.164174] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1915machine # [ 61.173990] systemd[578]: Stopped Run user-specific NixOS activation.1916machine # [ 61.176460] systemd[578]: Stopping Run user-specific NixOS activation...1917machine # [ 61.178635] systemd[578]: Starting Run user-specific NixOS activation...1918machine # [ 61.211779] systemd[578]: Finished Run user-specific NixOS activation.1919machine # [ 61.216513] systemd[1]: Stopped target Reactivate sysinit units.1920machine # [ 61.221282] systemd[1]: Stopping Reactivate sysinit units...1921machine # [ 61.222296] systemd[1]: Reached target Reactivate sysinit units.1922machine # [ 61.225975] systemd[1]: Reached target Remote File Systems.1923machine # [ 61.231602] systemd[1]: Starting instantiated@one.service...1924machine # [ 61.236098] systemd[1]: Starting instantiated@two.service...1925machine # [ 61.247752] systemd[1]: Starting linger-users.service...1926machine # [ 61.259331] systemd[1]: Reached target Local File Systems.1927machine # [ 61.265011] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1928machine # [ 61.266652] systemd[1]: Starting Create SUID/SGID Wrappers...1929machine # [ 61.267476] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1930machine # [ 61.276498] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671931machine # [ 61.278913] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1932machine # [ 61.285428] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1933machine # [ 61.286895] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1934machine # [ 61.301128] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1935machine # [ 61.311981] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1936machine # [ 61.329284] systemd[1]: Finished instantiated@two.service.1937machine # [ 61.338472] systemd[1]: Finished instantiated@one.service.1938machine # [ 61.370344] systemd[1]: linger-users.service: Deactivated successfully.1939machine # [ 61.372938] systemd[1]: Finished linger-users.service.1940machine # [ 61.502458] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1941machine # [ 61.505236] systemd[1]: Finished Create SUID/SGID Wrappers.1942machine # [ 61.762017] nixos[4027]: finished switching to system configuration /nix/store/qr9zi1c9cpvbxnzkmn8w6285ic0yi079-nixos-system-machine-test1943machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.83 seconds)1944(finished: subtest: services, in 39.78 seconds)1945subtest: failing units1946machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11947machine # [ 61.980695] nixos[4171]: switching to system configuration /nix/store/35gjk3hx1frn0d9b60pl2wqyvrpp65sa-nixos-system-machine-test1948machine # [ 61.983358] systemd[1]: instantiated@one.service: Deactivated successfully.1949machine # [ 61.987338] systemd[1]: Stopped instantiated@one.service.1950machine # [ 61.989800] systemd[1]: Stopped target Remote File Systems.1951machine # [ 61.990763] systemd[1]: instantiated@two.service: Deactivated successfully.1952machine # [ 61.991799] systemd[1]: Stopped instantiated@two.service.1953machine # [ 61.993552] systemd[1]: Stopped target Local File Systems.1954machine # [ 62.267121] systemd[1]: Reload requested from client PID 4171 ('.switch-to-conf') (unit backdoor.service)...1955machine # [ 62.269236] systemd[1]: Reloading...1956machine # [ 62.583980] systemd[1]: Reloading finished in 313 ms.1957machine # [ 62.671528] systemd[578]: Reexecution requested from client PID 4240 ('switch-to-confi')...1958machine # [ 62.675616] systemd[578]: Reexecuting.1959machine # [ 62.732716] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1960machine # [ 62.851067] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1961machine # [ 62.857299] systemd[578]: Reload requested from client PID 4240 ('switch-to-confi')...1962machine # [ 62.858754] systemd[578]: Reloading...1963machine # [ 62.973339] systemd[578]: Reloading finished in 112 ms.1964machine # [ 62.990113] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1965machine # [ 62.998567] systemd[578]: Stopped Run user-specific NixOS activation.1966machine # [ 63.000113] systemd[578]: Stopping Run user-specific NixOS activation...1967machine # [ 63.003596] systemd[578]: Starting Run user-specific NixOS activation...1968machine # [ 63.036005] systemd[578]: Finished Run user-specific NixOS activation.1969machine # [ 63.040429] systemd[1]: Stopped target Reactivate sysinit units.1970machine # [ 63.042477] systemd[1]: Stopping Reactivate sysinit units...1971machine # [ 63.043390] systemd[1]: Reached target Reactivate sysinit units.1972machine # [ 63.048359] systemd[1]: Reached target Local File Systems.1973machine # [ 63.049262] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1974machine # [ 63.060655] systemd[1]: Starting Create SUID/SGID Wrappers...1975machine # [ 63.061654] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1976machine # [ 63.063132] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671977machine # [ 63.073344] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1978machine # [ 63.075092] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1979machine # [ 63.078650] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1980machine # [ 63.080980] systemd[1]: Reached target Remote File Systems.1981machine # [ 63.083433] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1982machine # [ 63.085312] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1983machine # [ 63.243817] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1984machine # [ 63.247051] systemd[1]: Finished Create SUID/SGID Wrappers.1985machine # [ 63.251282] systemd[1]: Starting linger-users.service...1986machine # [ 63.256651] systemd[1]: Starting test.service...1987machine # [ 63.296476] systemd[1]: Finished test.service.1988machine # [ 63.314855] systemd[1]: linger-users.service: Deactivated successfully.1989machine # [ 63.317403] systemd[1]: Finished linger-users.service.1990machine # [ 63.574234] nixos[4171]: finished switching to system configuration /nix/store/35gjk3hx1frn0d9b60pl2wqyvrpp65sa-nixos-system-machine-test1991machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.81 seconds)1992machine: must fail: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&11993machine # [ 63.810943] nixos[4313]: switching to system configuration /nix/store/xcvwrj2xsyy1jj2h3xwh1ibc0mdvim92-nixos-system-machine-test1994machine # [ 63.813693] systemd[1]: Stopped target Local File Systems.1995machine # [ 63.817711] systemd[1]: Stopped target Remote File Systems.1996machine # [ 63.818692] systemd[1]: test.service: Deactivated successfully.1997machine # [ 63.819571] systemd[1]: Stopped test.service.1998machine # [ 64.117690] systemd[1]: Reload requested from client PID 4313 ('.switch-to-conf') (unit backdoor.service)...1999machine # [ 64.119841] systemd[1]: Reloading...2000machine # [ 64.453926] systemd[1]: Reloading finished in 332 ms.2001machine # [ 64.553051] systemd[578]: Reexecution requested from client PID 4382 ('switch-to-confi')...2002machine # [ 64.557704] systemd[578]: Reexecuting.2003machine # [ 64.608059] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2004machine # [ 64.723454] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2005machine # [ 64.731356] systemd[578]: Reload requested from client PID 4382 ('switch-to-confi')...2006machine # [ 64.735743] systemd[578]: Reloading...2007machine # [ 64.850514] systemd[578]: Reloading finished in 116 ms.2008machine # [ 64.868231] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2009machine # [ 64.881880] systemd[578]: Stopped Run user-specific NixOS activation.2010machine # [ 64.884670] systemd[578]: Stopping Run user-specific NixOS activation...2011machine # [ 64.887088] systemd[578]: Starting Run user-specific NixOS activation...2012machine # [ 64.924132] systemd[578]: Finished Run user-specific NixOS activation.2013machine # [ 64.928531] systemd[1]: Stopped target Reactivate sysinit units.2014machine # [ 64.931563] systemd[1]: Stopping Reactivate sysinit units...2015machine # [ 64.934343] systemd[1]: Reached target Reactivate sysinit units.2016machine # [ 64.936964] systemd[1]: Reached target Local File Systems.2017machine # [ 64.941128] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2018machine # [ 64.952973] systemd[1]: Starting Create SUID/SGID Wrappers...2019machine # [ 64.956518] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2020machine # [ 64.957893] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672021machine # [ 64.969471] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2022machine # [ 64.971221] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2023machine # [ 64.972649] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2024machine # [ 64.973886] systemd[1]: Reached target Remote File Systems.2025machine # [ 64.974809] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2026machine # [ 64.976204] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2027machine # [ 65.151231] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2028machine # [ 65.153555] systemd[1]: Finished Create SUID/SGID Wrappers.2029machine # [ 65.160194] systemd[1]: Starting linger-users.service...2030machine # [ 65.164554] systemd[1]: Starting test.service...2031machine # [ 65.206506] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE2032machine # [ 65.209256] systemd[1]: test.service: Failed with result 'exit-code'.2033machine # [ 65.214037] systemd[1]: Failed to start test.service.2034machine # [ 65.233980] systemd[1]: linger-users.service: Deactivated successfully.2035machine # [ 65.237224] systemd[1]: Finished linger-users.service.2036machine # [ 65.516524] nixos[4313]: switching to system configuration /nix/store/xcvwrj2xsyy1jj2h3xwh1ibc0mdvim92-nixos-system-machine-test failed (status 4)2037machine: (finished: must fail: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.94 seconds)2038machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12039machine # [ 65.745298] nixos[4456]: switching to system configuration /nix/store/r0rwzl4p51ns0p1wvhxjpmcs60q3c41d-nixos-system-machine-test2040machine # [ 65.750881] systemd[1]: Stopped target Remote File Systems.2041machine # [ 65.751813] systemd[1]: Stopped target Local File Systems.2042machine # [ 66.040168] systemd[1]: Reload requested from client PID 4456 ('.switch-to-conf') (unit backdoor.service)...2043machine # [ 66.042232] systemd[1]: Reloading...2044machine # [ 66.367583] systemd[1]: Reloading finished in 323 ms.2045machine # [ 66.455941] systemd[578]: Reexecution requested from client PID 4525 ('switch-to-confi')...2046machine # [ 66.458163] systemd[578]: Reexecuting.2047machine # [ 66.519767] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2048machine # [ 66.636151] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2049machine # [ 66.642780] systemd[578]: Reload requested from client PID 4525 ('switch-to-confi')...2050machine # [ 66.646785] systemd[578]: Reloading...2051machine # [ 66.750261] systemd[578]: Reloading finished in 104 ms.2052machine # [ 66.764232] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2053machine # [ 66.774233] systemd[578]: Stopped Run user-specific NixOS activation.2054machine # [ 66.776740] systemd[578]: Stopping Run user-specific NixOS activation...2055machine # [ 66.778972] systemd[578]: Starting Run user-specific NixOS activation...2056machine # [ 66.812097] systemd[578]: Finished Run user-specific NixOS activation.2057machine # [ 66.816687] systemd[1]: Stopped target Reactivate sysinit units.2058machine # [ 66.820328] systemd[1]: Stopping Reactivate sysinit units...2059machine # [ 66.821294] systemd[1]: Reached target Reactivate sysinit units.2060machine # [ 66.824258] systemd[1]: Reached target Remote File Systems.2061machine # [ 66.828391] systemd[1]: Started autorestart.service.2062machine # [ 66.833405] systemd[1]: Starting linger-users.service...2063machine # [ 66.840662] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2064machine # [ 66.842027] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2065machine # [ 66.854923] systemd[1]: Reached target Local File Systems.2066machine # [ 66.855884] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2067machine # [ 66.869450] systemd[1]: Starting Create SUID/SGID Wrappers...2068machine # [ 66.870581] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2069machine # [ 66.880272] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672070machine # [ 66.888712] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2071machine # [ 66.890449] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2072machine # [ 66.891722] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2073machine # [ 66.911363] systemd[1]: autorestart.service: Deactivated successfully.2074machine # [ 66.944221] systemd[1]: linger-users.service: Deactivated successfully.2075machine # [ 66.947749] systemd[1]: Finished linger-users.service.2076machine # [ 67.085021] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2077machine # [ 67.088292] systemd[1]: Finished Create SUID/SGID Wrappers.2078machine # [ 67.344581] nixos[4456]: finished switching to system configuration /nix/store/r0rwzl4p51ns0p1wvhxjpmcs60q3c41d-nixos-system-machine-test2079machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.83 seconds)2080machine # [ 67.379040] systemd[1]: Stopped autorestart.service.2081machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12082machine # [ 67.571210] nixos[4603]: switching to system configuration /nix/store/r0rwzl4p51ns0p1wvhxjpmcs60q3c41d-nixos-system-machine-test2083machine # [ 67.576609] systemd[1]: Stopped target Local File Systems.2084machine # [ 67.577518] systemd[1]: Stopped target Remote File Systems.2085machine # [ 67.859889] systemd[1]: Reload requested from client PID 4603 ('.switch-to-conf') (unit backdoor.service)...2086machine # [ 67.862346] systemd[1]: Reloading...2087machine # [ 68.171882] systemd[1]: Reloading finished in 308 ms.2088machine # [ 68.260543] systemd[578]: Reexecution requested from client PID 4672 ('switch-to-confi')...2089machine # [ 68.263246] systemd[578]: Reexecuting.2090machine # [ 68.319657] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2091machine # [ 68.434049] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2092machine # [ 68.440783] systemd[578]: Reload requested from client PID 4672 ('switch-to-confi')...2093machine # [ 68.443412] systemd[578]: Reloading...2094machine # [ 68.549993] systemd[578]: Reloading finished in 105 ms.2095machine # [ 68.564348] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2096machine # [ 68.574358] systemd[578]: Stopped Run user-specific NixOS activation.2097machine # [ 68.577212] systemd[578]: Stopping Run user-specific NixOS activation...2098machine # [ 68.579886] systemd[578]: Starting Run user-specific NixOS activation...2099machine # [ 68.614317] systemd[578]: Finished Run user-specific NixOS activation.2100machine # [ 68.619088] systemd[1]: Stopped target Reactivate sysinit units.2101machine # [ 68.622065] systemd[1]: Stopping Reactivate sysinit units...2102machine # [ 68.623329] systemd[1]: Reached target Reactivate sysinit units.2103machine # [ 68.627308] systemd[1]: Reached target Local File Systems.2104machine # [ 68.632746] systemd[1]: Reached target Remote File Systems.2105machine # [ 68.637181] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2106machine # [ 68.641728] systemd[1]: Starting Create SUID/SGID Wrappers...2107machine # [ 68.642772] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2108machine # [ 68.652197] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672109machine # [ 68.654782] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2110machine # [ 68.661473] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2111machine # [ 68.663035] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2112machine # [ 68.664394] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2113machine # [ 68.665724] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2114machine # [ 68.830419] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2115machine # [ 68.836656] systemd[1]: Finished Create SUID/SGID Wrappers.2116machine # [ 68.840272] systemd[1]: Started autorestart.service.2117machine # [ 68.845105] systemd[1]: Starting linger-users.service...2118machine # [ 68.885432] systemd[1]: autorestart.service: Deactivated successfully.2119machine # [ 68.905450] systemd[1]: linger-users.service: Deactivated successfully.2120machine # [ 68.908815] systemd[1]: Finished linger-users.service.2121machine # [ 69.164518] nixos[4603]: finished switching to system configuration /nix/store/r0rwzl4p51ns0p1wvhxjpmcs60q3c41d-nixos-system-machine-test2122machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.78 seconds)2123machine # [ 69.207483] systemd[1]: Stopped autorestart.service.2124machine: must fail: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&12125machine # [ 69.428668] nixos[4750]: switching to system configuration /nix/store/j24xyyk895py98s10xnaz16d8v6vrgcj-nixos-system-machine-test2126machine # [ 69.431448] systemd[1]: Stopped target Local File Systems.2127machine # [ 69.434476] systemd[1]: Stopped target Remote File Systems.2128machine # [ 69.734833] systemd[1]: Reload requested from client PID 4750 ('.switch-to-conf') (unit backdoor.service)...2129machine # [ 69.737304] systemd[1]: Reloading...2130machine # [ 70.065714] systemd[1]: Reloading finished in 326 ms.2131machine # [ 70.152226] systemd[578]: Reexecution requested from client PID 4819 ('switch-to-confi')...2132machine # [ 70.156421] systemd[578]: Reexecuting.2133machine # [ 70.215430] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2134machine # [ 70.329404] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2135machine # [ 70.336959] systemd[578]: Reload requested from client PID 4819 ('switch-to-confi')...2136machine # [ 70.338426] systemd[578]: Reloading...2137machine # [ 70.443261] systemd[578]: Reloading finished in 103 ms.2138machine # [ 70.461609] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2139machine # [ 70.469913] systemd[578]: Stopped Run user-specific NixOS activation.2140machine # [ 70.472403] systemd[578]: Stopping Run user-specific NixOS activation...2141machine # [ 70.474577] systemd[578]: Starting Run user-specific NixOS activation...2142machine # [ 70.507192] systemd[578]: Finished Run user-specific NixOS activation.2143machine # [ 70.510885] systemd[1]: Stopped target Reactivate sysinit units.2144machine # [ 70.513760] systemd[1]: Stopping Reactivate sysinit units...2145machine # [ 70.514704] systemd[1]: Reached target Reactivate sysinit units.2146machine # [ 70.520092] systemd[1]: Reached target Remote File Systems.2147machine # [ 70.524271] systemd[1]: Started autorestart.service.2148machine # [ 70.532630] systemd[1]: Starting linger-users.service...2149machine # [ 70.533543] systemd[1]: Reached target Local File Systems.2150machine # [ 70.534477] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2151machine # [ 70.555010] systemd[1]: Starting Create SUID/SGID Wrappers...2152machine # [ 70.556001] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2153machine # [ 70.557723] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672154machine # [ 70.562789] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2155machine # [ 70.569953] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2156machine # [ 70.571495] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2157machine # [ 70.583967] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2158machine # [ 70.591738] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2159machine # [ 70.604326] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE2160machine # [ 70.609606] systemd[1]: autorestart.service: Failed with result 'exit-code'.2161machine # [ 70.639339] systemd[1]: linger-users.service: Deactivated successfully.2162machine # [ 70.641323] systemd[1]: Finished linger-users.service.2163machine # [ 70.769786] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2164machine # [ 70.773380] systemd[1]: Finished Create SUID/SGID Wrappers.2165machine # [ 71.049967] nixos[4750]: switching to system configuration /nix/store/j24xyyk895py98s10xnaz16d8v6vrgcj-nixos-system-machine-test failed (status 4)2166machine: (finished: must fail: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.84 seconds)2167(finished: subtest: failing units, in 9.29 seconds)2168subtest: unit file parser2169machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12170machine # [ 71.256663] nixos[4893]: switching to system configuration /nix/store/0sg6l6yd37qb4nivbl7aqfjx0v1rx4di-nixos-system-machine-test2171machine # [ 71.259642] systemd[1]: Stopped target Remote File Systems.2172machine # [ 71.264099] systemd[1]: Stopped target Local File Systems.2173machine # [ 71.264992] systemd[1]: Stopped autorestart.service.2174machine # [ 71.534367] systemd[1]: Reload requested from client PID 4893 ('.switch-to-conf') (unit backdoor.service)...2175machine # [ 71.536363] systemd[1]: Reloading...2176machine # [ 71.852054] systemd[1]: Reloading finished in 314 ms.2177machine # [ 71.940451] systemd[578]: Reexecution requested from client PID 4962 ('switch-to-confi')...2178machine # [ 71.944801] systemd[578]: Reexecuting.2179machine # [ 72.004201] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2180machine # [ 72.119186] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2181machine # [ 72.126022] systemd[578]: Reload requested from client PID 4962 ('switch-to-confi')...2182machine # [ 72.130009] systemd[578]: Reloading...2183machine # [ 72.233651] systemd[578]: Reloading finished in 104 ms.2184machine # [ 72.248184] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2185machine # [ 72.258163] systemd[578]: Stopped Run user-specific NixOS activation.2186machine # [ 72.260788] systemd[578]: Stopping Run user-specific NixOS activation...2187machine # [ 72.263134] systemd[578]: Starting Run user-specific NixOS activation...2188machine # [ 72.296221] systemd[578]: Finished Run user-specific NixOS activation.2189machine # [ 72.301364] systemd[1]: Stopped target Reactivate sysinit units.2190machine # [ 72.306312] systemd[1]: Stopping Reactivate sysinit units...2191machine # [ 72.307227] systemd[1]: Reached target Reactivate sysinit units.2192machine # [ 72.308666] systemd[1]: Reached target Remote File Systems.2193machine # [ 72.309507] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2194machine # [ 72.310999] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2195machine # [ 72.318592] systemd[1]: Starting linger-users.service...2196machine # [ 72.322797] systemd[1]: Starting test.service...2197machine # [ 72.332428] systemd[1]: Reached target Local File Systems.2198machine # [ 72.338975] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2199machine # [ 72.348286] systemd[1]: Starting Create SUID/SGID Wrappers...2200machine # [ 72.349226] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2201machine # [ 72.350654] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672202machine # [ 72.364369] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2203machine # [ 72.366285] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2204machine # [ 72.377529] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2205machine # [ 72.397064] systemd[1]: Finished test.service.2206machine # [ 72.429811] systemd[1]: linger-users.service: Deactivated successfully.2207machine # [ 72.433678] systemd[1]: Finished linger-users.service.2208machine # [ 72.567992] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2209machine # [ 72.571666] systemd[1]: Finished Create SUID/SGID Wrappers.2210machine # [ 72.827331] nixos[4893]: finished switching to system configuration /nix/store/0sg6l6yd37qb4nivbl7aqfjx0v1rx4di-nixos-system-machine-test2211machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.78 seconds)2212machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&12213machine # [ 73.053586] nixos[5035]: switching to system configuration /nix/store/r3bcr5lvycxx6pgw5if9rrh0bv5saaah-nixos-system-machine-test2214machine # [ 73.057552] systemd[1]: Stopped target Remote File Systems.2215machine # [ 73.059811] systemd[1]: Stopped target Local File Systems.2216machine # [ 73.353153] systemd[1]: Reload requested from client PID 5035 ('.switch-to-conf') (unit backdoor.service)...2217machine # [ 73.355438] systemd[1]: Reloading...2218machine # [ 73.687683] systemd[1]: Reloading finished in 330 ms.2219machine # [ 73.780640] systemd[578]: Reexecution requested from client PID 5104 ('switch-to-confi')...2220machine # [ 73.784594] systemd[578]: Reexecuting.2221machine # [ 73.843962] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2222machine # [ 73.965033] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2223machine # [ 73.972530] systemd[578]: Reload requested from client PID 5104 ('switch-to-confi')...2224machine # [ 73.973873] systemd[578]: Reloading...2225machine # [ 74.085991] systemd[578]: Reloading finished in 110 ms.2226machine # [ 74.100199] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2227machine # [ 74.110456] systemd[578]: Stopped Run user-specific NixOS activation.2228machine # [ 74.113103] systemd[578]: Stopping Run user-specific NixOS activation...2229machine # [ 74.115461] systemd[578]: Starting Run user-specific NixOS activation...2230machine # [ 74.149477] systemd[578]: Finished Run user-specific NixOS activation.2231machine # [ 74.153973] systemd[1]: Stopped target Reactivate sysinit units.2232machine # [ 74.155063] systemd[1]: Stopping Reactivate sysinit units...2233machine # [ 74.160400] systemd[1]: Reached target Reactivate sysinit units.2234machine # [ 74.161493] systemd[1]: test.service: Deactivated successfully.2235machine # [ 74.162404] systemd[1]: Stopped test.service.2236machine # [ 74.163088] systemd[1]: Stopping test.service...2237machine # [ 74.164989] systemd[1]: Starting test.service...2238machine # [ 74.191543] systemd[1]: Finished test.service.2239machine # [ 74.198661] systemd[1]: Reached target Remote File Systems.2240machine # [ 74.201542] systemd[1]: Starting linger-users.service...2241machine # [ 74.215312] systemd[1]: Reached target Local File Systems.2242machine # [ 74.218439] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2243machine # [ 74.228784] systemd[1]: Starting Create SUID/SGID Wrappers...2244machine # [ 74.229790] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2245machine # [ 74.231297] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672246machine # [ 74.240782] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2247machine # [ 74.243207] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2248machine # [ 74.248650] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2249machine # [ 74.250097] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2250machine # [ 74.259760] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2251machine # [ 74.301411] systemd[1]: linger-users.service: Deactivated successfully.2252machine # [ 74.305389] systemd[1]: Finished linger-users.service.2253machine # [ 74.449012] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2254machine # [ 74.453159] systemd[1]: Finished Create SUID/SGID Wrappers.2255machine # [ 74.707453] nixos[5035]: finished switching to system configuration /nix/store/r3bcr5lvycxx6pgw5if9rrh0bv5saaah-nixos-system-machine-test2256machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.88 seconds)2257machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&12258machine # [ 74.958573] nixos[5177]: switching to system configuration /nix/store/z3fldvkzf9zn1wz7ad60iqbvvxgfmza7-nixos-system-machine-test2259machine # [ 74.961381] systemd[1]: Stopped target Local File Systems.2260machine # [ 74.964289] systemd[1]: Stopped target Remote File Systems.2261machine # [ 75.289030] systemd[1]: Reload requested from client PID 5177 ('.switch-to-conf') (unit backdoor.service)...2262machine # [ 75.291145] systemd[1]: Reloading...2263machine # [ 75.659342] systemd[1]: Reloading finished in 366 ms.2264machine # [ 75.760482] systemd[578]: Reexecution requested from client PID 5246 ('switch-to-confi')...2265machine # [ 75.763892] systemd[578]: Reexecuting.2266machine # [ 75.823854] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2267machine # [ 75.948128] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2268machine # [ 75.954008] systemd[578]: Reload requested from client PID 5246 ('switch-to-confi')...2269machine # [ 75.955522] systemd[578]: Reloading...2270machine # [ 76.068194] systemd[578]: Reloading finished in 110 ms.2271machine # [ 76.084209] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2272machine # [ 76.096091] systemd[578]: Stopped Run user-specific NixOS activation.2273machine # [ 76.097210] systemd[578]: Stopping Run user-specific NixOS activation...2274machine # [ 76.100542] systemd[578]: Starting Run user-specific NixOS activation...2275machine # [ 76.134218] systemd[578]: Finished Run user-specific NixOS activation.2276machine # [ 76.138880] systemd[1]: Stopped target Reactivate sysinit units.2277machine # [ 76.144858] systemd[1]: Stopping Reactivate sysinit units...2278machine # [ 76.145906] systemd[1]: Reached target Reactivate sysinit units.2279machine # [ 76.146896] systemd[1]: test.service: Deactivated successfully.2280machine # [ 76.147790] systemd[1]: Stopped test.service.2281machine # [ 76.148721] systemd[1]: Stopping test.service...2282machine # [ 76.151360] systemd[1]: Starting test.service...2283machine # [ 76.180487] systemd[1]: Finished test.service.2284machine # [ 76.187413] systemd[1]: Reached target Remote File Systems.2285machine # [ 76.192908] systemd[1]: Starting linger-users.service...2286machine # [ 76.200786] systemd[1]: Reached target Local File Systems.2287machine # [ 76.204688] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2288machine # [ 76.210958] systemd[1]: Starting Create SUID/SGID Wrappers...2289machine # [ 76.221004] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2290machine # [ 76.222693] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672291machine # [ 76.234129] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2292machine # [ 76.235987] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2293machine # [ 76.247450] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2294machine # [ 76.252592] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2295machine # [ 76.254208] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2296machine # [ 76.303065] systemd[1]: linger-users.service: Deactivated successfully.2297machine # [ 76.307340] systemd[1]: Finished linger-users.service.2298machine # [ 76.457372] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2299machine # [ 76.459562] systemd[1]: Finished Create SUID/SGID Wrappers.2300machine # [ 76.716698] nixos[5177]: finished switching to system configuration /nix/store/z3fldvkzf9zn1wz7ad60iqbvvxgfmza7-nixos-system-machine-test2301machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 2.01 seconds)2302machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12303machine # [ 76.937522] nixos[5319]: switching to system configuration /nix/store/0sg6l6yd37qb4nivbl7aqfjx0v1rx4di-nixos-system-machine-test2304machine # [ 76.943215] systemd[1]: Stopped target Local File Systems.2305machine # [ 76.945731] systemd[1]: Stopped target Remote File Systems.2306machine # [ 77.230915] systemd[1]: Reload requested from client PID 5319 ('.switch-to-conf') (unit backdoor.service)...2307machine # [ 77.233390] systemd[1]: Reloading...2308machine # [ 77.558438] systemd[1]: Reloading finished in 323 ms.2309machine # [ 77.647824] systemd[578]: Reexecution requested from client PID 5388 ('switch-to-confi')...2310machine # [ 77.653384] systemd[578]: Reexecuting.2311machine # [ 77.707805] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2312machine # [ 77.824673] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2313machine # [ 77.831556] systemd[578]: Reload requested from client PID 5388 ('switch-to-confi')...2314machine # [ 77.835342] systemd[578]: Reloading...2315machine # [ 77.943284] systemd[578]: Reloading finished in 109 ms.2316machine # [ 77.961679] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2317machine # [ 77.970207] systemd[578]: Stopped Run user-specific NixOS activation.2318machine # [ 77.972598] systemd[578]: Stopping Run user-specific NixOS activation...2319machine # [ 77.974681] systemd[578]: Starting Run user-specific NixOS activation...2320machine # [ 78.009249] systemd[578]: Finished Run user-specific NixOS activation.2321machine # [ 78.013377] systemd[1]: Stopped target Reactivate sysinit units.2322machine # [ 78.015577] systemd[1]: Stopping Reactivate sysinit units...2323machine # [ 78.019564] systemd[1]: Reached target Reactivate sysinit units.2324machine # [ 78.020872] systemd[1]: test.service: Deactivated successfully.2325machine # [ 78.021769] systemd[1]: Stopped test.service.2326machine # [ 78.022525] systemd[1]: Stopping test.service...2327machine # [ 78.024435] systemd[1]: Starting test.service...2328machine # [ 78.049478] systemd[1]: Finished test.service.2329machine # [ 78.053140] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2330machine # [ 78.058240] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2331machine # [ 78.063010] systemd[1]: Reached target Remote File Systems.2332machine # [ 78.069048] systemd[1]: Starting linger-users.service...2333machine # [ 78.074336] systemd[1]: Reached target Local File Systems.2334machine # [ 78.075313] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2335machine # [ 78.080761] systemd[1]: Starting Create SUID/SGID Wrappers...2336machine # [ 78.081727] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2337machine # [ 78.083091] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672338machine # [ 78.097588] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2339machine # [ 78.099355] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2340machine # [ 78.100784] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2341machine # [ 78.162357] systemd[1]: linger-users.service: Deactivated successfully.2342machine # [ 78.164200] systemd[1]: Finished linger-users.service.2343machine # [ 78.296316] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2344machine # [ 78.299424] systemd[1]: Finished Create SUID/SGID Wrappers.2345machine # [ 78.555320] nixos[5319]: finished switching to system configuration /nix/store/0sg6l6yd37qb4nivbl7aqfjx0v1rx4di-nixos-system-machine-test2346machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.84 seconds)2347machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&12348machine # [ 78.790268] nixos[5461]: switching to system configuration /nix/store/a2ngjdq6fis8hgnfafvn59wl7iyxzdr3-nixos-system-machine-test2349machine # [ 78.794148] systemd[1]: Stopped target Remote File Systems.2350machine # [ 78.796454] systemd[1]: Stopped target Local File Systems.2351machine # [ 79.089113] systemd[1]: Reload requested from client PID 5461 ('.switch-to-conf') (unit backdoor.service)...2352machine # [ 79.090729] systemd[1]: Reloading...2353machine # [ 79.418124] systemd[1]: Reloading finished in 326 ms.2354machine # [ 79.514018] systemd[578]: Reexecution requested from client PID 5530 ('switch-to-confi')...2355machine # [ 79.518861] systemd[578]: Reexecuting.2356machine # [ 79.571377] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2357machine # [ 79.689200] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2358machine # [ 79.696752] systemd[578]: Reload requested from client PID 5530 ('switch-to-confi')...2359machine # [ 79.699185] systemd[578]: Reloading...2360machine # [ 79.808306] systemd[578]: Reloading finished in 107 ms.2361machine # [ 79.824182] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2362machine # [ 79.833848] systemd[578]: Stopped Run user-specific NixOS activation.2363machine # [ 79.836521] systemd[578]: Stopping Run user-specific NixOS activation...2364machine # [ 79.838732] systemd[578]: Starting Run user-specific NixOS activation...2365machine # [ 79.872693] systemd[578]: Finished Run user-specific NixOS activation.2366machine # [ 79.876860] systemd[1]: Stopped target Reactivate sysinit units.2367machine # [ 79.879342] systemd[1]: Stopping Reactivate sysinit units...2368machine # [ 79.884261] systemd[1]: Reached target Reactivate sysinit units.2369machine # [ 79.885187] systemd[1]: Reached target Local File Systems.2370machine # [ 79.885972] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2371machine # [ 79.896683] systemd[1]: Starting Create SUID/SGID Wrappers...2372machine # [ 79.897625] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2373machine # [ 79.898927] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672374machine # [ 79.904856] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2375machine # [ 79.906546] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2376machine # [ 79.907851] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2377machine # [ 79.919280] systemd[1]: Reached target Remote File Systems.2378machine # [ 79.922813] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2379machine # [ 79.925338] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2380machine # [ 80.082669] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2381machine # [ 80.085744] systemd[1]: Finished Create SUID/SGID Wrappers.2382machine # [ 80.090881] systemd[1]: Starting linger-users.service...2383machine # [ 80.133604] systemd[1]: linger-users.service: Deactivated successfully.2384machine # [ 80.136548] systemd[1]: Finished linger-users.service.2385machine # [ 80.392240] nixos[5461]: finished switching to system configuration /nix/store/a2ngjdq6fis8hgnfafvn59wl7iyxzdr3-nixos-system-machine-test2386machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.84 seconds)2387machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&12388machine # [ 80.627218] nixos[5601]: switching to system configuration /nix/store/49i6wzl53bpbrnins2iwyak4xfas6nn9-nixos-system-machine-test2389machine # [ 80.629781] systemd[1]: Stopped target Remote File Systems.2390machine # [ 80.632426] systemd[1]: Stopped target Local File Systems.2391machine # [ 80.928386] systemd[1]: Reload requested from client PID 5601 ('.switch-to-conf') (unit backdoor.service)...2392machine # [ 80.930470] systemd[1]: Reloading...2393machine # [ 81.263187] systemd[1]: Reloading finished in 330 ms.2394machine # [ 81.350350] systemd[578]: Reexecution requested from client PID 5670 ('switch-to-confi')...2395machine # [ 81.354268] systemd[578]: Reexecuting.2396machine # [ 81.411419] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2397machine # [ 81.523024] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2398machine # [ 81.529891] systemd[578]: Reload requested from client PID 5670 ('switch-to-confi')...2399machine # [ 81.533687] systemd[578]: Reloading...2400machine # [ 81.638122] systemd[578]: Reloading finished in 105 ms.2401machine # [ 81.652176] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2402machine # [ 81.663384] systemd[578]: Stopped Run user-specific NixOS activation.2403machine # [ 81.666014] systemd[578]: Stopping Run user-specific NixOS activation...2404machine # [ 81.668466] systemd[578]: Starting Run user-specific NixOS activation...2405machine # [ 81.700706] systemd[578]: Finished Run user-specific NixOS activation.2406machine # [ 81.704550] systemd[1]: Stopped target Reactivate sysinit units.2407machine # [ 81.706992] systemd[1]: Stopping Reactivate sysinit units...2408machine # [ 81.707894] systemd[1]: Reached target Reactivate sysinit units.2409machine # [ 81.711732] systemd[1]: test.service: Deactivated successfully.2410machine # [ 81.712824] systemd[1]: Stopped test.service.2411machine # [ 81.713528] systemd[1]: Stopping test.service...2412machine # [ 81.715319] systemd[1]: Starting test.service...2413machine # [ 81.741097] systemd[1]: Finished test.service.2414machine # [ 81.745729] systemd[1]: Reached target Remote File Systems.2415machine # [ 81.749361] systemd[1]: Reached target Local File Systems.2416machine # [ 81.755176] systemd[1]: Starting linger-users.service...2417machine # [ 81.766332] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2418machine # [ 81.776359] systemd[1]: Starting Create SUID/SGID Wrappers...2419machine # [ 81.777303] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2420machine # [ 81.778630] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672421machine # [ 81.788227] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2422machine # [ 81.789957] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2423machine # [ 81.798670] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2424machine # [ 81.803030] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2425machine # [ 81.808887] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2426machine # [ 81.847752] systemd[1]: linger-users.service: Deactivated successfully.2427machine # [ 81.851067] systemd[1]: Finished linger-users.service.2428machine # [ 81.976154] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2429machine # [ 81.979168] systemd[1]: Finished Create SUID/SGID Wrappers.2430machine # [ 82.234971] nixos[5601]: finished switching to system configuration /nix/store/49i6wzl53bpbrnins2iwyak4xfas6nn9-nixos-system-machine-test2431machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.84 seconds)2432machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&12433machine # [ 82.459091] nixos[5743]: switching to system configuration /nix/store/zzqwjvynrhwqpdvq81y1k3da0qy3s9nz-nixos-system-machine-test2434machine # [ 82.461998] systemd[1]: Stopped target Remote File Systems.2435machine # [ 82.464473] systemd[1]: Stopped target Local File Systems.2436machine # [ 82.747009] systemd[1]: Reload requested from client PID 5743 ('.switch-to-conf') (unit backdoor.service)...2437machine # [ 82.749146] systemd[1]: Reloading...2438machine # [ 83.099903] systemd[1]: Reloading finished in 349 ms.2439machine # [ 83.190136] systemd[578]: Reexecution requested from client PID 5812 ('switch-to-confi')...2440machine # [ 83.191613] systemd[578]: Reexecuting.2441machine # [ 83.251441] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2442machine # [ 83.365046] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2443machine # [ 83.371962] systemd[578]: Reload requested from client PID 5812 ('switch-to-confi')...2444machine # [ 83.373389] systemd[578]: Reloading...2445machine # [ 83.480847] systemd[578]: Reloading finished in 105 ms.2446machine # [ 83.496180] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2447machine # [ 83.506638] systemd[578]: Stopped Run user-specific NixOS activation.2448machine # [ 83.509105] systemd[578]: Stopping Run user-specific NixOS activation...2449machine # [ 83.511325] systemd[578]: Starting Run user-specific NixOS activation...2450machine # [ 83.543853] systemd[578]: Finished Run user-specific NixOS activation.2451machine # [ 83.548442] systemd[1]: Stopped target Reactivate sysinit units.2452machine # [ 83.549715] systemd[1]: Stopping Reactivate sysinit units...2453machine # [ 83.550693] systemd[1]: Reached target Reactivate sysinit units.2454machine # [ 83.555395] systemd[1]: test.service: Deactivated successfully.2455machine # [ 83.556472] systemd[1]: Stopped test.service.2456machine # [ 83.557128] systemd[1]: Stopping test.service...2457machine # [ 83.558835] systemd[1]: Starting test.service...2458machine # [ 83.585189] systemd[1]: Finished test.service.2459machine # [ 83.591664] systemd[1]: Reached target Remote File Systems.2460machine # [ 83.595612] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2461machine # [ 83.604432] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2462machine # [ 83.605830] systemd[1]: Starting linger-users.service...2463machine # [ 83.610132] systemd[1]: Reached target Local File Systems.2464machine # [ 83.615542] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2465machine # [ 83.620832] systemd[1]: Starting Create SUID/SGID Wrappers...2466machine # [ 83.621724] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2467machine # [ 83.623108] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672468machine # [ 83.635035] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2469machine # [ 83.639702] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2470machine # [ 83.644653] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2471machine # [ 83.688764] systemd[1]: linger-users.service: Deactivated successfully.2472machine # [ 83.692627] systemd[1]: Finished linger-users.service.2473machine # [ 83.824704] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2474machine # [ 83.828186] systemd[1]: Finished Create SUID/SGID Wrappers.2475machine # [ 84.082425] nixos[5743]: finished switching to system configuration /nix/store/zzqwjvynrhwqpdvq81y1k3da0qy3s9nz-nixos-system-machine-test2476machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.85 seconds)2477machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&12478machine # [ 84.320785] nixos[5885]: switching to system configuration /nix/store/fxf18pa14wvbkf9vnj59aqdfapl9ywnz-nixos-system-machine-test2479machine # [ 84.323435] systemd[1]: Stopped target Remote File Systems.2480machine # [ 84.326261] systemd[1]: Stopped target Local File Systems.2481machine # [ 84.624437] systemd[1]: Reload requested from client PID 5885 ('.switch-to-conf') (unit backdoor.service)...2482machine # [ 84.626525] systemd[1]: Reloading...2483machine # [ 84.968286] systemd[1]: Reloading finished in 340 ms.2484machine # [ 85.056458] systemd[578]: Reexecution requested from client PID 5954 ('switch-to-confi')...2485machine # [ 85.059935] systemd[578]: Reexecuting.2486machine # [ 85.107198] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2487machine # [ 85.218366] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2488machine # [ 85.225370] systemd[578]: Reload requested from client PID 5954 ('switch-to-confi')...2489machine # [ 85.229677] systemd[578]: Reloading...2490machine # [ 85.340949] systemd[578]: Reloading finished in 112 ms.2491machine # [ 85.352193] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2492machine # [ 85.363722] systemd[578]: Stopped Run user-specific NixOS activation.2493machine # [ 85.366358] systemd[578]: Stopping Run user-specific NixOS activation...2494machine # [ 85.368341] systemd[578]: Starting Run user-specific NixOS activation...2495machine # [ 85.401257] systemd[578]: Finished Run user-specific NixOS activation.2496machine # [ 85.405240] systemd[1]: Stopped target Reactivate sysinit units.2497machine # [ 85.407520] systemd[1]: Stopping Reactivate sysinit units...2498machine # [ 85.411468] systemd[1]: Reached target Reactivate sysinit units.2499machine # [ 85.412907] systemd[1]: test.service: Deactivated successfully.2500machine # [ 85.413808] systemd[1]: Stopped test.service.2501machine # [ 85.414610] systemd[1]: Stopping test.service...2502machine # [ 85.420292] systemd[1]: Starting test.service...2503machine # [ 85.443600] systemd[1]: Finished test.service.2504machine # [ 85.450311] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2505machine # [ 85.455482] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2506machine # [ 85.460730] systemd[1]: Reached target Local File Systems.2507machine # [ 85.461675] systemd[1]: Reached target Remote File Systems.2508machine # [ 85.468455] systemd[1]: Starting linger-users.service...2509machine # [ 85.482135] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2510machine # [ 85.492214] systemd[1]: Starting Create SUID/SGID Wrappers...2511machine # [ 85.493326] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2512machine # [ 85.500284] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672513machine # [ 85.502835] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2514machine # [ 85.510075] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2515machine # [ 85.511570] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2516machine # [ 85.565347] systemd[1]: linger-users.service: Deactivated successfully.2517machine # [ 85.567738] systemd[1]: Finished linger-users.service.2518machine # [ 85.732216] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2519machine # [ 85.735781] systemd[1]: Finished Create SUID/SGID Wrappers.2520machine # [ 85.989911] nixos[5885]: finished switching to system configuration /nix/store/fxf18pa14wvbkf9vnj59aqdfapl9ywnz-nixos-system-machine-test2521machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 1.91 seconds)2522machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12523machine # [ 86.213394] nixos[6027]: switching to system configuration /nix/store/0sg6l6yd37qb4nivbl7aqfjx0v1rx4di-nixos-system-machine-test2524machine # [ 86.216068] systemd[1]: Stopped target Local File Systems.2525machine # [ 86.218580] systemd[1]: Stopped target Remote File Systems.2526machine # [ 86.502723] systemd[1]: Reload requested from client PID 6027 ('.switch-to-conf') (unit backdoor.service)...2527machine # [ 86.505015] systemd[1]: Reloading...2528machine # [ 86.833595] systemd[1]: Reloading finished in 326 ms.2529machine # [ 86.931721] systemd[578]: Reexecution requested from client PID 6095 ('switch-to-confi')...2530machine # [ 86.934240] systemd[578]: Reexecuting.2531machine # [ 86.992178] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2532machine # [ 87.105372] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2533machine # [ 87.113988] systemd[578]: Reload requested from client PID 6095 ('switch-to-confi')...2534machine # [ 87.115471] systemd[578]: Reloading...2535machine # [ 87.229569] systemd[578]: Reloading finished in 112 ms.2536machine # [ 87.244212] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2537machine # [ 87.256133] systemd[578]: Stopped Run user-specific NixOS activation.2538machine # [ 87.257321] systemd[578]: Stopping Run user-specific NixOS activation...2539machine # [ 87.259944] systemd[578]: Starting Run user-specific NixOS activation...2540machine # [ 87.293414] systemd[578]: Finished Run user-specific NixOS activation.2541machine # [ 87.297970] systemd[1]: Stopped target Reactivate sysinit units.2542machine # [ 87.300168] systemd[1]: Stopping Reactivate sysinit units...2543machine # [ 87.304779] systemd[1]: Reached target Reactivate sysinit units.2544machine # [ 87.305715] systemd[1]: test.service: Deactivated successfully.2545machine # [ 87.306641] systemd[1]: Stopped test.service.2546machine # [ 87.307313] systemd[1]: Stopping test.service...2547machine # [ 87.312535] systemd[1]: Starting test.service...2548machine # [ 87.334347] systemd[1]: Finished test.service.2549machine # [ 87.338646] systemd[1]: Reached target Remote File Systems.2550machine # [ 87.343945] systemd[1]: Starting linger-users.service...2551machine # [ 87.347997] systemd[1]: Reached target Local File Systems.2552machine # [ 87.351374] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2553machine # [ 87.364453] systemd[1]: Starting Create SUID/SGID Wrappers...2554machine # [ 87.365482] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2555machine # [ 87.366911] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672556machine # [ 87.381896] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2557machine # [ 87.383702] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2558machine # [ 87.385127] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2559machine # [ 87.386501] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2560machine # [ 87.387828] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2561machine # [ 87.444134] systemd[1]: linger-users.service: Deactivated successfully.2562machine # [ 87.446019] systemd[1]: Finished linger-users.service.2563machine # [ 87.581765] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2564machine # [ 87.584880] systemd[1]: Finished Create SUID/SGID Wrappers.2565machine # [ 87.842035] nixos[6027]: finished switching to system configuration /nix/store/0sg6l6yd37qb4nivbl7aqfjx0v1rx4di-nixos-system-machine-test2566machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.85 seconds)2567machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&12568machine # [ 88.081427] nixos[6169]: switching to system configuration /nix/store/hkcryrvawja2bfrn99amifp3s1l359r2-nixos-system-machine-test2569machine # [ 88.084327] systemd[1]: Stopped target Remote File Systems.2570machine # [ 88.086744] systemd[1]: Stopped target Local File Systems.2571machine # [ 88.393003] systemd[1]: Reload requested from client PID 6169 ('.switch-to-conf') (unit backdoor.service)...2572machine # [ 88.395385] systemd[1]: Reloading...2573machine # [ 88.733998] systemd[1]: Reloading finished in 336 ms.2574machine # [ 88.824478] systemd[578]: Reexecution requested from client PID 6238 ('switch-to-confi')...2575machine # [ 88.828242] systemd[578]: Reexecuting.2576machine # [ 88.891611] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2577machine # [ 89.009331] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2578machine # [ 89.016598] systemd[578]: Reload requested from client PID 6238 ('switch-to-confi')...2579machine # [ 89.019472] systemd[578]: Reloading...2580machine # [ 89.131622] systemd[578]: Reloading finished in 111 ms.2581machine # [ 89.148200] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2582machine # [ 89.160205] systemd[578]: Stopped Run user-specific NixOS activation.2583machine # [ 89.161330] systemd[578]: Stopping Run user-specific NixOS activation...2584machine # [ 89.164610] systemd[578]: Starting Run user-specific NixOS activation...2585machine # [ 89.198309] systemd[578]: Finished Run user-specific NixOS activation.2586machine # [ 89.203057] systemd[1]: Stopped target Reactivate sysinit units.2587machine # [ 89.207773] systemd[1]: Stopping Reactivate sysinit units...2588machine # [ 89.209105] systemd[1]: Reached target Reactivate sysinit units.2589machine # [ 89.211336] systemd[1]: Reloading test.service...2590machine # [ 89.238933] systemd[1]: Reloaded test.service.2591machine # [ 89.243356] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2592machine # [ 89.247041] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2593machine # [ 89.249404] systemd[1]: Reached target Local File Systems.2594machine # [ 89.251673] systemd[1]: Reached target Remote File Systems.2595machine # [ 89.260870] systemd[1]: Starting linger-users.service...2596machine # [ 89.272578] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2597machine # [ 89.284172] systemd[1]: Starting Create SUID/SGID Wrappers...2598machine # [ 89.285237] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2599machine # [ 89.286758] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672600machine # [ 89.291336] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2601machine # [ 89.296737] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2602machine # [ 89.303566] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2603machine # [ 89.354068] systemd[1]: linger-users.service: Deactivated successfully.2604machine # [ 89.357695] systemd[1]: Finished linger-users.service.2605machine # [ 89.506241] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2606machine # [ 89.509485] systemd[1]: Finished Create SUID/SGID Wrappers.2607machine # [ 89.765823] nixos[6169]: finished switching to system configuration /nix/store/hkcryrvawja2bfrn99amifp3s1l359r2-nixos-system-machine-test2608machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.92 seconds)2609machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&12610machine # [ 90.018967] nixos[6311]: switching to system configuration /nix/store/vrqyzkkrfnmnycy520kxkf7hdbg72r11-nixos-system-machine-test2611machine # [ 90.022225] systemd[1]: Stopped target Local File Systems.2612machine # [ 90.024741] systemd[1]: Stopped target Remote File Systems.2613machine # [ 90.347581] systemd[1]: Reload requested from client PID 6311 ('.switch-to-conf') (unit backdoor.service)...2614machine # [ 90.350182] systemd[1]: Reloading...2615machine # [ 90.683681] systemd[1]: Reloading finished in 332 ms.2616machine # [ 90.770442] systemd[578]: Reexecution requested from client PID 6380 ('switch-to-confi')...2617machine # [ 90.774949] systemd[578]: Reexecuting.2618machine # [ 90.819110] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2619machine # [ 90.929089] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2620machine # [ 90.936238] systemd[578]: Reload requested from client PID 6380 ('switch-to-confi')...2621machine # [ 90.938734] systemd[578]: Reloading...2622machine # [ 91.044958] systemd[578]: Reloading finished in 105 ms.2623machine # [ 91.056164] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2624machine # [ 91.066505] systemd[578]: Stopped Run user-specific NixOS activation.2625machine # [ 91.069075] systemd[578]: Stopping Run user-specific NixOS activation...2626machine # [ 91.072709] systemd[578]: Starting Run user-specific NixOS activation...2627machine # [ 91.104222] systemd[578]: Finished Run user-specific NixOS activation.2628machine # [ 91.108419] systemd[1]: Stopped target Reactivate sysinit units.2629machine # [ 91.110465] systemd[1]: Stopping Reactivate sysinit units...2630machine # [ 91.111360] systemd[1]: Reached target Reactivate sysinit units.2631machine # [ 91.115819] systemd[1]: Reloading test.service...2632machine # [ 91.141555] systemd[1]: Reloaded test.service.2633machine # [ 91.146866] systemd[1]: Reached target Remote File Systems.2634machine # [ 91.149712] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2635machine # [ 91.151196] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2636machine # [ 91.156640] systemd[1]: Reached target Local File Systems.2637machine # [ 91.160491] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2638machine # [ 91.164411] systemd[1]: Starting Create SUID/SGID Wrappers...2639machine # [ 91.165298] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2640machine # [ 91.166711] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672641machine # [ 91.177459] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2642machine # [ 91.179124] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2643machine # [ 91.182056] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2644machine # [ 91.342053] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2645machine # [ 91.343876] systemd[1]: Finished Create SUID/SGID Wrappers.2646machine # [ 91.349335] systemd[1]: Starting linger-users.service...2647machine # [ 91.390121] systemd[1]: linger-users.service: Deactivated successfully.2648machine # [ 91.393342] systemd[1]: Finished linger-users.service.2649machine # [ 91.647696] nixos[6311]: finished switching to system configuration /nix/store/vrqyzkkrfnmnycy520kxkf7hdbg72r11-nixos-system-machine-test2650machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.88 seconds)2651machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&12652machine # [ 91.880844] nixos[6453]: switching to system configuration /nix/store/vx89qxq069nin4xnl4rzfq099qjy9px5-nixos-system-machine-test2653machine # [ 91.883569] systemd[1]: Stopped target Remote File Systems.2654machine # [ 91.887062] systemd[1]: Stopped target Local File Systems.2655machine # [ 92.174553] systemd[1]: Reload requested from client PID 6453 ('.switch-to-conf') (unit backdoor.service)...2656machine # [ 92.176951] systemd[1]: Reloading...2657machine # [ 92.495481] systemd[1]: Reloading finished in 316 ms.2658machine # [ 92.579304] systemd[578]: Reexecution requested from client PID 6522 ('switch-to-confi')...2659machine # [ 92.583652] systemd[578]: Reexecuting.2660machine # [ 92.631101] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2661machine # [ 92.739468] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2662machine # [ 92.746250] systemd[578]: Reload requested from client PID 6522 ('switch-to-confi')...2663machine # [ 92.748724] systemd[578]: Reloading...2664machine # [ 92.853204] systemd[578]: Reloading finished in 103 ms.2665machine # [ 92.868172] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2666machine # [ 92.877768] systemd[578]: Stopped Run user-specific NixOS activation.2667machine # [ 92.880258] systemd[578]: Stopping Run user-specific NixOS activation...2668machine # [ 92.882437] systemd[578]: Starting Run user-specific NixOS activation...2669machine # [ 92.914910] systemd[578]: Finished Run user-specific NixOS activation.2670machine # [ 92.918750] systemd[1]: Stopped target Reactivate sysinit units.2671machine # [ 92.920808] systemd[1]: Stopping Reactivate sysinit units...2672machine # [ 92.921673] systemd[1]: Reached target Reactivate sysinit units.2673machine # [ 92.924438] systemd[1]: test.service: Deactivated successfully.2674machine # [ 92.925341] systemd[1]: Stopped test.service.2675machine # [ 92.926012] systemd[1]: Stopping test.service...2676machine # [ 92.929539] systemd[1]: Starting test.service...2677machine # [ 92.952522] systemd[1]: Finished test.service.2678machine # [ 92.958145] systemd[1]: Reached target Local File Systems.2679machine # [ 92.963269] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2680machine # [ 92.971069] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2681machine # [ 92.976693] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2682machine # [ 92.978315] systemd[1]: Starting Create SUID/SGID Wrappers...2683machine # [ 92.979206] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2684machine # [ 92.984911] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672685machine # [ 92.987214] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2686machine # [ 92.990721] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2687machine # [ 92.992791] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2688machine # [ 92.994538] systemd[1]: Reached target Remote File Systems.2689machine # [ 93.145673] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2690machine # [ 93.151100] systemd[1]: Finished Create SUID/SGID Wrappers.2691machine # [ 93.153405] systemd[1]: Starting linger-users.service...2692machine # [ 93.191938] systemd[1]: linger-users.service: Deactivated successfully.2693machine # [ 93.194850] systemd[1]: Finished linger-users.service.2694machine # [ 93.450240] nixos[6453]: finished switching to system configuration /nix/store/vx89qxq069nin4xnl4rzfq099qjy9px5-nixos-system-machine-test2695machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.80 seconds)2696machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&12697machine # [ 93.667524] nixos[6595]: switching to system configuration /nix/store/49i6wzl53bpbrnins2iwyak4xfas6nn9-nixos-system-machine-test2698machine # [ 93.673222] systemd[1]: Stopped target Local File Systems.2699machine # [ 93.674115] systemd[1]: Stopped target Remote File Systems.2700machine # [ 93.952475] systemd[1]: Reload requested from client PID 6595 ('.switch-to-conf') (unit backdoor.service)...2701machine # [ 93.954632] systemd[1]: Reloading...2702machine # [ 94.301999] systemd[1]: Reloading finished in 345 ms.2703machine # [ 94.393715] systemd[578]: Reexecution requested from client PID 6664 ('switch-to-confi')...2704machine # [ 94.398428] systemd[578]: Reexecuting.2705machine # [ 94.459621] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2706machine # [ 94.580162] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2707machine # [ 94.587232] systemd[578]: Reload requested from client PID 6664 ('switch-to-confi')...2708machine # [ 94.591259] systemd[578]: Reloading...2709machine # [ 94.695514] systemd[578]: Reloading finished in 105 ms.2710machine # [ 94.712191] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2711machine # [ 94.723012] systemd[578]: Stopped Run user-specific NixOS activation.2712machine # [ 94.725484] systemd[578]: Stopping Run user-specific NixOS activation...2713machine # [ 94.727830] systemd[578]: Starting Run user-specific NixOS activation...2714machine # [ 94.762783] systemd[578]: Finished Run user-specific NixOS activation.2715machine # [ 94.769020] systemd[1]: Stopped target Reactivate sysinit units.2716machine # [ 94.770311] systemd[1]: Stopping Reactivate sysinit units...2717machine # [ 94.771404] systemd[1]: Reached target Reactivate sysinit units.2718machine # [ 94.777173] systemd[1]: Reached target Remote File Systems.2719machine # [ 94.781222] systemd[1]: Starting linger-users.service...2720machine # [ 94.796915] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2721machine # [ 94.798573] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2722machine # [ 94.811379] systemd[1]: Reached target Local File Systems.2723machine # [ 94.818594] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2724machine # [ 94.824255] systemd[1]: Starting Create SUID/SGID Wrappers...2725machine # [ 94.825232] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2726machine # [ 94.826587] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672727machine # [ 94.838266] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2728machine # [ 94.843991] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2729machine # [ 94.852645] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2730machine # [ 94.891248] systemd[1]: linger-users.service: Deactivated successfully.2731machine # [ 94.894961] systemd[1]: Finished linger-users.service.2732machine # [ 95.027041] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2733machine # [ 95.030652] systemd[1]: Finished Create SUID/SGID Wrappers.2734machine # [ 95.285269] nixos[6595]: finished switching to system configuration /nix/store/49i6wzl53bpbrnins2iwyak4xfas6nn9-nixos-system-machine-test2735machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.83 seconds)2736(finished: subtest: unit file parser, in 24.23 seconds)2737subtest: restart and reload by activation script2738machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&12739machine # [ 95.486792] nixos[6735]: switching to system configuration /nix/store/mdgh5kkm1h4krzkf966x6qsr6n4hs0mz-nixos-system-machine-test2740machine # [ 95.489452] systemd[1]: Stopped target Local File Systems.2741machine # [ 95.491826] systemd[1]: Stopped target Remote File Systems.2742machine # [ 95.773931] systemd[1]: Reload requested from client PID 6735 ('.switch-to-conf') (unit backdoor.service)...2743machine # [ 95.776215] systemd[1]: Reloading...2744machine # [ 96.104368] systemd[1]: Reloading finished in 326 ms.2745machine # [ 96.197360] systemd[578]: Reexecution requested from client PID 6804 ('switch-to-confi')...2746machine # [ 96.202246] systemd[578]: Reexecuting.2747machine # [ 96.255563] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2748machine # [ 96.369554] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2749machine # [ 96.377223] systemd[578]: Reload requested from client PID 6804 ('switch-to-confi')...2750machine # [ 96.381002] systemd[578]: Reloading...2751machine # [ 96.486396] systemd[578]: Reloading finished in 106 ms.2752machine # [ 96.504200] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2753machine # [ 96.515389] systemd[578]: Stopped Run user-specific NixOS activation.2754machine # [ 96.518493] systemd[578]: Stopping Run user-specific NixOS activation...2755machine # [ 96.520843] systemd[578]: Starting Run user-specific NixOS activation...2756machine # [ 96.556908] systemd[578]: Finished Run user-specific NixOS activation.2757machine # [ 96.561813] systemd[1]: Stopped target Reactivate sysinit units.2758machine # [ 96.566047] systemd[1]: Stopping Reactivate sysinit units...2759machine # [ 96.567049] systemd[1]: Reached target Reactivate sysinit units.2760machine # [ 96.567997] systemd[1]: Reached target Remote File Systems.2761machine # [ 96.575954] systemd[1]: Starting linger-users.service...2762machine # [ 96.589751] systemd[1]: Reached target Local File Systems.2763machine # [ 96.590922] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2764machine # [ 96.605075] systemd[1]: Starting Create SUID/SGID Wrappers...2765machine # [ 96.606136] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2766machine # [ 96.607443] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672767machine # [ 96.622237] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2768machine # [ 96.627905] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2769machine # [ 96.633179] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2770machine # [ 96.634676] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2771machine # [ 96.635937] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2772machine # [ 96.678318] systemd[1]: linger-users.service: Deactivated successfully.2773machine # [ 96.681042] systemd[1]: Finished linger-users.service.2774machine # [ 96.819644] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2775machine # [ 96.822922] systemd[1]: Finished Create SUID/SGID Wrappers.2776machine # [ 97.079389] nixos[6735]: finished switching to system configuration /nix/store/mdgh5kkm1h4krzkf966x6qsr6n4hs0mz-nixos-system-machine-test2777machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.80 seconds)2778machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12779machine # [ 97.340905] nixos[6875]: switching to system configuration /nix/store/imrgpfbaq32r5pfh3bibpb79238273pz-nixos-system-machine-test2780machine # [ 97.344111] systemd[1]: test.service: Deactivated successfully.2781machine # [ 97.348720] systemd[1]: Stopped test.service.2782machine # [ 97.350275] systemd[1]: Stopped target Remote File Systems.2783machine # [ 97.351108] systemd[1]: Stopped target Local File Systems.2784machine # [ 97.666525] systemd[1]: Reload requested from client PID 6875 ('.switch-to-conf') (unit backdoor.service)...2785machine # [ 97.668693] systemd[1]: Reloading...2786machine # [ 98.006122] systemd[1]: Reloading finished in 335 ms.2787machine # [ 98.094805] systemd[578]: Reexecution requested from client PID 6946 ('switch-to-confi')...2788machine # [ 98.099133] systemd[578]: Reexecuting.2789machine # [ 98.155380] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2790machine # [ 98.272723] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2791machine # [ 98.280142] systemd[578]: Reload requested from client PID 6946 ('switch-to-confi')...2792machine # [ 98.281571] systemd[578]: Reloading...2793machine # [ 98.391279] systemd[578]: Reloading finished in 107 ms.2794machine # [ 98.408191] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2795machine # [ 98.419869] systemd[578]: Stopped Run user-specific NixOS activation.2796machine # [ 98.422626] systemd[578]: Stopping Run user-specific NixOS activation...2797machine # [ 98.424792] systemd[578]: Starting Run user-specific NixOS activation...2798machine # [ 98.456741] systemd[578]: Finished Run user-specific NixOS activation.2799machine # [ 98.460954] systemd[1]: Stopped target Reactivate sysinit units.2800machine # [ 98.463009] systemd[1]: Stopping Reactivate sysinit units...2801machine # [ 98.463945] systemd[1]: Reached target Reactivate sysinit units.2802machine # [ 98.470381] systemd[1]: Created slice Slice /system/templated-simple-service.2803machine # [ 98.474966] systemd[1]: Starting templated-simple-service@instance.service...2804machine # [ 98.481397] systemd[1]: Created slice Slice /system/templated-reload-triggers.2805machine # [ 98.483844] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart.2806machine # [ 98.487386] systemd[1]: Reached target Remote File Systems.2807machine # [ 98.495108] systemd[1]: Starting linger-users.service...2808machine # [ 98.499651] systemd[1]: Starting reload-triggers-and-restart.service...2809machine # [ 98.510558] systemd[1]: Starting reload-triggers.service...2810machine # [ 98.523632] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2811machine # [ 98.541635] systemd[1]: Starting templated-reload-triggers@instance.service...2812machine # [ 98.542909] systemd[1]: Starting simple-reload-service.service...2813machine # [ 98.571026] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2814machine # [ 98.591100] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2815machine # [ 98.611015] systemd[1]: Starting simple-service.service...2816machine # [ 98.611939] systemd[1]: Starting simple-restart-service.service...2817machine # [ 98.653429] systemd[1]: Starting no-restart-service.service...2818machine # [ 98.654514] systemd[1]: Created slice Slice /system/templated-simple-reload-service.2819machine # [ 98.655844] systemd[1]: Starting templated-simple-reload-service@instance.service...2820machine # [ 98.705158] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as.2821machine # [ 98.732866] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2822machine # [ 98.734298] systemd[1]: Reached target Local File Systems.2823machine # [ 98.735295] systemd[1]: Finished templated-simple-service@instance.service.2824machine # [ 98.789039] systemd[1]: Created slice Slice /system/templated-no-restart-service.2825machine # [ 98.815065] systemd[1]: Starting templated-no-restart-service@instance.service...2826machine # [ 98.834281] systemd[1]: Finished reload-triggers-and-restart.service.2827machine # [ 98.846377] systemd[1]: Finished reload-triggers.service.2828machine # [ 98.854068] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2829machine # [ 98.855782] systemd[1]: Starting Create SUID/SGID Wrappers...2830machine # [ 98.872358] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2831machine # [ 98.873769] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672832machine # [ 98.888509] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2833machine # [ 98.890318] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2834machine # [ 98.891670] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2835machine # [ 98.904735] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2836machine # [ 98.906016] systemd[1]: Created slice Slice /system/templated-simple-restart-service.2837machine # [ 98.907113] systemd[1]: Finished simple-reload-service.service.2838machine # [ 98.907950] systemd[1]: Finished templated-reload-triggers@instance.service.2839machine # [ 98.910710] systemd[1]: Finished no-restart-service.service.2840machine # [ 98.913069] systemd[1]: Finished simple-service.service.2841machine # [ 98.913975] systemd[1]: Finished simple-restart-service.service.2842machine # [ 98.914853] systemd[1]: Finished templated-simple-reload-service@instance.service.2843machine # [ 98.915918] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2844machine # [ 98.918611] systemd[1]: Finished templated-no-restart-service@instance.service.2845machine # [ 98.920850] systemd[1]: linger-users.service: Deactivated successfully.2846machine # [ 98.923303] systemd[1]: Finished linger-users.service.2847machine # [ 99.058762] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2848machine # [ 99.063890] systemd[1]: Finished Create SUID/SGID Wrappers.2849machine # [ 99.067681] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2850machine # [ 99.070865] systemd[1]: Starting templated-simple-restart-service@instance.service...2851machine # [ 99.110295] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2852machine # [ 99.113204] systemd[1]: Finished templated-simple-restart-service@instance.service.2853machine # [ 99.370215] nixos[6875]: finished switching to system configuration /nix/store/imrgpfbaq32r5pfh3bibpb79238273pz-nixos-system-machine-test2854machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.29 seconds)2855machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12856machine # [ 99.640438] nixos[7045]: switching to system configuration /nix/store/imrgpfbaq32r5pfh3bibpb79238273pz-nixos-system-machine-test2857machine # [ 99.643496] systemd[1]: Stopped target Remote File Systems.2858machine # [ 99.646606] systemd[1]: Stopped target Local File Systems.2859machine # [ 99.961189] systemd[1]: Reload requested from client PID 7045 ('.switch-to-conf') (unit backdoor.service)...2860machine # [ 99.963289] systemd[1]: Reloading...2861machine # [ 100.305290] systemd[1]: Reloading finished in 340 ms.2862machine # [ 100.396435] systemd[578]: Reexecution requested from client PID 7116 ('switch-to-confi')...2863machine # [ 100.399391] systemd[578]: Reexecuting.2864machine # [ 100.459872] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2865machine # [ 100.577865] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2866machine # [ 100.585662] systemd[578]: Reload requested from client PID 7116 ('switch-to-confi')...2867machine # [ 100.589768] systemd[578]: Reloading...2868machine # [ 100.702251] systemd[578]: Reloading finished in 111 ms.2869machine # [ 100.716271] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2870machine # [ 100.727766] systemd[578]: Stopped Run user-specific NixOS activation.2871machine # [ 100.730459] systemd[578]: Stopping Run user-specific NixOS activation...2872machine # [ 100.732752] systemd[578]: Starting Run user-specific NixOS activation...2873machine # [ 100.765612] systemd[578]: Finished Run user-specific NixOS activation.2874machine # [ 100.769762] systemd[1]: Stopped target Reactivate sysinit units.2875machine # [ 100.772767] systemd[1]: Stopping Reactivate sysinit units...2876machine # [ 100.773725] systemd[1]: Reached target Reactivate sysinit units.2877machine # [ 100.779314] systemd[1]: Reloading reload-triggers-and-restart.service...2878machine # [ 100.793656] systemd[1]: Reloading reload-triggers.service...2879machine # [ 100.798430] systemd[1]: Reloading simple-reload-service.service...2880machine # [ 100.813951] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service...2881machine # [ 100.828786] systemd[1]: Reloading templated-reload-triggers@instance.service...2882machine # [ 100.830109] systemd[1]: Reloading templated-simple-reload-service@instance.service...2883machine # [ 100.874173] systemd[1]: Reloaded reload-triggers.service.2884machine # [ 100.881291] systemd[1]: Reloaded reload-triggers-and-restart.service.2885machine # [ 100.886970] systemd[1]: Reloaded simple-reload-service.service.2886machine # [ 100.913125] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service.2887machine # [ 100.916780] systemd[1]: Reloaded templated-reload-triggers@instance.service.2888machine # [ 100.918103] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2889machine # [ 100.923222] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2890machine # [ 100.928644] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2891machine # [ 100.929687] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2892machine # [ 100.930707] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2893machine # [ 100.931690] systemd[1]: simple-restart-service.service: Deactivated successfully.2894machine # [ 100.947309] systemd[1]: Stopped simple-restart-service.service.2895machine # [ 100.962458] systemd[1]: Stopping simple-restart-service.service...2896machine # [ 100.963440] systemd[1]: Starting simple-restart-service.service...2897machine # [ 100.973472] systemd[1]: simple-service.service: Deactivated successfully.2898machine # [ 100.974649] systemd[1]: Stopped simple-service.service.2899machine # [ 100.975586] systemd[1]: Stopping simple-service.service...2900machine # [ 100.996926] systemd[1]: Starting simple-service.service...2901machine # [ 100.998012] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2902machine # [ 100.999485] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2903machine # [ 101.026861] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2904machine # [ 101.040218] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2905machine # [ 101.041558] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2906machine # [ 101.042825] systemd[1]: Stopped templated-simple-restart-service@instance.service.2907machine # [ 101.043879] systemd[1]: Stopping templated-simple-restart-service@instance.service...2908machine # [ 101.066456] systemd[1]: Starting templated-simple-restart-service@instance.service...2909machine # [ 101.068443] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2910machine # [ 101.070170] systemd[1]: Stopped templated-simple-service@instance.service.2911machine # [ 101.071969] systemd[1]: Stopping templated-simple-service@instance.service...2912machine # [ 101.074780] systemd[1]: Starting templated-simple-service@instance.service...2913machine # [ 101.075926] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2914machine # [ 101.086187] systemd[1]: Finished simple-restart-service.service.2915machine # [ 101.087105] systemd[1]: Finished simple-service.service.2916machine # [ 101.087886] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2917machine # [ 101.097002] systemd[1]: Finished templated-simple-restart-service@instance.service.2918machine # [ 101.098225] systemd[1]: Finished templated-simple-service@instance.service.2919machine # [ 101.099199] systemd[1]: Reached target Local File Systems.2920machine # [ 101.099994] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2921machine # [ 101.109905] systemd[1]: Starting Create SUID/SGID Wrappers...2922machine # [ 101.110776] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2923machine # [ 101.112980] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672924machine # [ 101.115770] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2925machine # [ 101.119836] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2926machine # [ 101.121510] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2927machine # [ 101.122764] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2928machine # [ 101.124555] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2929machine # [ 101.126254] systemd[1]: Reached target Remote File Systems.2930machine # [ 101.276267] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2931machine # [ 101.280781] systemd[1]: Finished Create SUID/SGID Wrappers.2932machine # [ 101.283001] systemd[1]: Starting linger-users.service...2933machine # [ 101.325941] systemd[1]: linger-users.service: Deactivated successfully.2934machine # [ 101.328884] systemd[1]: Finished linger-users.service.2935machine # [ 101.584593] nixos[7045]: finished switching to system configuration /nix/store/imrgpfbaq32r5pfh3bibpb79238273pz-nixos-system-machine-test2936machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.21 seconds)2937machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&12938machine # [ 101.869329] nixos[7211]: switching to system configuration /nix/store/rzpsm3cxcc99kq26fpkl018d6rj659h0-nixos-system-machine-test2939machine # [ 101.871906] systemd[1]: Stopped target Local File Systems.2940machine # [ 101.874321] systemd[1]: Stopped target Remote File Systems.2941machine # [ 102.182209] systemd[1]: Reload requested from client PID 7211 ('.switch-to-conf') (unit backdoor.service)...2942machine # [ 102.184261] systemd[1]: Reloading...2943machine # [ 102.526002] systemd[1]: Reloading finished in 339 ms.2944machine # [ 102.620142] systemd[578]: Reexecution requested from client PID 7282 ('switch-to-confi')...2945machine # [ 102.624633] systemd[578]: Reexecuting.2946machine # [ 102.679514] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2947machine # [ 102.795569] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2948machine # [ 102.802419] systemd[578]: Reload requested from client PID 7282 ('switch-to-confi')...2949machine # [ 102.806410] systemd[578]: Reloading...2950machine # [ 102.913462] systemd[578]: Reloading finished in 108 ms.2951machine # [ 102.928198] systemd[578]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2952machine # [ 102.939218] systemd[578]: Stopped Run user-specific NixOS activation.2953machine # [ 102.942031] systemd[578]: Stopping Run user-specific NixOS activation...2954machine # [ 102.944650] systemd[578]: Starting Run user-specific NixOS activation...2955machine # [ 102.976619] systemd[578]: Finished Run user-specific NixOS activation.2956machine # [ 102.980917] systemd[1]: Stopped target Reactivate sysinit units.2957machine # [ 102.986535] systemd[1]: Stopping Reactivate sysinit units...2958machine # [ 102.987519] systemd[1]: Reached target Reactivate sysinit units.2959machine # [ 102.990704] systemd[1]: Reloading reload-triggers.service...2960machine # [ 103.000359] systemd[1]: Reloading simple-reload-service.service...2961machine # [ 103.016120] systemd[1]: Reloading templated-reload-triggers@instance.service...2962machine # [ 103.025114] systemd[1]: Reloading templated-simple-reload-service@instance.service...2963machine # [ 103.062395] systemd[1]: Reloaded reload-triggers.service.2964machine # [ 103.070048] systemd[1]: Reloaded simple-reload-service.service.2965machine # [ 103.085395] systemd[1]: Reloaded templated-reload-triggers@instance.service.2966machine # [ 103.089591] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2967machine # [ 103.092341] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2968machine # [ 103.093671] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2969machine # [ 103.094760] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2970machine # [ 103.102384] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2971machine # [ 103.103552] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully.2972machine # [ 103.112432] systemd[1]: Stopped reload-triggers-and-restart.service.2973machine # [ 103.113437] systemd[1]: Stopping reload-triggers-and-restart.service...2974machine # [ 103.114399] systemd[1]: Starting reload-triggers-and-restart.service...2975machine # [ 103.115327] systemd[1]: simple-restart-service.service: Deactivated successfully.2976machine # [ 103.129687] systemd[1]: Stopped simple-restart-service.service.2977machine # [ 103.130706] systemd[1]: Stopping simple-restart-service.service...2978machine # [ 103.131612] systemd[1]: Starting simple-restart-service.service...2979machine # [ 103.160465] systemd[1]: simple-service.service: Deactivated successfully.2980machine # [ 103.161593] systemd[1]: Stopped simple-service.service.2981machine # [ 103.162634] systemd[1]: Stopping simple-service.service...2982machine # [ 103.163599] systemd[1]: Starting simple-service.service...2983machine # [ 103.199405] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2984machine # [ 103.215582] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2985machine # [ 103.231457] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2986machine # [ 103.244615] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2987machine # [ 103.258083] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully.2988machine # [ 103.259619] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service.2989machine # [ 103.282012] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service...2990machine # [ 103.283579] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2991machine # [ 103.291260] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2992machine # [ 103.295603] systemd[1]: Stopped templated-simple-restart-service@instance.service.2993machine # [ 103.300811] systemd[1]: Stopping templated-simple-restart-service@instance.service...2994machine # [ 103.302086] systemd[1]: Starting templated-simple-restart-service@instance.service...2995machine # [ 103.303176] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2996machine # [ 103.305986] systemd[1]: Stopped templated-simple-service@instance.service.2997machine # [ 103.307057] systemd[1]: Stopping templated-simple-service@instance.service...2998machine # [ 103.317763] systemd[1]: Starting templated-simple-service@instance.service...2999machine # [ 103.319007] systemd[1]: Finished simple-restart-service.service.3000machine # [ 103.319895] systemd[1]: Finished reload-triggers-and-restart.service.3001machine # [ 103.330639] systemd[1]: Finished reload-triggers-and-restart-by-as.service.3002machine # [ 103.331806] systemd[1]: Finished simple-service.service.3003machine # [ 103.337356] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.3004machine # [ 103.338817] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.3005machine # [ 103.340203] systemd[1]: Finished templated-simple-restart-service@instance.service.3006machine # [ 103.341325] systemd[1]: Finished templated-simple-service@instance.service.3007machine # [ 103.342449] systemd[1]: Reached target Local File Systems.3008machine # [ 103.343275] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore3009machine # [ 103.345828] systemd[1]: Starting Create SUID/SGID Wrappers...3010machine # [ 103.347690] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.3011machine # [ 103.351162] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc673012machine # [ 103.354428] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore3013machine # [ 103.358726] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3014machine # [ 103.363297] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3015machine # [ 103.364982] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os3016machine # [ 103.366675] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki3017machine # [ 103.368322] systemd[1]: Reached target Remote File Systems.3018machine # [ 103.511875] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.3019machine # [ 103.515244] systemd[1]: Finished Create SUID/SGID Wrappers.3020machine # [ 103.519856] systemd[1]: Starting linger-users.service...3021machine # [ 103.562975] systemd[1]: linger-users.service: Deactivated successfully.3022machine # [ 103.566062] systemd[1]: Finished linger-users.service.3023machine # [ 103.821729] nixos[7211]: finished switching to system configuration /nix/store/rzpsm3cxcc99kq26fpkl018d6rj659h0-nixos-system-machine-test3024machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.24 seconds)3025machine: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&13026machine: (finished: must succeed: /nix/store/3a8b0v5cbazr3k5wwbn68askaic4prw0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.35 seconds)3027(finished: subtest: restart and reload by activation script, in 8.89 seconds)3028(finished: run the VM test script, in 104.92 seconds)3029test script finished in 104.97s3030cleanup3031kill QemuMachine (pid 45)3032machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lq2fsnmg0q3y0vlxn91w8s8wvj1m6fld-python3-3.14.8/bin/python3.14)3033machine # [2026-10-21T03:02:29Z INFO virtiofsd] Client disconnected, shutting down3034machine # [2026-10-21T03:02:29Z INFO virtiofsd] Client disconnected, shutting down3035machine # [2026-10-21T03:02:29Z INFO virtiofsd] Client disconnected, shutting down3036(finished: cleanup, in 0.16 seconds)3037additionally exposed symbols:3038 machine, other,3039 vlan1,3040 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