vm-test-run-switch-test-services
checks.aarch64-linux.switchTest
· build #56
· 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 # Disk image does not exist, creating the virtualisation disk image...11machine: QEMU running (pid 45)12machine # Formatting '/build/vm-state-machine/tmp.I8CO0IfISN', 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: 2f4c355d-c499-4507-bb34-03136a09c55217machine # 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-14T03:13:54Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)28machine # [2026-10-14T03:13:54Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether29machine # [2026-10-14T03:13:54Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)30machine # [2026-10-14T03:13:54Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether31machine # [2026-10-14T03:13:54Z INFO virtiofsd] Waiting for vhost-user socket connection...32machine # [2026-10-14T03:13:54Z INFO virtiofsd] Waiting for vhost-user socket connection...33machine # [2026-10-14T03:13:54Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)34machine # [2026-10-14T03:13:54Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether35machine # [2026-10-14T03:13:54Z INFO virtiofsd] Waiting for vhost-user socket connection...36machine # [2026-10-14T03:13:54Z INFO virtiofsd] Client connected, servicing requests37machine # [2026-10-14T03:13:54Z INFO virtiofsd] Client connected, servicing requests38machine # [2026-10-14T03:13:54Z INFO virtiofsd] Client connected, servicing requests39machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]40machine # [ 0.000000] Linux version 6.18.55 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Sat Oct 3 10:39:03 UTC 202641machine # [ 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 s186840 r8192 d116264 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/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/init regInfo=/nix/.ro-store/ici2f5s61h9mg1dgs393ipg2y284ws0n-closure-info/registration console=ttyAMA0,115200n8 console=tty074machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/ici2f5s61h9mg1dgs393ipg2y284ws0n-closure-info/registration", will be passed to user space.75machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 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 75039 entries in 294 pages88machine # [ 0.000000] ftrace: allocated 294 pages with 4 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=384 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 @44cf0000 (indirect, esz 8, psz 64K, shr 1)109machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)110machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000111machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000112machine # [ 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.000036] arm-pv: using stolen time PV118machine # [ 0.000570] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)119machine # [ 0.000773] Console: colour dummy device 80x25120machine # [ 0.000782] printk: legacy console [tty0] enabled121machine # [ 0.000973] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)122machine # [ 0.000980] pid_max: default: 32768 minimum: 301123machine # [ 0.001066] LSM: initializing lsm=capability,landlock,yama,bpf,ima124machine # [ 0.001244] landlock: Up and running.125machine # [ 0.001248] Yama: becoming mindful.126machine # [ 0.001817] LSM support for eBPF active127machine # [ 0.001957] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)128machine # [ 0.001978] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)129machine # [ 0.004138] rcu: Hierarchical SRCU implementation.130machine # [ 0.004145] rcu: Max phase no-delay instances is 1000.131machine # [ 0.005529] fsl-mc MSI: its@8080000 domain created132machine # [ 0.005657] EFI services will not be available.133machine # [ 0.005758] smp: Bringing up secondary CPUs ...134machine # [ 0.005769] smp: Brought up 1 node, 1 CPU135machine # [ 0.005772] SMP: Total of 1 processors activated.136machine # [ 0.005775] CPU: All CPU(s) started at EL1137machine # [ 0.005790] CPU features: detected: Branch Target Identification138machine # [ 0.005798] CPU features: detected: ARMv8.4 Translation Table Level139machine # [ 0.005801] CPU features: detected: Instruction cache invalidation not required for I/D coherence140machine # [ 0.005804] CPU features: detected: Data cache clean to the PoU not required for I/D coherence141machine # [ 0.005808] CPU features: detected: Common not Private translations142machine # [ 0.005812] CPU features: detected: CRC32 instructions143machine # [ 0.005815] CPU features: detected: Data cache clean to Point of Deep Persistence144machine # [ 0.005818] CPU features: detected: Data cache clean to Point of Persistence145machine # [ 0.005821] CPU features: detected: Data independent timing control (DIT)146machine # [ 0.005825] CPU features: detected: E0PD147machine # [ 0.005827] CPU features: detected: Enhanced Counter Virtualization148machine # [ 0.005830] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)149machine # [ 0.005834] CPU features: detected: Enhanced Virtualization Traps150machine # [ 0.005837] CPU features: detected: Fine Grained Traps151machine # [ 0.005848] CPU features: detected: Generic authentication (architected QARMA5 algorithm)152machine # [ 0.005855] CPU features: detected: RCpc load-acquire (LDAPR)153machine # [ 0.005858] CPU features: detected: LSE atomic instructions154machine # [ 0.005861] CPU features: detected: Privileged Access Never155machine # [ 0.005864] CPU features: detected: PMUv3156machine # [ 0.005866] CPU features: detected: RAS Extension Support157machine # [ 0.005869] CPU features: detected: RASv1p1 Extension Support158machine # [ 0.005872] CPU features: detected: Random Number Generator159machine # [ 0.005874] CPU features: detected: Speculation barrier (SB)160machine # [ 0.005877] CPU features: detected: Stage-2 Force Write-Back161machine # [ 0.005880] CPU features: detected: TLB range maintenance instructions162machine # [ 0.005885] CPU features: detected: Speculative Store Bypassing Safe (SSBS)163machine # [ 0.005926] alternatives: applying system-wide alternatives164machine # [ 0.009173] CPU features: detected: BBM Level 2 without TLB conflict abort165machine # [ 0.009373] Memory: 892884K/1048576K available (24576K kernel code, 7094K rwdata, 26568K rodata, 4736K init, 1106K bss, 114372K reserved, 32768K cma-reserved)166machine # [ 0.009838] devtmpfs: initialized167machine # [ 0.011734] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)168machine # [ 0.011762] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).169machine # [ 0.011970] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL170machine # [ 0.011979] 0 pages in range for non-PLT usage171machine # [ 0.011980] 508192 pages in range for PLT usage172machine # [ 0.012102] pinctrl core: initialized pinctrl subsystem173machine # [ 0.013024] DMI not present or invalid.174machine # [ 0.017058] NET: Registered PF_NETLINK/PF_ROUTE protocol family175machine # [ 0.019548] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations176machine # [ 0.019711] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations177machine # [ 0.019869] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations178machine # [ 0.019894] audit: initializing netlink subsys (disabled)179machine # [ 0.020481] thermal_sys: Registered thermal governor 'fair_share'180machine # [ 0.020483] thermal_sys: Registered thermal governor 'bang_bang'181machine # [ 0.020486] thermal_sys: Registered thermal governor 'step_wise'182machine # [ 0.020489] thermal_sys: Registered thermal governor 'user_space'183machine # [ 0.020491] thermal_sys: Registered thermal governor 'power_allocator'184machine # [ 0.020522] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1185machine # [ 0.020532] cpuidle: using governor ladder186machine # [ 0.020539] cpuidle: using governor menu187machine # [ 0.020747] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.188machine # [ 0.020770] ASID allocator initialised with 65536 entries189machine # [ 0.022165] Serial: AMBA PL011 UART driver190machine # [ 0.028220] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1191machine # [ 0.028388] printk: console [ttyAMA0] enabled192machine # [ 0.162204] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages193machine # [ 0.162215] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page194machine # [ 0.162218] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages195machine # [ 0.162221] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page196machine # [ 0.162224] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages197machine # [ 0.162227] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page198machine # [ 0.162229] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages199machine # [ 0.162232] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page200machine # [ 0.163514] fbcon: Taking over console201machine # [ 0.163530] ACPI: Interpreter disabled.202machine # [ 0.172682] iommu: Default domain type: Translated203machine # [ 0.172688] iommu: DMA domain TLB invalidation policy: strict mode204machine # [ 0.173116] SCSI subsystem initialized205machine # [ 0.173327] usbcore: registered new interface driver usbfs206machine # [ 0.173358] usbcore: registered new interface driver hub207machine # [ 0.173375] usbcore: registered new device driver usb208machine # [ 0.173681] pps_core: LinuxPPS API ver. 1 registered209machine # [ 0.173685] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>210machine # [ 0.173693] PTP clock support registered211machine # [ 0.173746] EDAC MC: Ver: 3.0.0212machine # [ 0.183580] scmi_core: SCMI protocol bus registered213machine # [ 0.184059] FPGA manager framework214machine # [ 0.185814] vgaarb: loaded215machine # [ 0.186104] clocksource: Switched to clocksource arch_sys_counter216machine # [ 0.193755] VFS: Disk quotas dquot_6.6.0217machine # [ 0.193782] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)218machine # [ 0.197571] netfs: FS-Cache loaded219machine # [ 0.197714] pnp: PnP ACPI: disabled220machine # [ 0.202386] NET: Registered PF_INET protocol family221machine # [ 0.202552] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)222machine # [ 0.234001] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)223machine # [ 0.234046] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)224machine # [ 0.234069] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)225machine # [ 0.237499] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)226machine # [ 0.237575] TCP: Hash tables configured (established 8192 bind 8192)227machine # [ 0.237665] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)228machine # [ 0.237700] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)229machine # [ 0.237722] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)230machine # [ 0.237806] NET: Registered PF_UNIX/PF_LOCAL protocol family231machine # [ 0.237854] NET: Registered PF_XDP protocol family232machine # [ 0.237873] PCI: CLS 0 bytes, default 64233machine # [ 0.238144] Trying to unpack rootfs image as initramfs...234machine # [ 0.253383] kvm [1]: HYP mode not available235machine # [ 0.351941] Initialise system trusted keyrings236machine # [ 0.352096] workingset: timestamp_bits=42 max_order=18 bucket_order=0237machine # [ 0.352514] squashfs: version 4.0 (2009/01/31) Phillip Lougher238machine # [ 0.352561] 9p: Installing v9fs 9p2000 file system support239machine # [ 0.380794] Key type asymmetric registered240machine # [ 0.380812] Asymmetric key parser 'x509' registered241machine # [ 0.380900] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)242machine # [ 0.381043] io scheduler mq-deadline registered243machine # [ 0.381048] io scheduler kyber registered244machine # [ 0.394280] pl061_gpio 9030000.pl061: PL061 GPIO chip registered245machine # [ 0.395002] ledtrig-cpu: registered to indicate activity on CPUs246machine # [ 0.395443] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:247machine # [ 0.395460] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000248machine # [ 0.395470] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000249machine # [ 0.395476] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000250machine # [ 0.395502] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits251machine # [ 0.395526] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]252machine # [ 0.395603] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00253machine # [ 0.395611] pci_bus 0000:00: root bus resource [bus 00-ff]254machine # [ 0.395615] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]255machine # [ 0.395618] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]256machine # [ 0.395621] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]257machine # [ 0.395705] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint258machine # [ 0.396180] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint259machine # [ 0.396376] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]260machine # [ 0.396388] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]261machine # [ 0.396414] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]262machine # [ 0.396426] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]263machine # [ 0.396904] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint264machine # [ 0.397092] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]265machine # [ 0.397104] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]266machine # [ 0.397132] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]267machine # [ 0.397610] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint268machine # [ 0.397805] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]269machine # [ 0.397817] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]270machine # [ 0.397844] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]271machine # [ 0.430466] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint272machine # [ 0.430675] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]273machine # [ 0.430687] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]274machine # [ 0.430713] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]275machine # [ 0.430725] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]276machine # [ 0.431305] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint277machine # [ 0.431499] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]278machine # [ 0.431525] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]279machine # [ 0.432000] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint280machine # [ 0.432192] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]281machine # [ 0.432217] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]282machine # [ 0.432627] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint283machine # [ 0.432811] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]284machine # [ 0.433088] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint285machine # [ 0.433283] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]286machine # [ 0.433310] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]287machine # [ 0.433780] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint288machine # [ 0.433970] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]289machine # [ 0.433996] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]290machine # [ 0.451854] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint291machine # [ 0.452046] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]292machine # [ 0.452072] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]293machine # [ 0.452561] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint294machine # [ 0.452884] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]295machine # [ 0.452896] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]296machine # [ 0.452922] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]297machine # [ 0.453405] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint298machine # [ 0.453600] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]299machine # [ 0.453611] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]300machine # [ 0.453638] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]301machine # [ 0.470429] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned302machine # [ 0.470442] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned303machine # [ 0.470446] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned304machine # [ 0.470498] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned305machine # [ 0.470543] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned306machine # [ 0.470587] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned307machine # [ 0.470633] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned308machine # [ 0.470677] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned309machine # [ 0.470722] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned310machine # [ 0.470768] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned311machine # [ 0.470813] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned312machine # [ 0.470857] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned313machine # [ 0.470979] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned314machine # [ 0.471024] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned315machine # [ 0.471042] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned316machine # [ 0.471059] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned317machine # [ 0.471077] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned318machine # [ 0.471173] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned319machine # [ 0.471197] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned320machine # [ 0.471214] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned321machine # [ 0.471236] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned322machine # [ 0.471254] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned323machine # [ 0.471277] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned324machine # [ 0.471295] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned325machine # [ 0.471316] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned326machine # [ 0.471333] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned327machine # [ 0.471351] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned328machine # [ 0.471371] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned329machine # [ 0.471388] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned330machine # [ 0.471406] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned331machine # [ 0.471424] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned332machine # [ 0.471447] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]333machine # [ 0.471452] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]334machine # [ 0.471455] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]335machine # [ 0.472329] pci 0000:00:07.0: enabling device (0000 -> 0002)336machine # [ 0.525362] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)337machine # [ 0.535731] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)338machine # [ 0.537833] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)339machine # [ 0.541467] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)340machine # [ 0.551590] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)341machine # [ 0.553595] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)342machine # [ 0.557168] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)343machine # [ 0.567216] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)344machine # [ 0.569059] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)345machine # [ 0.572430] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)346machine # [ 0.582753] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)347machine # [ 0.588999] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled348machine # [ 0.591887] msm_serial: driver initialized349machine # [ 0.592044] SuperH (H)SCI(F) driver initialized350machine # [ 0.592104] STM32 USART driver initialized351machine # [ 0.629043] loop: module loaded352machine # [ 0.629252] virtio_blk virtio2: 1/0/0 default/read/poll queues353machine # [ 0.630099] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)354machine # [ 0.642249] megasas: 07.734.00.00-rc1355machine # [ 0.643115] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]356machine # [ 0.645000] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000357machine # [ 0.645016] Intel/Sharp Extended Query Table at 0x0031358machine # [ 0.650212] Using buffer write method359machine # [ 0.650245] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]360machine # [ 0.651619] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000361machine # [ 0.651633] Intel/Sharp Extended Query Table at 0x0031362machine # [ 0.652946] Using buffer write method363machine # [ 0.652962] Concatenating MTD devices:364machine # [ 0.652965] (0): "0.flash"365machine # [ 0.652967] (1): "0.flash"366machine # [ 0.652969] into device "0.flash"367machine # [ 0.966769] Freeing initrd memory: 27128K368machine # [ 0.972755] tun: Universal TUN/TAP device driver, 1.6369machine # [ 0.977303] thunder_xcv, ver 1.0370machine # [ 0.977333] thunder_bgx, ver 1.0371machine # [ 0.977352] nicpf, ver 1.0372machine # [ 0.977920] e1000: Intel(R) PRO/1000 Network Driver373machine # [ 0.977924] e1000: Copyright (c) 1999-2006 Intel Corporation.374machine # [ 0.977951] e1000e: Intel(R) PRO/1000 Network Driver375machine # [ 0.977957] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.376machine # [ 0.977982] igb: Intel(R) Gigabit Ethernet Network Driver377machine # [ 0.977985] igb: Copyright (c) 2007-2014 Intel Corporation.378machine # [ 0.978005] igbvf: Intel(R) Gigabit Virtual Function Network Driver379machine # [ 0.978009] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.380machine # [ 0.985236] sky2: driver version 1.30381machine # [ 0.987443] usbcore: registered new interface driver usb-storage382machine # [ 0.987535] usbcore: registered new interface driver usbserial_generic383machine # [ 0.987545] usbserial: USB Serial support registered for generic384machine # [ 0.988177] hv_vmbus: registering driver hyperv_keyboard385machine # [ 0.989488] ehci-pci 0000:00:07.0: EHCI Host Controller386machine # [ 0.989507] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1387machine # [ 0.989721] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000388machine # [ 0.990046] rtc-pl031 9010000.pl031: registered as rtc0389machine # [ 0.990074] rtc-pl031 9010000.pl031: setting system clock to 2026-10-14T03:13:55 UTC (1791947635)390machine # [ 0.997736] i2c_dev: i2c /dev entries driver391machine # [ 0.998150] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00392machine # [ 0.998536] hub 1-0:1.0: USB hub found393machine # [ 0.998554] hub 1-0:1.0: 6 ports detected394machine # [ 1.004350] sdhci: Secure Digital Host Controller Interface driver395machine # [ 1.004355] sdhci: Copyright(c) Pierre Ossman396machine # [ 1.004636] Synopsys Designware Multimedia Card Interface Driver397machine # [ 1.005014] sdhci-pltfm: SDHCI platform and OF driver helper398machine # [ 1.009571] hid: raw HID events driver (C) Jiri Kosina399machine # [ 1.009816] usbcore: registered new interface driver usbhid400machine # [ 1.009820] usbhid: USB HID core driver401machine # [ 1.012941] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available402machine # [ 1.015790] drop_monitor: Initializing network drop monitor service403machine # [ 1.016012] NET: Registered PF_INET6 protocol family404machine # [ 1.016573] Segment Routing with IPv6405machine # [ 1.016598] In-situ OAM (IOAM) with IPv6406machine # [ 1.016625] NET: Registered PF_PACKET protocol family407machine # [ 1.016688] 9pnet: Installing 9P2000 support408machine # [ 1.016727] Key type dns_resolver registered409machine # [ 1.027068] registered taskstats version 1410machine # [ 1.027228] Loading compiled-in X.509 certificates411machine # [ 1.035654] Demotion targets for Node 0: null412machine # [ 1.035765] Key type .fscrypt registered413machine # [ 1.035769] Key type fscrypt-provisioning registered414machine # [ 1.035866] ima: No TPM chip found, activating TPM-bypass!415machine # [ 1.035883] ima: Allocated hash algorithm: sha1416machine # [ 1.035908] ima: No architecture policies found417machine # [ 1.036559] input: gpio-keys as /devices/platform/gpio-keys/input/input0418machine # [ 1.058628] clk: Disabling unused clocks419machine # [ 1.058645] PM: genpd: Disabling unused power domains420machine # [ 1.061862] Freeing unused kernel memory: 4736K421machine # [ 1.062068] Run /init as init process422machine # [ 1.080615] systemd[1]: Successfully made /usr/ read-only.423machine # [ 1.081066] systemd[1]: systemd 263-195a17c 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)424machine # [ 1.081080] systemd[1]: Detected virtualization qemu.425machine # [ 1.081115] systemd[1]: Detected architecture arm64.426machine # [ 1.081121] systemd[1]: Running in initrd.427machine # [ 1.081402] systemd[1]: Initializing machine ID from random generator.428machine # [ 1.081495] systemd[1]: Hostname set to <machine>.429machine # [ 1.178416] systemd[1]: bpf-restrict-fs: LSM BPF program attached430machine # [ 1.231386] systemd[1]: Queued start job for default target Initrd Default Target.431machine # [ 1.237256] systemd[1]: Created slice Slice /system/modprobe.432machine # [ 1.237435] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.433machine # [ 1.237461] systemd[1]: Expecting device /dev/disk/by-label/nixos...434machine # [ 1.237482] systemd[1]: Reached target Path Units.435machine # [ 1.237495] systemd[1]: Reached target Slice Units.436machine # [ 1.237511] systemd[1]: Reached target Swaps.437machine # [ 1.237526] systemd[1]: Reached target Timer Units.438machine # [ 1.237654] systemd[1]: Listening on D-Bus System Message Bus Socket.439machine # [ 1.237802] systemd[1]: Listening on Journal Socket (/dev/log).440machine # [ 1.237951] systemd[1]: Listening on Journal Sockets.441machine # [ 1.238024] systemd[1]: Listening on udev Kernel Socket.442machine # [ 1.238039] systemd[1]: Reached target Socket Units.443machine # [ 1.246811] usb 1-1: new high-speed USB device number 2 using ehci-pci444machine # [ 1.248516] systemd[1]: Starting Create List of Static Device Nodes...445machine # [ 1.248572] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs446machine # [ 1.257916] systemd[1]: Mounting Kernel Configuration File System...447machine # [ 1.272322] systemd[1]: Starting Journal Service...448machine # [ 1.285980] systemd[1]: Starting Load Kernel Modules...449machine # [ 1.286082] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os450machine # [ 1.310757] systemd[1]: Starting Coldplug All udev Devices...451machine # [ 1.334575] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.452machine # [ 1.334904] systemd[1]: Finished Create List of Static Device Nodes.453machine # [ 1.336049] systemd[1]: Mounted Kernel Configuration File System.454machine # [ 1.340491] systemd-journald[71]: Collecting audit messages is disabled.455machine # [ 1.342952] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...456machine # [ 1.354255] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev457machine # [ 1.369053] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0458machine # [ 1.369308] [drm] features: -virgl +edid -resource_blob -host_visible459machine # [ 1.369311] [drm] features: -context_init460machine # [ 1.370047] [drm] number of scanouts: 1461machine # [ 1.370058] [drm] number of cap sets: 0462machine # [ 1.386668] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic463machine # [ 1.386680] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0464machine # [ 1.395796] 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/input1465machine # [ 1.410006] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.466machine # [ 1.414480] systemd[1]: Starting Create Static Device Nodes in /dev...467machine # [ 1.420594] Console: switching to colour frame buffer device 160x50468machine # [ 1.442797] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device469machine # [ 1.452913] systemd[1]: Finished Load Kernel Modules.470machine # [ 1.458419] systemd[1]: Starting Apply Kernel Variables...471machine # [ 1.482348] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0472machine # [ 1.490513] systemd[1]: Finished Create Static Device Nodes in /dev.473machine # [ 1.490764] systemd[1]: Reached target Preparation for Local File Systems.474machine # [ 1.490795] systemd[1]: Reached target Local File Systems.475machine # [ 1.497014] systemd[1]: Starting Rule-based Manager for Device Events and Files...476machine # [ 1.521321] systemd[1]: Started Journal Service.477machine # [ 1.508285] systemd-modules-load[72]: Inserted module 'dm_mod'478machine # [ 1.516608] systemd-modules-load[72]: Module 'virtio_balloon' is built in479machine # [ 1.517858] systemd-modules-load[72]: Module 'virtio_console' is built in480machine # [ 1.518957] systemd-modules-load[72]: Inserted module 'virtio_gpu'481machine # [ 1.530842] systemd-modules-load[72]: Module 'virtio_rng' is built in482machine # [ 1.536330] systemd[1]: Finished Apply Kernel Variables.483machine # [ 1.539012] systemd[1]: Starting Create System Files and Directories...484machine # [ 1.578733] systemd[1]: Finished Create System Files and Directories.485machine # [ 1.586980] systemd-udevd[80]: Using default interface naming scheme 'v261'.486machine # [ 1.602213] usb 1-2: new high-speed USB device number 3 using ehci-pci487machine # [ 1.611701] systemd[1]: Started Rule-based Manager for Device Events and Files.488machine # [ 1.704369] systemd[1]: Starting Virtual Console Setup...489machine # [ 1.768026] 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/input2490machine # [ 1.768277] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0491machine # [ 1.788954] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.492machine # [ 1.800409] systemd[1]: Finished Virtual Console Setup.493machine # [ 2.472443] (udev-worker)[97]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.494machine # [ 2.519440] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line.495machine # [ 2.532256] systemd[1]: Finished Coldplug All udev Devices.496machine # [ 2.535002] systemd[1]: Reached target System Initialization.497machine # [ 2.536839] systemd[1]: Reached target Basic System.498machine # [ 2.548496] systemd[1]: Found device /dev/disk/by-label/nixos.499machine # [ 2.552154] systemd[1]: Reached target Initrd Root Device.500machine # [ 2.556731] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...501machine # [ 2.608560] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks502machine # [ 2.615996] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.503machine # [ 2.620189] systemd[1]: Mounting /sysroot...504machine # [ 2.658811] systemd[1]: Mounted /sysroot.505machine # [ 2.674957] EXT4-fs (vda): mounted filesystem 2f4c355d-c499-4507-bb34-03136a09c552 r/w with ordered data mode. Quota mode: none.506machine # [ 2.662445] systemd[1]: Reached target Initrd Root File System.507machine # [ 2.668760] systemd[1]: Mounting /sysroot/nix/.ro-store...508machine # [ 2.687718] systemd[1]: Mounting /sysroot/nix/.rw-store...509machine # [ 2.692198] systemd[1]: Mounting /sysroot/run...510machine # [ 2.715284] systemd[1]: Mounting /sysroot/tmp/shared...511machine # [ 2.739786] systemd[1]: Mounting /sysroot/tmp/xchg...512machine # [ 2.755517] systemd[1]: Starting Mountpoints Configured in the Real Root...513machine # [ 2.819974] fuse: init (API version 7.45)514machine # [ 2.806790] systemd[1]: Mounted /sysroot/nix/.rw-store.515machine # [ 2.828700] virtiofs virtio6: discovered new tag: nix-store516machine # [ 2.829515] virtiofs virtio6: virtio_fs_setup_dax: No cache capability517machine # [ 2.848831] virtiofs virtio7: discovered new tag: shared518machine # [ 2.849639] virtiofs virtio7: virtio_fs_setup_dax: No cache capability519machine # [ 2.842821] systemd-sysroot-fstab-check[124]: /sysroot should be mounted in the initrd, will request daemon-reload.520machine # [ 2.867847] virtiofs virtio8: discovered new tag: xchg521machine # [ 2.868654] virtiofs virtio8: virtio_fs_setup_dax: No cache capability522machine # [ 2.856534] systemd[1]: Mounted /sysroot/run.523machine # [ 2.879666] systemd[1]: Mounted /sysroot/nix/.ro-store.524machine # [ 2.884501] systemd[1]: Mounted /sysroot/tmp/shared.525machine # [ 2.885915] systemd[1]: Mounted /sysroot/tmp/xchg.526machine # [ 2.888659] systemd[1]: Reload requested from client PID 124 ('systemd-sysroot') (unit initrd-parse-etc.service)...527machine # [ 2.895162] systemd[1]: Reloading...528machine # [ 3.088876] systemd[1]: Reloading finished in 196 ms.529machine # [ 3.123406] systemd-sysroot-fstab-check[124]: Requesting initrd-fs.target/start/replace...530machine # [ 3.130860] systemd-sysroot-fstab-check[124]: Requesting swap.target/start/replace...531machine # [ 3.136946] systemd[1]: Starting rw-sysroot-nix-store.service...532machine # [ 3.139342] systemd[1]: initrd-parse-etc.service: Deactivated successfully.533machine # [ 3.146581] systemd[1]: Finished Mountpoints Configured in the Real Root.534machine # [ 3.149093] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.535machine # [ 3.176397] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.536machine # [ 3.178078] systemd[1]: Finished rw-sysroot-nix-store.service.537machine # [ 3.300540] systemd[1]: Mounting /sysroot/nix/store...538machine # [ 3.346728] systemd[1]: Mounted /sysroot/nix/store.539machine # [ 3.347870] systemd[1]: Reached target Initrd File Systems.540machine # [ 3.350730] systemd[1]: Starting Find NixOS closure...541machine # [ 3.362066] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...542machine # [ 3.408123] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.543machine # [ 3.410413] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.544machine # [ 3.427808] systemd[1]: Finished Find NixOS closure.545machine # [ 3.430815] systemd[1]: Reached target Initrd Default Target.546machine # [ 3.436861] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...547machine # [ 3.470492] systemd[1]: Stopped target Initrd Default Target.548machine # [ 3.471984] systemd[1]: Stopped target Basic System.549machine # [ 3.476906] systemd[1]: Stopped target Initrd Root Device.550machine # [ 3.478917] systemd[1]: Stopped target Path Units.551machine # [ 3.480109] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.552machine # [ 3.483227] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.553machine # [ 3.488763] systemd[1]: Stopped target Slice Units.554machine # [ 3.490263] systemd[1]: Stopped target Socket Units.555machine # [ 3.492054] systemd[1]: Stopped target System Initialization.556machine # [ 3.497814] systemd[1]: Stopped target Swaps.557machine # [ 3.499577] systemd[1]: Stopped target Timer Units.558machine # [ 3.501268] systemd[1]: dbus.socket: Deactivated successfully.559machine # [ 3.504521] systemd[1]: Closed D-Bus System Message Bus Socket.560machine # [ 3.508180] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.561machine # [ 3.510653] systemd[1]: Stopped Find NixOS closure.562machine # [ 3.516223] systemd[1]: Starting rw-sysroot-nix-store.service...563machine # [ 3.519120] systemd[1]: systemd-sysctl.service: Deactivated successfully.564machine # [ 3.522713] systemd[1]: Stopped Apply Kernel Variables.565machine # [ 3.527290] systemd[1]: systemd-modules-load.service: Deactivated successfully.566machine # [ 3.533120] systemd[1]: Stopped Load Kernel Modules.567machine # [ 3.533920] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.568machine # [ 3.535183] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.569machine # [ 3.544389] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.570machine # [ 3.545566] systemd[1]: Stopped Create System Files and Directories.571machine # [ 3.548905] systemd[1]: Stopped target Local File Systems.572machine # [ 3.550517] systemd[1]: Stopped target Preparation for Local File Systems.573machine # [ 3.553155] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.574machine # [ 3.555789] systemd[1]: Stopped Coldplug All udev Devices.575machine # [ 3.557719] systemd[1]: Stopping Rule-based Manager for Device Events and Files...576machine # [ 3.560349] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.577machine # [ 3.564429] systemd[1]: Stopped Virtual Console Setup.578machine # [ 3.565361] systemd[1]: initrd-cleanup.service: Deactivated successfully.579machine # [ 3.566624] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.580machine # [ 3.567672] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.581machine # [ 3.568863] systemd[1]: Finished rw-sysroot-nix-store.service.582machine # [ 3.569743] systemd[1]: systemd-udevd.service: Deactivated successfully.583machine # [ 3.570691] systemd[1]: Stopped Rule-based Manager for Device Events and Files.584machine # [ 3.571723] systemd[1]: Starting Cleanup udev Database...585machine # [ 3.576255] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.586machine # [ 3.578379] systemd[1]: Stopped Create Static Device Nodes in /dev.587machine # [ 3.584377] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.588machine # [ 3.585658] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.589machine # [ 3.586842] systemd[1]: kmod-static-nodes.service: Deactivated successfully.590machine # [ 3.587855] systemd[1]: Stopped Create List of Static Device Nodes.591machine # [ 3.609344] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.592machine # [ 3.611956] systemd[1]: Finished Cleanup udev Database.593machine # [ 3.613394] systemd[1]: Reached target Switch Root.594machine # [ 3.614719] systemd[1]: Starting NixOS Activation...595machine # [ 3.696877] initrd-nixos-activation-start[170]: booting system configuration /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test596machine # [ 3.729216] initrd-nixos-activation-start[170]: running activation script...597machine # [ 3.946447] initrd-nixos-activation-start[193]: setting up /etc...598machine # [ 4.065963] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.599machine # [ 4.069221] systemd[1]: Finished NixOS Activation.600machine # [ 4.070621] systemd[1]: Starting Switch Root...601machine # [ 4.092951] systemd[1]: Switching root.602machine # [ 4.275725] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).603machine # [ 4.410404] systemd[1]: systemd 263-195a17c 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)604machine # [ 4.411386] systemd[1]: Detected virtualization qemu.605machine # [ 4.411809] systemd[1]: Detected architecture arm64.606machine # [ 4.412177] systemd[1]: Detected first boot.607machine # [ 4.413616] systemd[1]: Initializing machine ID from random generator.608machine # [ 4.538763] systemd[1]: bpf-restrict-fs: LSM BPF program attached609machine # [ 4.704868] systemd[1]: Applying preset policy.610machine # [ 4.942929] systemd[1]: Populated /etc with preset unit settings.611machine # [ 5.145519] systemd[1]: initrd-switch-root.service: Deactivated successfully.612machine # [ 5.148643] systemd[1]: Stopped initrd-switch-root.service.613machine # [ 5.153080] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.614machine # [ 5.157275] systemd[1]: Created slice Slice /system/getty.615machine # [ 5.160351] systemd[1]: Created slice User and Session Slice.616machine # [ 5.161026] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.617machine # [ 5.161826] systemd[1]: Started Forward Password Requests to Wall Directory Watch.618machine # [ 5.166227] systemd[1]: Expecting device /dev/hvc0...619machine # [ 5.166708] systemd[1]: Expecting device /dev/ttyAMA0...620machine # [ 5.167765] systemd[1]: Reached target Local Encrypted Volumes.621machine # [ 5.168523] systemd[1]: Stopped target initrd-fs.target.622machine # [ 5.169212] systemd[1]: Stopped target initrd-root-fs.target.623machine # [ 5.169896] systemd[1]: Stopped target initrd-switch-root.target.624machine # [ 5.174998] systemd[1]: Reached target Virtual Machines and Containers.625machine # [ 5.175897] systemd[1]: Reached target Path Units.626machine # [ 5.176575] systemd[1]: Reached target Remote File Systems.627machine # [ 5.177257] systemd[1]: Reached target Slice Units.628machine # [ 5.177915] systemd[1]: Reached target Swaps.629machine # [ 5.184078] systemd[1]: Listening on Query the User Interactively for a Password.630machine # [ 5.187351] systemd[1]: Listening on Process Core Dump Socket.631machine # [ 5.188883] systemd[1]: Listening on Credential Encryption/Decryption.632machine # [ 5.192083] systemd[1]: Listening on Factory Reset Management.633machine # [ 5.192684] systemd[1]: Listening on Hostname Service Socket.634machine # [ 5.199365] systemd[1]: Starting Journal Log Access Socket...635machine # [ 5.200696] systemd[1]: Listening on Journal Audit Socket.636machine # [ 5.204730] systemd[1]: Listening on Console Output Muting Service Socket.637machine # [ 5.205736] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.638machine # [ 5.209249] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os639machine # [ 5.212348] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki640machine # [ 5.218740] systemd[1]: Listening on Disk Repartitioning Service Socket.641machine # [ 5.219570] systemd[1]: Listening on udev Varlink Socket.642machine # [ 5.224781] systemd[1]: Mounting Huge Pages File System...643machine # [ 5.230381] systemd[1]: Mounting POSIX Message Queue File System...644machine # [ 5.246326] systemd[1]: Mounting Kernel Debug File System...645machine # [ 5.261957] systemd[1]: Mounting Kernel Trace File System...646machine # [ 5.279493] systemd[1]: Starting Create List of Static Device Nodes...647machine # [ 5.283683] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs648machine # [ 5.303650] systemd[1]: Mounting Kernel Configuration File System...649machine # [ 5.317153] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm650machine # [ 5.317956] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore651machine # [ 5.324346] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse652machine # [ 5.342801] systemd[1]: Mounting FUSE Control File System...653machine # [ 5.350098] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67654machine # [ 5.382786] systemd[1]: Starting Journal Service...655machine # [ 5.396337] systemd[1]: Starting Load Kernel Modules...656machine # [ 5.421040] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...657machine # [ 5.452059] systemd[1]: Starting Remount Root and Kernel File Systems...658machine # [ 5.452482] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os659machine # [ 5.460548] systemd-journald[265]: Collecting audit messages is enabled.660machine # [ 5.454180] systemd[1]: Queued start job for default target Multi-User System.661machine # [ 5.474961] systemd[1]: Starting Coldplug All udev Devices...662machine # [ 5.477894] systemd[1]: Started Journal Service.663machine # [ 5.463149] systemd[1]: Unnecessary job was removed for /sys/devices/platform/9000000.pl011/9000000.pl011:0/9000000.pl011:0.0/tty/ttyAMA0.664machine # [ 5.466250] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0.665machine # [ 5.467562] systemd[1]: systemd-journald.service: Deactivated successfully.666machine # [ 5.496709] systemd[1]: Listening on Journal Log Access Socket.667machine # [ 5.501369] systemd[1]: Mounted Huge Pages File System.668machine # [ 5.502366] systemd[1]: Mounted POSIX Message Queue File System.669machine # [ 5.503289] systemd[1]: Mounted Kernel Debug File System.670machine # [ 5.510117] systemd[1]: Mounted Kernel Trace File System.671machine # [ 5.519045] systemd-modules-load[266]: Module 'atkbd' is built in672machine # [ 5.528187] systemd-modules-load[266]: Module 'loop' is built in673machine # [ 5.529289] systemd[1]: Finished Create List of Static Device Nodes.674machine # [ 5.548896] systemd[1]: Finished Load Kernel Modules.675machine # [ 5.576343] systemd[1]: Starting Firewall...676machine # [ 5.591725] systemd[1]: Starting Apply Kernel Variables...677machine # [ 5.618538] EXT4-fs (vda): re-mounted 2f4c355d-c499-4507-bb34-03136a09c552.678machine # [ 5.611120] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...679machine # [ 5.616313] systemd[1]: Mounted Kernel Configuration File System.680machine # [ 5.632490] systemd-oomd[267]: No swap; memory pressure usage will be degraded681machine # [ 5.641162] systemd[1]: Finished Remount Root and Kernel File Systems.682machine # [ 5.642291] systemd[1]: Listening on Disk Image Download Service Socket.683machine # [ 5.663754] systemd[1]: Starting Flush Journal to Persistent Storage...684machine # [ 5.676734] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore685machine # [ 5.698672] systemd[1]: Starting Load/Save OS Random Seed...686machine # [ 5.699694] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os687machine # [ 5.713161] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.688machine # [ 5.714174] systemd[1]: Mounted FUSE Control File System.689machine # [ 5.831503] systemd-journald[265]: Received client request to flush runtime journal.690machine # [ 5.899098] systemd[1]: Finished Apply Kernel Variables.691machine # [ 5.908258] systemd[1]: Finished Load/Save OS Random Seed.692machine # [ 5.918169] systemd[1]: Reached target First Boot Complete.693machine # [ 5.919158] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.694machine # [ 5.924285] systemd[1]: Starting Create Static Device Nodes in /dev...695machine # [ 5.925856] systemd[1]: Finished Flush Journal to Persistent Storage.696machine # [ 6.068922] systemd[1]: Finished Create Static Device Nodes in /dev.697machine # [ 6.076105] systemd[1]: Reached target Preparation for Local File Systems.698machine # [ 6.078907] systemd[1]: Starting Rule-based Manager for Device Events and Files...699machine # [ 6.137210] systemd[1]: Mounting /run/wrappers...700machine # [ 6.215404] systemd[1]: Mounted /run/wrappers.701machine # [ 6.216993] systemd[1]: Reached target Local File Systems.702machine # [ 6.234040] systemd[1]: Listening on Boot Loader Control Service Socket.703machine # [ 6.246617] systemd[1]: Starting Create SUID/SGID Wrappers...704machine # [ 6.247630] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.705machine # [ 6.259137] systemd[1]: Starting Save Transient machine-id to Disk...706machine # [ 6.266524] systemd[1]: Starting Create System Files and Directories...707machine # [ 6.309073] systemd-udevd[304]: Using default interface naming scheme 'v261'.708machine # [ 6.414663] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.709machine # [ 6.430408] systemd[1]: Finished Save Transient machine-id to Disk.710machine # [ 6.473304] systemd[1]: Started Rule-based Manager for Device Events and Files.711machine # [ 6.512807] systemd[1]: Finished Create System Files and Directories.712machine # [ 6.532153] systemd[1]: Starting Rebuild Journal Catalog...713machine # [ 6.540299] systemd[1]: Starting Record System Boot/Shutdown in UTMP...714machine # [ 6.676850] systemd[1]: Finished Record System Boot/Shutdown in UTMP.715machine # [ 6.763614] systemd[1]: Finished Rebuild Journal Catalog.716machine # [ 6.776097] systemd[1]: Starting Update is Completed...717machine # [ 6.869844] systemd[1]: Finished Update is Completed.718machine # [ 7.261581] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.719machine # [ 7.269361] systemd[1]: Finished Create SUID/SGID Wrappers.720machine # [ 7.580116] systemd[1]: Finished Coldplug All udev Devices.721machine # [ 7.583554] systemd[1]: Reached target System Initialization.722machine # [ 7.588630] systemd[1]: Started Discard unused filesystem blocks once a week.723machine # [ 7.589835] systemd[1]: Started Daily Cleanup of Temporary Directories.724machine # [ 7.590864] systemd[1]: Reached target Timer Units.725machine # [ 7.591663] systemd[1]: Listening on D-Bus System Message Bus Socket.726machine # [ 7.599871] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.727machine # [ 7.607014] systemd[1]: Reached target Socket Units.728machine # [ 7.607823] systemd[1]: Reached target Basic System.729machine # [ 7.612329] systemd[1]: Starting Import lastlog data into lastlog2 database...730machine # [ 7.613549] systemd[1]: Starting Name Service Cache Daemon (nsncd)...731machine # [ 7.614499] systemd[1]: Starting Post-Boot Actions...732machine # [ 7.625982] systemd[1]: Started Reset console on configuration changes.733machine # [ 7.657843] systemd[1]: Starting resolvconf update...734machine # [ 7.731578] systemd[1]: Starting D-Bus System Message Bus...735machine # [ 7.795601] systemd[1]: Started Name Service Cache Daemon (nsncd).736machine # [ 7.803191] nsncd[427]: Oct 14 03:14:02.326 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"737machine # [ 7.829519] systemd[1]: Reached target Host and Network Name Lookups.738machine # [ 7.830660] systemd[1]: Reached target User and Group Name Lookups.739machine # [ 7.831610] systemd[1]: Starting User Login Management...740machine # [ 7.897680] systemd[1]: Finished Post-Boot Actions.741machine # [ 8.031766] dbus-broker-launch[436]: Looking up NSS user entry for 'systemd-timesync'...742machine # [ 8.046596] dbus-broker-launch[436]: NSS returned no entry for 'systemd-timesync'743machine # [ 8.047724] dbus-broker-launch[436]: Invalid user-name in /nix/store/by20c8m1gj11fw6fnmvl9y8k6lwif7mq-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"744machine # [ 8.081926] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3745machine # [ 8.067328] systemd[1]: Finished Import lastlog data into lastlog2 database.746machine # [ 8.093844] systemd[1]: Started D-Bus System Message Bus.747machine # [ 8.114513] systemd-logind[446]: New seat seat0.748machine # [ 8.128757] systemd[1]: Started User Login Management.749machine # [ 8.142519] systemd[1]: Starting linger-users.service...750machine # [ 8.151244] dbus-broker-launch[436]: Ready751machine # [ 8.250108] systemd[1]: Stopped target Host and Network Name Lookups.752machine # [ 8.253733] systemd[1]: Stopping Host and Network Name Lookups...753machine # [ 8.261980] systemd[1]: Stopped target User and Group Name Lookups.754machine # [ 8.263124] systemd[1]: Stopping User and Group Name Lookups...755machine # [ 8.269981] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...756machine # [ 8.271021] systemd[1]: nscd.service: Deactivated successfully.757machine # [ 8.271906] systemd[1]: Stopped Name Service Cache Daemon (nsncd).758machine # [ 8.314807] systemd[1]: Starting Name Service Cache Daemon (nsncd)...759machine # [ 8.436897] systemd[1]: Created slice Slice /user/1001.760machine # [ 8.438062] systemd[1]: Starting User Runtime Directory /run/user/1001...761machine # [ 8.487229] systemd[1]: linger-users.service: Deactivated successfully.762machine # [ 8.513321] systemd[1]: Finished linger-users.service.763machine # [ 8.563727] systemd[1]: Finished User Runtime Directory /run/user/1001.764machine # [ 8.589806] systemd[1]: Starting User Manager for UID 1001...765machine # [ 8.616858] systemd[1]: Started Name Service Cache Daemon (nsncd).766machine # [ 8.618115] systemd[1]: Reached target Host and Network Name Lookups.767machine # [ 8.665178] systemd[1]: Reached target User and Group Name Lookups.768machine # [ 8.679476] nsncd[518]: Oct 14 03:14:03.155 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"769machine # [ 8.731415] (systemd)[538]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0)770machine # [ 8.793748] systemd-logind[446]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'.771machine # [ 8.795797] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy772machine # [ 9.119278] systemd[1]: Starting Virtual Console Setup...773machine # [ 9.153422] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs774machine # [ 9.155195] systemd[538]: Queued start job for default target Main User Target.775machine # [ 9.202952] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy776machine # [ 9.249438] systemd[538]: Created slice User Application Slice.777machine # [ 9.278860] systemd[538]: Started Daily Cleanup of User's Temporary Directories.778machine # [ 9.300722] systemd[538]: Reached target Paths.779machine # [ 9.307333] systemd[538]: Reached target Timers.780machine # [ 9.315299] systemd[538]: Starting D-Bus User Message Bus Socket...781machine # [ 9.331730] systemd[538]: Starting Create User Files and Directories...782machine # [ 9.335844] systemd[1]: Finished resolvconf update.783machine # [ 9.342775] systemd[1]: Starting DHCP Client...784machine # [ 9.348649] systemd[538]: Finished Create User Files and Directories.785machine # [ 9.359570] systemd[538]: Listening on D-Bus User Message Bus Socket.786machine # [ 9.367303] systemd[538]: Reached target Sockets.787machine # [ 9.373488] systemd[538]: Reached target Basic System.788machine # [ 9.379998] systemd[1]: Started User Manager for UID 1001.789machine # [ 9.389823] systemd[538]: Starting Run user-specific NixOS activation...790machine # [ 9.400292] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.791machine # [ 9.406999] systemd[1]: Stopped Virtual Console Setup.792machine # [ 9.415203] systemd[1]: Starting Virtual Console Setup...793machine # [ 9.421116] systemd[538]: Finished Run user-specific NixOS activation.794machine # [ 9.429335] systemd[538]: Reached target Main User Target.795machine # [ 9.433584] systemd[538]: Startup finished in 432ms.796machine # [ 9.439839] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.797machine # [ 9.441951] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.798machine # [ 9.443027] systemd[1]: Started backdoor.service.799machine # connecting to host...800machine # [ 9.557587] systemd[1]: Finished Firewall.801machine # [ 9.558372] systemd[1]: Reached target Preparation for Network.802machine # [ 9.581103] systemd[1]: Starting Extra networking commands....803machine # [ 9.642659] (udev-worker)[599]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.804machine: Guest shell says: b'Spawning backdoor root shell...\n'805machine: connected to guest root shell806machine: (connecting took 9.99 seconds)807machine: (finished: waiting for the VM to finish booting, in 10.38 seconds)808machine # [ 9.687526] (udev-worker)[599]: Network interface NamePolicy= disabled on kernel command line.809machine # [ 9.899897] systemd[1]: Condition check resulted in Virtio network device being skipped.810machine # [ 9.931570] systemd[1]: Condition check resulted in Virtio network device being skipped.811machine # [ 9.952775] systemd[1]: Starting Address configuration of eth1...812machine # [ 9.954056] systemd-logind[446]: Watching system buttons on /dev/input/event0 (gpio-keys)813machine # [ 10.072531] mousedev: PS/2 mouse device common for all mice814machine # [ 10.093232] dhcpcd[588]: dhcpcd-10.3.2 starting815machine # [ 10.120765] dhcpcd[621]: dev: loaded udev816machine # [ 10.163049] 8021q: 802.1Q VLAN Support v1.8817machine # [ 10.257552] cfg80211: Loading compiled-in X.509 certificates for regulatory database818machine # [ 10.296226] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'819machine # [ 10.296742] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'820machine # [ 10.298025] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2821machine # [ 10.298385] cfg80211: failed to load regulatory.db822machine # [ 10.366468] 8021q: adding VLAN 0 to HW filter on device eth1823machine # [ 10.358149] systemd-vconsole-setup[571]: Configuration of first virtual console was skipped, ignoring remaining ones.824machine # [ 10.401608] systemd[1]: Finished Virtual Console Setup.825machine # [ 10.402539] systemd-logind[446]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)826machine # [ 10.473128] network-addresses-eth1-start[618]: adding address 192.168.1.1/24... done827machine # [ 10.536885] network-addresses-eth1-start[618]: adding address 2001:db8:1::1/64... done828machine # [ 10.605145] systemd[1]: Finished Address configuration of eth1.829machine # [ 10.617542] dhcpcd[660]: /nix/store/92w4pf1lqszlcwfq9ma2y2vaad5dssks-openresolv-3.17.4/sbin/.resolvconf-wrapped: line 1250: kill: (619) - Operation not permitted830machine # [ 10.619573] dhcpcd[660]: .resolvconf-wrapped: clearing stale lock pid 619831machine # [ 10.842446] 8021q: adding VLAN 0 to HW filter on device eth0832machine # [ 10.832134] dhcpcd[621]: eth0: waiting for carrier833machine # [ 10.833029] dhcpcd[621]: eth0: carrier acquired834machine # [ 10.910813] dhcpcd[621]: DUID 00:01:00:01:32:61:af:fd:52:54:00:12:34:56835machine # [ 10.911934] dhcpcd[621]: eth0: IAID 00:12:34:56836machine # [ 10.931694] dhcpcd[621]: eth0: adding address fe80::5054:ff:fe12:3456837machine # [ 10.966601] systemd[1]: Finished Extra networking commands..838machine # [ 10.967587] systemd[1]: Reached target Network.839machine # [ 10.994130] systemd[1]: Starting Permit User Sessions...840machine # [ 11.196141] systemd[1]: Finished Permit User Sessions.841machine # [ 11.220402] systemd[1]: Started Getty on tty1.842machine # [ 11.221283] systemd[1]: Reached target Login Prompts.843machine # [ 11.614599] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.844machine # [ 11.615806] systemd[1]: Stopped Virtual Console Setup.845machine # [ 11.633117] systemd[1]: Stopping Virtual Console Setup...846machine # [ 11.634014] systemd[1]: Starting Virtual Console Setup...847machine # [ 11.652573] systemd-logind[446]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)848machine # [ 11.662472] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.849machine # [ 11.671107] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.850machine # [ 11.684659] systemd[1]: Stopped Virtual Console Setup.851machine # [ 11.685505] systemd[1]: Starting Virtual Console Setup...852machine # [ 11.701600] dhcpcd[621]: eth0: soliciting a DHCP lease853machine # [ 11.702461] dhcpcd[621]: eth0: offered 10.0.2.15 from 10.0.2.2854machine # [ 11.708290] dhcpcd[621]: eth0: probing address 10.0.2.15/24855machine # [ 11.813620] systemd-vconsole-setup[712]: Configuration of first virtual console was skipped, ignoring remaining ones.856machine # [ 11.819028] systemd[1]: Finished Virtual Console Setup.857machine # [ 12.757555] dhcpcd[621]: eth0: soliciting an IPv6 router858machine # [ 12.760958] dhcpcd[621]: eth0: Router Advertisement from fe80::2859machine # [ 12.762449] dhcpcd[621]: eth0: adding address fec0::5054:ff:fe12:3456/64860machine # [ 12.763932] dhcpcd[621]: eth0: adding route to fec0::/64861machine # [ 12.766430] dhcpcd[621]: eth0: adding default route via fe80::2862machine # [ 16.774189] dhcpcd[621]: eth0: leased 10.0.2.15 for 86400 seconds863machine # [ 16.776451] dhcpcd[621]: eth0: adding route to 10.0.2.0/24864machine # [ 16.777906] dhcpcd[621]: eth0: adding default route via 10.0.2.2865machine # [ 16.962133] systemd[1]: Started DHCP Client.866machine # [ 16.964521] systemd[1]: Reached target Multi-User System.867machine # [ 16.965604] systemd[1]: Startup finished in 1.049s (kernel) + 3.262s (initrd) + 12.651s (userspace) = 16.964s.868machine: (finished: waiting for unit multi-user.target, in 17.80 seconds)869machine: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/bin/switch-to-configuration test870machine # Checking switch inhibitors... done871machine # [ 17.315013] nixos[825]: switching to system configuration /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test872machine # activating the configuration...873machine # [ 17.319306] systemd[1]: Stopped target Local File Systems.874machine # [ 17.321773] systemd[1]: Stopped target Remote File Systems.875machine # setting up /etc...876machine # [ 17.617442] systemd[1]: Reload requested from client PID 825 ('.switch-to-conf') (unit backdoor.service)...877machine # [ 17.619162] systemd[1]: Reloading...878machine # [ 17.942889] systemd[1]: Reloading finished in 322 ms.879machine # reloading user units for usertest...880machine # [ 17.999894] systemd[538]: Created slice User Core Session Slice.881machine # [ 18.003383] systemd[538]: Starting D-Bus User Message Bus...882machine # [ 18.038242] dbus-broker-launch[895]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/by20c8m1gj11fw6fnmvl9y8k6lwif7mq-system-path/share/dbus-1/services/org.freedesktop.import1.service'883machine # [ 18.041776] dbus-broker-launch[895]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/by20c8m1gj11fw6fnmvl9y8k6lwif7mq-system-path/share/dbus-1/services/org.freedesktop.machine1.service'884machine # [ 18.045021] dbus-broker-launch[895]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/by20c8m1gj11fw6fnmvl9y8k6lwif7mq-system-path/share/dbus-1/services/org.freedesktop.portable1.service'885machine # [ 18.048102] dbus-broker-launch[895]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/by20c8m1gj11fw6fnmvl9y8k6lwif7mq-system-path/share/dbus-1/services/org.freedesktop.systemd1.service'886machine # [ 18.053170] dbus-broker-launch[895]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored887machine # [ 18.055043] dbus-broker-launch[895]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored888machine # [ 18.058366] systemd[538]: Started D-Bus User Message Bus.889machine # [ 18.061408] dbus-broker-launch[895]: Ready890machine # [ 18.104988] systemd[538]: Reexecution requested from client PID 894 ('switch-to-confi')...891machine # [ 18.109617] systemd[538]: Reexecuting.892machine # [ 18.164125] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy893machine # [ 18.285855] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy894machine # [ 18.294079] systemd[538]: Reload requested from client PID 894 ('switch-to-confi')...895machine # [ 18.296624] systemd[538]: Reloading...896machine # [ 18.409620] systemd[538]: Reloading finished in 111 ms.897machine # [ 18.425794] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy898machine # restarting the following user units: nixos-activation.service899machine # [ 18.437494] systemd[538]: Stopped Run user-specific NixOS activation.900machine # [ 18.439989] systemd[538]: Stopping Run user-specific NixOS activation...901machine # [ 18.442362] systemd[538]: Starting Run user-specific NixOS activation...902machine # [ 18.483787] systemd[538]: Finished Run user-specific NixOS activation.903machine # restarting sysinit-reactivation.target904machine # [ 18.499073] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....905machine # [ 18.592332] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..906machine # [ 18.596978] systemd[1]: Reached target Reactivate sysinit units.907machine # [ 18.600709] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os908machine # [ 18.605431] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki909machine # [ 18.606866] systemd[1]: Reached target Remote File Systems.910machine # [ 18.608895] systemd[1]: Reached target Local File Systems.911machine # [ 18.617275] systemd[1]: Starting linger-users.service...912machine # [ 18.624758] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore913machine # [ 18.632563] systemd[1]: Starting Create SUID/SGID Wrappers...914machine # [ 18.633628] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.915machine # [ 18.634906] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67916machine # [ 18.644558] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore917machine # [ 18.646491] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os918machine # [ 18.647809] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os919machine # [ 18.718394] systemd[1]: linger-users.service: Deactivated successfully.920machine # [ 18.722789] systemd[1]: Finished linger-users.service.921machine # [ 18.856943] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.922machine # [ 18.859926] systemd[1]: Finished Create SUID/SGID Wrappers.923machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service924machine # [ 19.118110] nixos[825]: finished switching to system configuration /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test925machine: (finished: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/bin/switch-to-configuration test, in 2.02 seconds)926machine: must succeed: rm /etc/NIXOS927machine: (finished: must succeed: rm /etc/NIXOS, in 0.03 seconds)928machine: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/wrjfvlxivrnrjka36srkwlchw449wmci-nixos-system-other-test/bin/switch-to-configuration test929machine # this should succeed (config: /nix/store/wrjfvlxivrnrjka36srkwlchw449wmci-nixos-system-other-test, action: test)930machine # Checking switch inhibitors... done931machine # [ 19.393067] nixos[972]: switching to system configuration /nix/store/wrjfvlxivrnrjka36srkwlchw449wmci-nixos-system-other-test932machine # activating the configuration...933machine # [ 19.397607] systemd[1]: Stopped target Remote File Systems.934machine # [ 19.399392] systemd[1]: Stopped target Local File Systems.935machine # removing user ‘usertest’936machine # setting up /etc...937machine # [ 19.690997] systemd[1]: Reload requested from client PID 972 ('.switch-to-conf') (unit backdoor.service)...938machine # [ 19.693535] systemd[1]: Reloading...939machine # [ 20.029041] systemd[1]: Reloading finished in 334 ms.940machine # reloading user units for usertest...941machine # [ 20.119771] systemd[538]: Reexecution requested from client PID 1043 ('switch-to-confi')...942machine # [ 20.123069] systemd[538]: Reexecuting.943machine # [ 20.180173] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy944machine # [ 20.341415] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy945machine # [ 20.348445] systemd[538]: Reload requested from client PID 1043 ('switch-to-confi')...946machine # [ 20.352124] systemd[538]: Reloading...947machine # [ 20.461149] systemd[538]: Reloading finished in 109 ms.948machine # [ 20.477875] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy949machine # restarting the following user units: nixos-activation.service950machine # [ 20.487935] systemd[538]: Stopped Run user-specific NixOS activation.951machine # [ 20.490606] systemd[538]: Stopping Run user-specific NixOS activation...952machine # [ 20.492758] systemd[538]: Starting Run user-specific NixOS activation...953machine # [ 20.526058] systemd[538]: Finished Run user-specific NixOS activation.954machine # restarting sysinit-reactivation.target955machine # [ 20.530798] systemd[1]: Stopped target Reactivate sysinit units.956machine # reloading the following units: dbus-broker.service957machine # [ 20.535260] systemd[1]: Stopping Reactivate sysinit units...958machine # [ 20.537189] systemd[1]: Reached target Reactivate sysinit units.959machine # [ 20.539116] dbus-broker-launch[436]: Caught SIGHUP, trigger reload.960machine # [ 20.540764] systemd[1]: Reloading D-Bus System Message Bus...961machine # [ 20.544891] dbus-broker-launch[436]: Looking up NSS user entry for 'systemd-timesync'...962machine # [ 20.547121] dbus-broker-launch[436]: NSS returned no entry for 'systemd-timesync'963machine # [ 20.548485] dbus-broker-launch[436]: Invalid user-name in /nix/store/jv0hcwnmszawk334lp8i6ifxll77f8fw-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"964machine # [ 20.566266] systemd[1]: Reloaded D-Bus System Message Bus.965machine # restarting the following units: network-addresses-eth1.service966machine # [ 20.574168] systemd[1]: Stopping Address configuration of eth1...967machine # [ 20.607895] network-addresses-eth1-pre-stop[1056]: deleting address 192.168.1.1/24... done968machine # [ 20.616781] network-addresses-eth1-pre-stop[1056]: deleting address 2001:db8:1::1/64... done969machine # [ 20.624352] systemd[1]: network-addresses-eth1.service: Deactivated successfully.970machine # [ 20.627413] systemd[1]: Stopped Address configuration of eth1.971machine # [ 20.631953] systemd[1]: Starting Address configuration of eth1...972machine # [ 20.677194] network-addresses-eth1-start[1061]: adding address 192.168.1.2/24... done973machine # [ 20.685203] network-addresses-eth1-start[1061]: adding address 2001:db8:1::2/64... done974machine # [ 20.695852] systemd[1]: Finished Address configuration of eth1.975machine # [ 20.700504] systemd[1]: Reached target Remote File Systems.976machine # [ 20.703887] systemd[1]: Reached target Local File Systems.977machine # [ 20.709379] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os978machine # [ 20.710843] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki979machine # [ 20.717177] systemd[1]: Starting linger-users.service...980machine # [ 20.728159] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore981machine # [ 20.737780] systemd[1]: Starting Create SUID/SGID Wrappers...982machine # [ 20.738741] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.983machine # [ 20.740000] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67984machine # [ 20.748958] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore985machine # [ 20.750669] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os986machine # [ 20.752001] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os987machine # [ 20.780400] linger-users-start[1075]: id: ‘usertest’: no such user988machine # [ 20.784503] linger-users-start[1072]: Removing linger for missing user usertest989machine # [ 20.794364] systemd[1]: linger-users.service: Deactivated successfully.990machine # [ 20.798914] systemd[1]: Finished linger-users.service.991machine # [ 20.970494] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.992machine # [ 20.974216] systemd[1]: Finished Create SUID/SGID Wrappers.993machine # [ 21.227379] nixos[972]: finished switching to system configuration /nix/store/wrjfvlxivrnrjka36srkwlchw449wmci-nixos-system-other-test994machine: (finished: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/wrjfvlxivrnrjka36srkwlchw449wmci-nixos-system-other-test/bin/switch-to-configuration test, in 2.08 seconds)995subtest: services996machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/bin/switch-to-configuration test 2>&1997machine # [ 21.453957] nixos[1139]: switching to system configuration /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test998machine # [ 21.456542] systemd[1]: Stopped target Local File Systems.999machine # [ 21.459825] systemd[1]: Stopped target Remote File Systems.1000machine # [ 21.749844] systemd[1]: Reload requested from client PID 1139 ('.switch-to-conf') (unit backdoor.service)...1001machine # [ 21.751852] systemd[1]: Reloading...1002machine # [ 22.086486] systemd[1]: Reloading finished in 332 ms.1003machine # [ 22.178362] systemd[538]: Reexecution requested from client PID 1208 ('switch-to-confi')...1004machine # [ 22.179851] systemd[538]: Reexecuting.1005machine # [ 22.235796] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1006machine # [ 22.350213] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1007machine # [ 22.357271] systemd[538]: Reload requested from client PID 1208 ('switch-to-confi')...1008machine # [ 22.359614] systemd[538]: Reloading...1009machine # [ 22.467848] systemd[538]: Reloading finished in 107 ms.1010machine # [ 22.484170] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1011machine # [ 22.494693] systemd[538]: Stopped Run user-specific NixOS activation.1012machine # [ 22.497290] systemd[538]: Stopping Run user-specific NixOS activation...1013machine # [ 22.499537] systemd[538]: Starting Run user-specific NixOS activation...1014machine # [ 22.533052] systemd[538]: Finished Run user-specific NixOS activation.1015machine # [ 22.537274] systemd[1]: Stopped target Reactivate sysinit units.1016machine # [ 22.542213] systemd[1]: Stopping Reactivate sysinit units...1017machine # [ 22.543165] systemd[1]: Reached target Reactivate sysinit units.1018machine # [ 22.544376] systemd[1]: Reloading D-Bus System Message Bus...1019machine # [ 22.547979] dbus-broker-launch[436]: Caught SIGHUP, trigger reload.1020machine # [ 22.550435] dbus-broker-launch[436]: Looking up NSS user entry for 'systemd-timesync'...1021machine # [ 22.552647] dbus-broker-launch[436]: NSS returned no entry for 'systemd-timesync'1022machine # [ 22.553854] dbus-broker-launch[436]: Invalid user-name in /nix/store/by20c8m1gj11fw6fnmvl9y8k6lwif7mq-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1023machine # [ 22.580092] systemd[1]: Reloaded D-Bus System Message Bus.1024machine # [ 22.586217] systemd[1]: Stopping Address configuration of eth1...1025machine # [ 22.620295] network-addresses-eth1-pre-stop[1220]: deleting address 192.168.1.2/24... done1026machine # [ 22.628703] network-addresses-eth1-pre-stop[1220]: deleting address 2001:db8:1::2/64... done1027machine # [ 22.639645] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1028machine # [ 22.642162] systemd[1]: Stopped Address configuration of eth1.1029machine # [ 22.648549] systemd[1]: Starting Address configuration of eth1...1030machine # [ 22.705606] network-addresses-eth1-start[1225]: adding address 192.168.1.1/24... done1031machine # [ 22.714361] network-addresses-eth1-start[1225]: adding address 2001:db8:1::1/64... done1032machine # [ 22.725912] systemd[1]: Finished Address configuration of eth1.1033machine # [ 22.733557] systemd[1]: Reached target Local File Systems.1034machine # [ 22.738062] systemd[1]: Reached target Remote File Systems.1035machine # [ 22.739086] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1036machine # [ 22.744560] systemd[1]: Starting Create SUID/SGID Wrappers...1037machine # [ 22.745598] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1038machine # [ 22.746928] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671039machine # [ 22.763321] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1040machine # [ 22.767318] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1041machine # [ 22.768935] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1042machine # [ 22.770225] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1043machine # [ 22.771662] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1044machine # [ 22.937378] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1045machine # [ 22.942117] systemd[1]: Finished Create SUID/SGID Wrappers.1046machine # [ 22.944756] systemd[1]: Starting linger-users.service...1047machine # [ 22.982254] systemd[1]: linger-users.service: Deactivated successfully.1048machine # [ 22.985051] systemd[1]: Finished linger-users.service.1049machine # [ 23.242027] nixos[1139]: finished switching to system configuration /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test1050machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.01 seconds)1051machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/bin/switch-to-configuration test 2>&11052machine # [ 23.462764] nixos[1294]: switching to system configuration /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test1053machine # [ 23.465577] systemd[1]: Stopped target Local File Systems.1054machine # [ 23.467760] systemd[1]: Stopped target Remote File Systems.1055machine # [ 23.808520] systemd[1]: Reload requested from client PID 1294 ('.switch-to-conf') (unit backdoor.service)...1056machine # [ 23.810201] systemd[1]: Reloading...1057machine # [ 24.144520] systemd[1]: Reloading finished in 332 ms.1058machine # [ 24.230141] systemd[538]: Reexecution requested from client PID 1364 ('switch-to-confi')...1059machine # [ 24.234139] systemd[538]: Reexecuting.1060machine # [ 24.291475] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1061machine # [ 24.407943] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1062machine # [ 24.414971] systemd[538]: Reload requested from client PID 1364 ('switch-to-confi')...1063machine # [ 24.417709] systemd[538]: Reloading...1064machine # [ 24.527866] systemd[538]: Reloading finished in 109 ms.1065machine # [ 24.545804] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1066machine # [ 24.553877] systemd[538]: Stopped Run user-specific NixOS activation.1067machine # [ 24.556075] systemd[538]: Stopping Run user-specific NixOS activation...1068machine # [ 24.558607] systemd[538]: Starting Run user-specific NixOS activation...1069machine # [ 24.592769] systemd[538]: Finished Run user-specific NixOS activation.1070machine # [ 24.597533] systemd[1]: Stopped target Reactivate sysinit units.1071machine # [ 24.598897] systemd[1]: Stopping Reactivate sysinit units...1072machine # [ 24.599814] systemd[1]: Reached target Reactivate sysinit units.1073machine # [ 24.603104] systemd[1]: Reached target Local File Systems.1074machine # [ 24.607185] systemd[1]: Reached target Remote File Systems.1075machine # [ 24.611817] systemd[1]: Starting linger-users.service...1076machine # [ 24.623629] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1077machine # [ 24.629172] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1078machine # [ 24.630589] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1079machine # [ 24.641587] systemd[1]: Starting Create SUID/SGID Wrappers...1080machine # [ 24.642569] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1081machine # [ 24.643883] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671082machine # [ 24.659013] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1083machine # [ 24.663270] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1084machine # [ 24.667532] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1085machine # [ 24.709833] systemd[1]: linger-users.service: Deactivated successfully.1086machine # [ 24.713275] systemd[1]: Finished linger-users.service.1087machine # [ 24.867826] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1088machine # [ 24.871992] systemd[1]: Finished Create SUID/SGID Wrappers.1089machine # [ 25.126145] nixos[1294]: finished switching to system configuration /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test1090machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.88 seconds)1091machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11092machine # [ 25.362081] nixos[1435]: switching to system configuration /nix/store/hd97j3kl1k224s79yab3svhh9qcs6cvq-nixos-system-machine-test1093machine # [ 25.366130] systemd[1]: Stopped target Remote File Systems.1094machine # [ 25.367209] systemd[1]: Stopped target Local File Systems.1095machine # [ 25.662402] systemd[1]: Reload requested from client PID 1435 ('.switch-to-conf') (unit backdoor.service)...1096machine # [ 25.664666] systemd[1]: Reloading...1097machine # [ 26.006720] systemd[1]: Reloading finished in 340 ms.1098machine # [ 26.087999] systemd[538]: Reexecution requested from client PID 1504 ('switch-to-confi')...1099machine # [ 26.090850] systemd[538]: Reexecuting.1100machine # [ 26.147325] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1101machine # [ 26.259404] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1102machine # [ 26.267102] systemd[538]: Reload requested from client PID 1504 ('switch-to-confi')...1103machine # [ 26.270121] systemd[538]: Reloading...1104machine # [ 26.377977] systemd[538]: Reloading finished in 108 ms.1105machine # [ 26.392186] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1106machine # [ 26.403772] systemd[538]: Stopped Run user-specific NixOS activation.1107machine # [ 26.405216] systemd[538]: Stopping Run user-specific NixOS activation...1108machine # [ 26.408090] systemd[538]: Starting Run user-specific NixOS activation...1109machine # [ 26.436120] systemd[538]: Finished Run user-specific NixOS activation.1110machine # [ 26.440110] systemd[1]: Stopped target Reactivate sysinit units.1111machine # [ 26.443778] systemd[1]: Stopping Reactivate sysinit units...1112machine # [ 26.445812] systemd[1]: Reached target Reactivate sysinit units.1113machine # [ 26.446809] systemd[1]: Reached target Remote File Systems.1114machine # [ 26.449517] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1115machine # [ 26.455581] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1116machine # [ 26.459604] systemd[1]: Starting linger-users.service...1117machine # [ 26.463102] systemd[1]: Starting test.service...1118machine # [ 26.472232] systemd[1]: Reached target Local File Systems.1119machine # [ 26.478603] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1120machine # [ 26.488470] systemd[1]: Starting Create SUID/SGID Wrappers...1121machine # [ 26.489406] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1122machine # [ 26.490692] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671123machine # [ 26.498089] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1124machine # [ 26.499812] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1125machine # [ 26.501507] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1126machine # [ 26.546470] systemd[1]: Finished test.service.1127machine # [ 26.575426] systemd[1]: linger-users.service: Deactivated successfully.1128machine # [ 26.577689] systemd[1]: Finished linger-users.service.1129machine # [ 26.712221] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1130machine # [ 26.715655] systemd[1]: Finished Create SUID/SGID Wrappers.1131machine # [ 26.972447] nixos[1435]: finished switching to system configuration /nix/store/hd97j3kl1k224s79yab3svhh9qcs6cvq-nixos-system-machine-test1132machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.85 seconds)1133machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11134machine # [ 27.192427] nixos[1578]: switching to system configuration /nix/store/hd97j3kl1k224s79yab3svhh9qcs6cvq-nixos-system-machine-test1135machine # [ 27.195329] systemd[1]: Stopped target Remote File Systems.1136machine # [ 27.198929] systemd[1]: Stopped target Local File Systems.1137machine # [ 27.491350] systemd[1]: Reload requested from client PID 1578 ('.switch-to-conf') (unit backdoor.service)...1138machine # [ 27.493708] systemd[1]: Reloading...1139machine # [ 27.829543] systemd[1]: Reloading finished in 333 ms.1140machine # [ 27.914842] systemd[538]: Reexecution requested from client PID 1647 ('switch-to-confi')...1141machine # [ 27.917794] systemd[538]: Reexecuting.1142machine # [ 27.984385] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1143machine # [ 28.102370] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1144machine # [ 28.109568] systemd[538]: Reload requested from client PID 1647 ('switch-to-confi')...1145machine # [ 28.112228] systemd[538]: Reloading...1146machine # [ 28.224183] systemd[538]: Reloading finished in 110 ms.1147machine # [ 28.240225] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1148machine # [ 28.251398] systemd[538]: Stopped Run user-specific NixOS activation.1149machine # [ 28.252627] systemd[538]: Stopping Run user-specific NixOS activation...1150machine # [ 28.255404] systemd[538]: Starting Run user-specific NixOS activation...1151machine # [ 28.291371] systemd[538]: Finished Run user-specific NixOS activation.1152machine # [ 28.297079] systemd[1]: Stopped target Reactivate sysinit units.1153machine # [ 28.300513] systemd[1]: Stopping Reactivate sysinit units...1154machine # [ 28.301604] systemd[1]: Reached target Reactivate sysinit units.1155machine # [ 28.302593] systemd[1]: Reached target Remote File Systems.1156machine # [ 28.307755] systemd[1]: Starting linger-users.service...1157machine # [ 28.318690] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1158machine # [ 28.326214] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1159machine # [ 28.327745] systemd[1]: Reached target Local File Systems.1160machine # [ 28.341232] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1161machine # [ 28.343000] systemd[1]: Starting Create SUID/SGID Wrappers...1162machine # [ 28.355169] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1163machine # [ 28.358139] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671164machine # [ 28.361520] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1165machine # [ 28.363242] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1166machine # [ 28.370258] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1167machine # [ 28.423237] systemd[1]: linger-users.service: Deactivated successfully.1168machine # [ 28.427696] systemd[1]: Finished linger-users.service.1169machine # [ 28.623545] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1170machine # [ 28.626501] systemd[1]: Finished Create SUID/SGID Wrappers.1171machine # [ 28.883348] nixos[1578]: finished switching to system configuration /nix/store/hd97j3kl1k224s79yab3svhh9qcs6cvq-nixos-system-machine-test1172machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.91 seconds)1173machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&11174machine # [ 29.143583] nixos[1718]: switching to system configuration /nix/store/n34zr7h310mf8iginim3fkrklnji67rm-nixos-system-machine-test1175machine # [ 29.146692] systemd[1]: Stopped target Remote File Systems.1176machine # [ 29.149345] systemd[1]: Stopped target Local File Systems.1177machine # [ 29.451805] systemd[1]: Reload requested from client PID 1718 ('.switch-to-conf') (unit backdoor.service)...1178machine # [ 29.454146] systemd[1]: Reloading...1179machine # [ 29.830135] systemd[1]: Reloading finished in 373 ms.1180machine # [ 29.922327] systemd[538]: Reexecution requested from client PID 1787 ('switch-to-confi')...1181machine # [ 29.923861] systemd[538]: Reexecuting.1182machine # [ 29.984786] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1183machine # [ 30.103184] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1184machine # [ 30.110629] systemd[538]: Reload requested from client PID 1787 ('switch-to-confi')...1185machine # [ 30.113397] systemd[538]: Reloading...1186machine # [ 30.283358] systemd[538]: Reloading finished in 168 ms.1187machine # [ 30.300224] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1188machine # [ 30.311188] systemd[538]: Stopped Run user-specific NixOS activation.1189machine # [ 30.313907] systemd[538]: Stopping Run user-specific NixOS activation...1190machine # [ 30.316198] systemd[538]: Starting Run user-specific NixOS activation...1191machine # [ 30.358207] systemd[538]: Finished Run user-specific NixOS activation.1192machine # [ 30.363216] systemd[1]: Stopped target Reactivate sysinit units.1193machine # [ 30.365600] systemd[1]: Stopping Reactivate sysinit units...1194machine # [ 30.366544] systemd[1]: Reached target Reactivate sysinit units.1195machine # [ 30.370684] systemd[1]: Reached target Remote File Systems.1196machine # [ 30.376165] systemd[1]: Starting linger-users.service...1197machine # [ 30.385165] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1198machine # [ 30.392861] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1199machine # [ 30.394374] systemd[1]: Reached target Local File Systems.1200machine # [ 30.395201] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1201machine # [ 30.413403] systemd[1]: Starting Create SUID/SGID Wrappers...1202machine # [ 30.414406] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1203machine # [ 30.415823] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671204machine # [ 30.429687] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1205machine # [ 30.431422] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1206machine # [ 30.434951] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1207machine # [ 30.478311] systemd[1]: linger-users.service: Deactivated successfully.1208machine # [ 30.482373] systemd[1]: Finished linger-users.service.1209machine # [ 30.646231] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1210machine # [ 30.649632] systemd[1]: Finished Create SUID/SGID Wrappers.1211machine # [ 30.905920] nixos[1718]: finished switching to system configuration /nix/store/n34zr7h310mf8iginim3fkrklnji67rm-nixos-system-machine-test1212machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 2.02 seconds)1213machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11214machine # [ 31.152906] nixos[1859]: switching to system configuration /nix/store/f9j1g17kp1cycddhw7flsj254qs35lcw-nixos-system-machine-test1215machine # [ 31.155659] systemd[1]: Stopped target Remote File Systems.1216machine # [ 31.158430] systemd[1]: test.service: Deactivated successfully.1217machine # [ 31.159368] systemd[1]: Stopped Test unit.1218machine # [ 31.160636] systemd[1]: Stopped target Local File Systems.1219machine # [ 31.462235] systemd[1]: Reload requested from client PID 1859 ('.switch-to-conf') (unit backdoor.service)...1220machine # [ 31.464353] systemd[1]: Reloading...1221machine # [ 31.793894] systemd[1]: Reloading finished in 327 ms.1222machine # [ 31.880853] systemd[538]: Reexecution requested from client PID 1928 ('switch-to-confi')...1223machine # [ 31.885205] systemd[538]: Reexecuting.1224machine # [ 31.931194] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1225machine # [ 32.045203] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1226machine # [ 32.051812] systemd[538]: Reload requested from client PID 1928 ('switch-to-confi')...1227machine # [ 32.054407] systemd[538]: Reloading...1228machine # [ 32.163531] systemd[538]: Reloading finished in 107 ms.1229machine # [ 32.180203] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1230machine # [ 32.191026] systemd[538]: Stopped Run user-specific NixOS activation.1231machine # [ 32.193571] systemd[538]: Stopping Run user-specific NixOS activation...1232machine # [ 32.195858] systemd[538]: Starting Run user-specific NixOS activation...1233machine # [ 32.230844] systemd[538]: Finished Run user-specific NixOS activation.1234machine # [ 32.235346] systemd[1]: Stopped target Reactivate sysinit units.1235machine # [ 32.239532] systemd[1]: Stopping Reactivate sysinit units...1236machine # [ 32.241306] systemd[1]: Reached target Reactivate sysinit units.1237machine # [ 32.242216] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1238machine # [ 32.243553] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1239machine # [ 32.245884] systemd[1]: Reached target Remote File Systems.1240machine # [ 32.251741] systemd[1]: Starting linger-users.service...1241machine # [ 32.256700] systemd[1]: Starting test.service...1242machine # [ 32.272626] systemd[1]: Reached target Local File Systems.1243machine # [ 32.273581] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1244machine # [ 32.287959] systemd[1]: Starting Create SUID/SGID Wrappers...1245machine # [ 32.289602] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1246machine # [ 32.291060] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671247machine # [ 32.309120] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1248machine # [ 32.310905] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1249machine # [ 32.317902] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1250machine # [ 32.343791] systemd[1]: Finished test.service.1251machine # [ 32.376926] systemd[1]: linger-users.service: Deactivated successfully.1252machine # [ 32.381663] systemd[1]: Finished linger-users.service.1253machine # [ 32.566808] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1254machine # [ 32.570469] systemd[1]: Finished Create SUID/SGID Wrappers.1255machine # [ 32.827005] nixos[1859]: finished switching to system configuration /nix/store/f9j1g17kp1cycddhw7flsj254qs35lcw-nixos-system-machine-test1256machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.92 seconds)1257machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&11258machine # [ 33.047175] nixos[2001]: switching to system configuration /nix/store/g6wmn9xvnyx781gjs5d3s2fflnlm93dl-nixos-system-machine-test1259machine # [ 33.050179] systemd[1]: Stopped target Local File Systems.1260machine # [ 33.052614] systemd[1]: Stopped target Remote File Systems.1261machine # [ 33.360928] systemd[1]: Reload requested from client PID 2001 ('.switch-to-conf') (unit backdoor.service)...1262machine # [ 33.363165] systemd[1]: Reloading...1263machine # [ 33.711290] systemd[1]: Reloading finished in 346 ms.1264machine # [ 33.841650] systemd[538]: Reexecution requested from client PID 2070 ('switch-to-confi')...1265machine # [ 33.846390] systemd[538]: Reexecuting.1266machine # [ 33.899260] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1267machine # [ 34.014623] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1268machine # [ 34.022342] systemd[538]: Reload requested from client PID 2070 ('switch-to-confi')...1269machine # [ 34.025120] systemd[538]: Reloading...1270machine # [ 34.142886] systemd[538]: Reloading finished in 116 ms.1271machine # [ 34.160236] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1272machine # [ 34.172147] systemd[538]: Stopped Run user-specific NixOS activation.1273machine # [ 34.173374] systemd[538]: Stopping Run user-specific NixOS activation...1274machine # [ 34.176404] systemd[538]: Starting Run user-specific NixOS activation...1275machine # [ 34.211166] systemd[538]: Finished Run user-specific NixOS activation.1276machine # [ 34.217080] systemd[1]: Stopped target Reactivate sysinit units.1277machine # [ 34.220352] systemd[1]: Stopping Reactivate sysinit units...1278machine # [ 34.221439] systemd[1]: Reached target Reactivate sysinit units.1279machine # [ 34.225215] systemd[1]: test.service: Deactivated successfully.1280machine # [ 34.226223] systemd[1]: Stopped test.service.1281machine # [ 34.226892] systemd[1]: Stopping test.service...1282machine # [ 34.229802] systemd[1]: Starting test.service...1283machine # [ 34.260140] systemd[1]: Finished test.service.1284machine # [ 34.265788] systemd[1]: Reached target Remote File Systems.1285machine # [ 34.271641] systemd[1]: Reached target Local File Systems.1286machine # [ 34.278812] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1287machine # [ 34.289203] systemd[1]: Starting Create SUID/SGID Wrappers...1288machine # [ 34.290211] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1289machine # [ 34.291491] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671290machine # [ 34.299400] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1291machine # [ 34.301442] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1292machine # [ 34.302758] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1293machine # [ 34.303990] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1294machine # [ 34.306341] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1295machine # [ 34.504866] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1296machine # [ 34.508494] systemd[1]: Finished Create SUID/SGID Wrappers.1297machine # [ 34.514126] systemd[1]: Starting linger-users.service...1298machine # [ 34.569281] systemd[1]: linger-users.service: Deactivated successfully.1299machine # [ 34.571309] systemd[1]: Finished linger-users.service.1300machine # [ 34.828958] nixos[2001]: finished switching to system configuration /nix/store/g6wmn9xvnyx781gjs5d3s2fflnlm93dl-nixos-system-machine-test1301machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.00 seconds)1302machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&11303machine # [ 35.094829] nixos[2144]: switching to system configuration /nix/store/xwa75mqpvr51s1s09ix97dh727qdb0yr-nixos-system-machine-test1304machine # [ 35.097579] systemd[1]: Stopped target Remote File Systems.1305machine # [ 35.100476] systemd[1]: Stopped target Local File Systems.1306machine # [ 35.453532] systemd[1]: Reload requested from client PID 2144 ('.switch-to-conf') (unit backdoor.service)...1307machine # [ 35.455655] systemd[1]: Reloading...1308machine # [ 35.990910] systemd[1]: Reloading finished in 532 ms.1309machine # [ 36.082049] systemd[538]: Reexecution requested from client PID 2213 ('switch-to-confi')...1310machine # [ 36.085905] systemd[538]: Reexecuting.1311machine # [ 36.149377] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1312machine # [ 36.275416] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1313machine # [ 36.282008] systemd[538]: Reload requested from client PID 2213 ('switch-to-confi')...1314machine # [ 36.283419] systemd[538]: Reloading...1315machine # [ 36.397359] systemd[538]: Reloading finished in 112 ms.1316machine # [ 36.412253] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1317machine # [ 36.423188] systemd[538]: Stopped Run user-specific NixOS activation.1318machine # [ 36.425931] systemd[538]: Stopping Run user-specific NixOS activation...1319machine # [ 36.429297] systemd[538]: Starting Run user-specific NixOS activation...1320machine # [ 36.462093] systemd[538]: Finished Run user-specific NixOS activation.1321machine # [ 36.467086] systemd[1]: Stopped target Reactivate sysinit units.1322machine # [ 36.471990] systemd[1]: Stopping Reactivate sysinit units...1323machine # [ 36.473226] systemd[1]: Reached target Reactivate sysinit units.1324machine # [ 36.475423] systemd[1]: Reloading test.service...1325machine # [ 36.503204] systemd[1]: Reloaded test.service.1326machine # [ 36.507032] systemd[1]: Reached target Local File Systems.1327machine # [ 36.511214] systemd[1]: Reached target Remote File Systems.1328machine # [ 36.516137] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1329machine # [ 36.519050] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1330machine # [ 36.524174] systemd[1]: Starting linger-users.service...1331machine # [ 36.536941] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1332machine # [ 36.544342] systemd[1]: Starting Create SUID/SGID Wrappers...1333machine # [ 36.545387] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1334machine # [ 36.546651] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671335machine # [ 36.558416] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1336machine # [ 36.563786] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1337machine # [ 36.573289] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1338machine # [ 36.618035] systemd[1]: linger-users.service: Deactivated successfully.1339machine # [ 36.622024] systemd[1]: Finished linger-users.service.1340machine # [ 36.769034] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1341machine # [ 36.771924] systemd[1]: Finished Create SUID/SGID Wrappers.1342machine # [ 37.028511] nixos[2144]: finished switching to system configuration /nix/store/xwa75mqpvr51s1s09ix97dh727qdb0yr-nixos-system-machine-test1343machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 2.20 seconds)1344machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&11345machine # [ 37.307994] nixos[2287]: switching to system configuration /nix/store/3r6q2s9gw2fnc44qjn2ar03bacpqbg0a-nixos-system-machine-test1346machine # [ 37.311538] systemd[1]: Stopped target Remote File Systems.1347machine # [ 37.314802] systemd[1]: Stopped target Local File Systems.1348machine # [ 37.683683] systemd[1]: Reload requested from client PID 2287 ('.switch-to-conf') (unit backdoor.service)...1349machine # [ 37.686256] systemd[1]: Reloading...1350machine # [ 38.140521] systemd[1]: Reloading finished in 452 ms.1351machine # [ 38.236994] systemd[538]: Reexecution requested from client PID 2356 ('switch-to-confi')...1352machine # [ 38.240567] systemd[538]: Reexecuting.1353machine # [ 38.292080] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1354machine # [ 38.421526] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1355machine # [ 38.429217] systemd[538]: Reload requested from client PID 2356 ('switch-to-confi')...1356machine # [ 38.433364] systemd[538]: Reloading...1357machine # [ 38.548584] systemd[538]: Reloading finished in 116 ms.1358machine # [ 38.564187] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1359machine # [ 38.576325] systemd[538]: Stopped Run user-specific NixOS activation.1360machine # [ 38.578926] systemd[538]: Stopping Run user-specific NixOS activation...1361machine # [ 38.581263] systemd[538]: Starting Run user-specific NixOS activation...1362machine # [ 38.614008] systemd[538]: Finished Run user-specific NixOS activation.1363machine # [ 38.620466] systemd[1]: Stopped target Reactivate sysinit units.1364machine # [ 38.622194] systemd[1]: Stopping Reactivate sysinit units...1365machine # [ 38.623082] systemd[1]: Reached target Reactivate sysinit units.1366machine # [ 38.626553] systemd[1]: Reached target Local File Systems.1367machine # [ 38.628999] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1368machine # [ 38.636307] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1369machine # [ 38.637897] systemd[1]: Reached target Remote File Systems.1370machine # [ 38.638745] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1371machine # [ 38.642859] systemd[1]: Starting Create SUID/SGID Wrappers...1372machine # [ 38.643882] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1373machine # [ 38.652399] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671374machine # [ 38.654900] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1375machine # [ 38.664562] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1376machine # [ 38.666058] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1377machine # [ 38.867360] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1378machine # [ 38.873735] systemd[1]: Finished Create SUID/SGID Wrappers.1379machine # [ 38.880130] systemd[1]: Starting linger-users.service...1380machine # [ 38.931538] systemd[1]: linger-users.service: Deactivated successfully.1381machine # [ 38.934823] systemd[1]: Finished linger-users.service.1382machine # [ 39.194336] nixos[2287]: finished switching to system configuration /nix/store/3r6q2s9gw2fnc44qjn2ar03bacpqbg0a-nixos-system-machine-test1383machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 2.17 seconds)1384machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&11385machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.43 seconds)1386machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/bin/switch-to-configuration test 2>&11387machine # [ 39.847521] nixos[2437]: switching to system configuration /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test1388machine # [ 39.854520] systemd[1]: Stopped target Local File Systems.1389machine # [ 39.855553] systemd[1]: Stopped target Remote File Systems.1390machine # [ 39.859433] systemd[1]: test.service: Deactivated successfully.1391machine # [ 39.861444] systemd[1]: Stopped test.service.1392machine # [ 40.659287] systemd[1]: Reload requested from client PID 2437 ('.switch-to-conf') (unit backdoor.service)...1393machine # [ 40.659798] systemd[1]: Reloading...1394machine # [ 41.650036] systemd[1]: Reloading finished in 982 ms.1395machine # [ 41.793884] systemd[538]: Reexecution requested from client PID 2507 ('switch-to-confi')...1396machine # [ 41.808803] systemd[538]: Reexecuting.1397machine # [ 41.915289] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1398machine # [ 42.111745] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1399machine # [ 42.122079] systemd[538]: Reload requested from client PID 2507 ('switch-to-confi')...1400machine # [ 42.124836] systemd[538]: Reloading...1401machine # [ 42.455653] systemd[538]: Reloading finished in 329 ms.1402machine # [ 42.476316] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1403machine # [ 42.524616] systemd[538]: Stopped Run user-specific NixOS activation.1404machine # [ 42.545132] systemd[538]: Stopping Run user-specific NixOS activation...1405machine # [ 42.550807] systemd[538]: Starting Run user-specific NixOS activation...1406machine # [ 42.640360] systemd[538]: Finished Run user-specific NixOS activation.1407machine # [ 42.674859] systemd[1]: Stopped target Reactivate sysinit units.1408machine # [ 42.683365] systemd[1]: Stopping Reactivate sysinit units...1409machine # [ 42.688487] systemd[1]: Reached target Reactivate sysinit units.1410machine # [ 42.690323] systemd[1]: Reached target Remote File Systems.1411machine # [ 42.691734] systemd[1]: Reached target Local File Systems.1412machine # [ 42.705842] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1413machine # [ 42.719768] systemd[1]: Starting Create SUID/SGID Wrappers...1414machine # [ 42.780332] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1415machine # [ 42.802683] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671416machine # [ 42.850262] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1417machine # [ 42.873356] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1418machine # [ 42.875648] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1419machine # [ 42.877992] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1420machine # [ 42.885219] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1421machine # [ 44.236593] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1422machine # [ 44.239044] systemd[1]: Finished Create SUID/SGID Wrappers.1423machine # [ 44.254103] systemd[1]: Starting linger-users.service...1424machine # [ 44.333682] systemd[1]: linger-users.service: Deactivated successfully.1425machine # [ 44.337345] systemd[1]: Finished linger-users.service.1426machine # [ 44.594558] nixos[2437]: finished switching to system configuration /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test1427machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 4.97 seconds)1428machine: must succeed: /nix/store/h4m331qrvvbwlvnwfd9mrlyhvhr8jg3s-separate-activation-script/bin/switch-to-configuration test 2>&11429machine # [ 44.840518] nixos[2579]: switching to system configuration /nix/store/kkvklpqfw3za8642gviw3hji4alpqdqc-nixos-system-machine-test1430machine # [ 44.843558] systemd[1]: Stopped target Local File Systems.1431machine # [ 44.846390] systemd[1]: Stopped target Remote File Systems.1432machine # [ 45.346726] systemd[1]: Reload requested from client PID 2579 ('.switch-to-conf') (unit backdoor.service)...1433machine # [ 45.349666] systemd[1]: Reloading...1434machine # [ 45.845671] systemd[1]: Reloading finished in 492 ms.1435machine # [ 45.959609] systemd[538]: Stopped Run user-specific NixOS activation.1436machine # [ 45.964849] systemd[538]: Reexecution requested from client PID 2648 ('switch-to-confi')...1437machine # [ 45.966455] systemd[538]: Reexecuting.1438machine # [ 46.032742] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1439machine # [ 46.233845] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1440machine # [ 46.244237] systemd[538]: Reload requested from client PID 2648 ('switch-to-confi')...1441machine # [ 46.246338] systemd[538]: Reloading...1442machine # [ 46.363643] systemd[538]: Reloading finished in 124 ms.1443machine # [ 46.380193] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1444machine # [ 46.397291] systemd[1]: Stopped target Reactivate sysinit units.1445machine # [ 46.398425] systemd[1]: Stopping Reactivate sysinit units...1446machine # [ 46.399307] systemd[1]: Reached target Reactivate sysinit units.1447machine # [ 46.412891] systemd[1]: Reached target Local File Systems.1448machine # [ 46.413952] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1449machine # [ 46.415584] systemd[1]: Starting Create SUID/SGID Wrappers...1450machine # [ 46.428320] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1451machine # [ 46.429917] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671452machine # [ 46.443698] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1453machine # [ 46.451265] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1454machine # [ 46.453754] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1455machine # [ 46.455203] systemd[1]: Reached target Remote File Systems.1456machine # [ 46.457302] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1457machine # [ 46.459652] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1458machine # [ 46.665192] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1459machine # [ 46.667682] systemd[1]: Finished Create SUID/SGID Wrappers.1460machine # [ 46.674991] systemd[1]: Starting linger-users.service...1461machine # [ 46.680501] systemd[1]: Starting test.service...1462machine # [ 46.738883] systemd[1]: Finished test.service.1463machine # [ 46.767030] systemd[1]: linger-users.service: Deactivated successfully.1464machine # [ 46.769477] systemd[1]: Finished linger-users.service.1465machine # [ 47.035444] nixos[2579]: finished switching to system configuration /nix/store/kkvklpqfw3za8642gviw3hji4alpqdqc-nixos-system-machine-test1466machine: (finished: must succeed: /nix/store/h4m331qrvvbwlvnwfd9mrlyhvhr8jg3s-separate-activation-script/bin/switch-to-configuration test 2>&1, in 2.44 seconds)1467machine: must succeed: ! test -e /run/current-system/activate1468machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.03 seconds)1469machine: must succeed: ! test -e /run/current-system/dry-activate1470machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.03 seconds)1471machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration1472machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.04 seconds)1473machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&11474machine # [ 47.413031] nixos[2727]: switching to system configuration /nix/store/2g6ccvbqhiwyk6xn2nv67lm80zj3nz6c-nixos-system-machine-test1475machine # [ 47.416461] systemd[1]: Stopped target Local File Systems.1476machine # [ 47.420450] systemd[1]: test.service: Deactivated successfully.1477machine # [ 47.422235] systemd[1]: Stopped test.service.1478machine # [ 47.422980] systemd[1]: Stopped target Remote File Systems.1479machine # [ 47.915956] systemd[1]: Reload requested from client PID 2727 ('.switch-to-conf') (unit backdoor.service)...1480machine # [ 47.919020] systemd[1]: Reloading...1481machine # [ 48.335401] systemd[1]: Reloading finished in 414 ms.1482machine # [ 48.437602] systemd[538]: Reexecution requested from client PID 2796 ('switch-to-confi')...1483machine # [ 48.442619] systemd[538]: Reexecuting.1484machine # [ 48.495593] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1485machine # [ 48.613192] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1486machine # [ 48.621164] systemd[538]: Reload requested from client PID 2796 ('switch-to-confi')...1487machine # [ 48.623642] systemd[538]: Reloading...1488machine # [ 48.749024] systemd[538]: Reloading finished in 124 ms.1489machine # [ 48.766170] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1490machine # [ 48.777507] systemd[538]: Starting Run user-specific NixOS activation...1491machine # [ 48.813687] systemd[538]: Finished Run user-specific NixOS activation.1492machine # [ 48.817214] systemd[538]: Stopped Run user-specific NixOS activation.1493machine # [ 48.820798] systemd[538]: Stopping Run user-specific NixOS activation...1494machine # [ 48.822914] systemd[538]: Starting Run user-specific NixOS activation...1495machine # [ 48.833970] systemd[1]: Stopped target Reactivate sysinit units.1496machine # [ 48.835088] systemd[1]: Stopping Reactivate sysinit units...1497machine # [ 48.839211] systemd[1]: Reached target Reactivate sysinit units.1498machine # [ 48.842639] systemd[1]: Reached target Remote File Systems.1499machine # [ 48.845189] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1500machine # [ 48.851367] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1501machine # [ 48.855706] systemd[1]: Reached target Local File Systems.1502machine # [ 48.865791] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1503machine # [ 48.876897] systemd[1]: Starting Create SUID/SGID Wrappers...1504machine # [ 48.877994] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1505machine # [ 48.879359] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671506machine # [ 48.897883] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1507machine # [ 48.899647] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1508machine # [ 48.913833] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1509machine # [ 48.931342] systemd[538]: Finished Run user-specific NixOS activation.1510machine # [ 49.123075] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1511machine # [ 49.125477] systemd[1]: Finished Create SUID/SGID Wrappers.1512machine # [ 49.131816] systemd[1]: Starting linger-users.service...1513machine # [ 49.137429] systemd[1]: Started test.service.1514machine # [ 49.183582] systemd[1]: test.service: Deactivated successfully.1515machine # [ 49.214234] systemd[1]: linger-users.service: Deactivated successfully.1516machine # [ 49.216371] systemd[1]: Finished linger-users.service.1517machine # [ 49.475673] nixos[2727]: finished switching to system configuration /nix/store/2g6ccvbqhiwyk6xn2nv67lm80zj3nz6c-nixos-system-machine-test1518machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 2.34 seconds)1519machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&11520machine # [ 49.811587] nixos[2872]: switching to system configuration /nix/store/7grn7zs6rxf5nh9mr6psc21rifaqcfb4-nixos-system-machine-test1521machine # [ 49.815380] systemd[1]: Stopped target Local File Systems.1522machine # [ 49.817861] systemd[1]: Stopped target Remote File Systems.1523machine # [ 50.248770] systemd[1]: Reload requested from client PID 2872 ('.switch-to-conf') (unit backdoor.service)...1524machine # [ 50.250517] systemd[1]: Reloading...1525machine # [ 50.810289] systemd[1]: Reloading finished in 558 ms.1526machine # [ 50.906937] systemd[538]: Reexecution requested from client PID 2941 ('switch-to-confi')...1527machine # [ 50.911388] systemd[538]: Reexecuting.1528machine # [ 50.976266] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1529machine # [ 51.103084] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1530machine # [ 51.110840] systemd[538]: Reload requested from client PID 2941 ('switch-to-confi')...1531machine # [ 51.115041] systemd[538]: Reloading...1532machine # [ 51.231578] systemd[538]: Reloading finished in 117 ms.1533machine # [ 51.248185] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1534machine # [ 51.258536] systemd[538]: Stopped Run user-specific NixOS activation.1535machine # [ 51.261333] systemd[538]: Stopping Run user-specific NixOS activation...1536machine # [ 51.263625] systemd[538]: Starting Run user-specific NixOS activation...1537machine # [ 51.298702] systemd[538]: Finished Run user-specific NixOS activation.1538machine # [ 51.303974] systemd[1]: Stopped target Reactivate sysinit units.1539machine # [ 51.305934] systemd[1]: Stopping Reactivate sysinit units...1540machine # [ 51.306821] systemd[1]: Reached target Reactivate sysinit units.1541machine # [ 51.309805] systemd[1]: Reached target Remote File Systems.1542machine # [ 51.318296] systemd[1]: Reached target Local File Systems.1543machine # [ 51.319284] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1544machine # [ 51.331424] systemd[1]: Starting Create SUID/SGID Wrappers...1545machine # [ 51.334930] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1546machine # [ 51.340249] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671547machine # [ 51.342822] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1548machine # [ 51.344688] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1549machine # [ 51.346008] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1550machine # [ 51.347257] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1551machine # [ 51.349793] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1552machine # [ 51.534458] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1553machine # [ 51.538317] systemd[1]: Finished Create SUID/SGID Wrappers.1554machine # [ 51.543161] systemd[1]: Starting escaped\x2ddash.service...1555machine # [ 51.549511] systemd[1]: Starting linger-users.service...1556machine # [ 51.598256] systemd[1]: Finished escaped\x2ddash.service.1557machine # [ 51.620536] systemd[1]: linger-users.service: Deactivated successfully.1558machine # [ 51.623004] systemd[1]: Finished linger-users.service.1559machine # [ 51.881104] nixos[2872]: finished switching to system configuration /nix/store/7grn7zs6rxf5nh9mr6psc21rifaqcfb4-nixos-system-machine-test1560machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 2.40 seconds)1561machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&11562machine # [ 52.117317] nixos[3014]: switching to system configuration /nix/store/jrmd4bjf5asmwmqzrx8ydwgin9zv6asb-nixos-system-machine-test1563machine # [ 52.120624] systemd[1]: Stopped target Local File Systems.1564machine # [ 52.122453] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1565machine # [ 52.126014] systemd[1]: Stopped escaped\x2ddash.service.1566machine # [ 52.127472] systemd[1]: Stopped target Remote File Systems.1567machine # [ 52.443002] systemd[1]: Reload requested from client PID 3014 ('.switch-to-conf') (unit backdoor.service)...1568machine # [ 52.445392] systemd[1]: Reloading...1569machine # [ 52.802533] systemd[1]: Reloading finished in 355 ms.1570machine # [ 52.933497] systemd[538]: Reexecution requested from client PID 3083 ('switch-to-confi')...1571machine # [ 52.936406] systemd[538]: Reexecuting.1572machine # [ 53.053111] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1573machine # [ 53.199787] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1574machine # [ 53.207068] systemd[538]: Reload requested from client PID 3083 ('switch-to-confi')...1575machine # [ 53.210947] systemd[538]: Reloading...1576machine # [ 53.338801] systemd[538]: Reloading finished in 129 ms.1577machine # [ 53.356259] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1578machine # [ 53.371733] systemd[538]: Stopped Run user-specific NixOS activation.1579machine # [ 53.373132] systemd[538]: Stopping Run user-specific NixOS activation...1580machine # [ 53.375789] systemd[538]: Starting Run user-specific NixOS activation...1581machine # [ 53.412573] systemd[538]: Finished Run user-specific NixOS activation.1582machine # [ 53.417438] systemd[1]: Stopped target Reactivate sysinit units.1583machine # [ 53.418529] systemd[1]: Stopping Reactivate sysinit units...1584machine # [ 53.419363] systemd[1]: Reached target Reactivate sysinit units.1585machine # [ 53.422938] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1586machine # [ 53.426846] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1587machine # [ 53.432680] systemd[1]: Reached target Remote File Systems.1588machine # [ 53.439031] systemd[1]: Starting escaped\x2ddash.service...1589machine # [ 53.449204] systemd[1]: Starting linger-users.service...1590machine # [ 53.459807] systemd[1]: Reached target Local File Systems.1591machine # [ 53.465412] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1592machine # [ 53.467062] systemd[1]: Starting Create SUID/SGID Wrappers...1593machine # [ 53.467950] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1594machine # [ 53.479810] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671595machine # [ 53.490676] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1596machine # [ 53.497974] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1597machine # [ 53.506133] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1598machine # [ 53.530607] systemd[1]: Finished escaped\x2ddash.service.1599machine # [ 53.568938] systemd[1]: linger-users.service: Deactivated successfully.1600machine # [ 53.572513] systemd[1]: Finished linger-users.service.1601machine # [ 53.728220] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1602machine # [ 53.732184] systemd[1]: Finished Create SUID/SGID Wrappers.1603machine # [ 53.986520] nixos[3014]: finished switching to system configuration /nix/store/jrmd4bjf5asmwmqzrx8ydwgin9zv6asb-nixos-system-machine-test1604machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 2.11 seconds)1605machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&11606machine # [ 54.320773] nixos[3156]: switching to system configuration /nix/store/j5wi19qaalmvsps62qfcc5w0i5qkvsf9-nixos-system-machine-test1607machine # [ 54.323715] systemd[1]: Stopped target Remote File Systems.1608machine # [ 54.327822] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1609machine # [ 54.329373] systemd[1]: Stopped escaped\x2ddash.service.1610machine # [ 54.331646] systemd[1]: Stopped target Local File Systems.1611machine # [ 54.666264] systemd[1]: Reload requested from client PID 3156 ('.switch-to-conf') (unit backdoor.service)...1612machine # [ 54.668495] systemd[1]: Reloading...1613machine # [ 55.045534] systemd[1]: Reloading finished in 374 ms.1614machine # [ 55.132435] systemd[538]: Reexecution requested from client PID 3225 ('switch-to-confi')...1615machine # [ 55.136776] systemd[538]: Reexecuting.1616machine # [ 55.195396] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1617machine # [ 55.310331] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1618machine # [ 55.317515] systemd[538]: Reload requested from client PID 3225 ('switch-to-confi')...1619machine # [ 55.321527] systemd[538]: Reloading...1620machine # [ 55.429319] systemd[538]: Reloading finished in 108 ms.1621machine # [ 55.444212] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1622machine # [ 55.454664] systemd[538]: Stopped Run user-specific NixOS activation.1623machine # [ 55.457248] systemd[538]: Stopping Run user-specific NixOS activation...1624machine # [ 55.459461] systemd[538]: Starting Run user-specific NixOS activation...1625machine # [ 55.494261] systemd[538]: Finished Run user-specific NixOS activation.1626machine # [ 55.498487] systemd[1]: Stopped target Reactivate sysinit units.1627machine # [ 55.501594] systemd[1]: Stopping Reactivate sysinit units...1628machine # [ 55.502506] systemd[1]: Reached target Reactivate sysinit units.1629machine # [ 55.505106] systemd[1]: Reached target Local File Systems.1630machine # [ 55.507392] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1631machine # [ 55.510985] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1632machine # [ 55.515466] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1633machine # [ 55.524770] systemd[1]: Starting Create SUID/SGID Wrappers...1634machine # [ 55.525689] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1635machine # [ 55.526927] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671636machine # [ 55.537491] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1637machine # [ 55.539181] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1638machine # [ 55.541582] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1639machine # [ 55.542899] systemd[1]: Reached target Remote File Systems.1640machine # [ 55.710078] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1641machine # [ 55.714664] systemd[1]: Finished Create SUID/SGID Wrappers.1642machine # [ 55.718556] systemd[1]: Starting -.service...1643machine # [ 55.721714] systemd[1]: Starting linger-users.service...1644machine # [ 55.763077] systemd[1]: Finished -.service.1645machine # [ 55.784785] systemd[1]: linger-users.service: Deactivated successfully.1646machine # [ 55.788172] systemd[1]: Finished linger-users.service.1647machine # [ 56.043123] nixos[3156]: finished switching to system configuration /nix/store/j5wi19qaalmvsps62qfcc5w0i5qkvsf9-nixos-system-machine-test1648machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 2.05 seconds)1649machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&11650machine # [ 56.286672] nixos[3298]: switching to system configuration /nix/store/9fllxkd6vzl08hipbcd7nbwl2hqbd209-nixos-system-machine-test1651machine # [ 56.289287] systemd[1]: Stopped target Remote File Systems.1652machine # [ 56.291981] systemd[1]: Stopped target Local File Systems.1653machine # [ 56.602688] systemd[1]: Reload requested from client PID 3298 ('.switch-to-conf') (unit backdoor.service)...1654machine # [ 56.605020] systemd[1]: Reloading...1655machine # [ 56.971360] systemd[1]: Reloading finished in 364 ms.1656machine # [ 57.063005] systemd[538]: Reexecution requested from client PID 3367 ('switch-to-confi')...1657machine # [ 57.067337] systemd[538]: Reexecuting.1658machine # [ 57.123534] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1659machine # [ 57.243930] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1660machine # [ 57.252136] systemd[538]: Reload requested from client PID 3367 ('switch-to-confi')...1661machine # [ 57.254688] systemd[538]: Reloading...1662machine # [ 57.370717] systemd[538]: Reloading finished in 115 ms.1663machine # [ 57.388218] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1664machine # [ 57.399504] systemd[538]: Stopped Run user-specific NixOS activation.1665machine # [ 57.402230] systemd[538]: Stopping Run user-specific NixOS activation...1666machine # [ 57.404812] systemd[538]: Starting Run user-specific NixOS activation...1667machine # [ 57.438869] systemd[538]: Finished Run user-specific NixOS activation.1668machine # [ 57.443812] systemd[1]: Stopped target Reactivate sysinit units.1669machine # [ 57.448627] systemd[1]: Stopping Reactivate sysinit units...1670machine # [ 57.449642] systemd[1]: Reached target Reactivate sysinit units.1671machine # [ 57.452418] systemd[1]: Reloading -.service...1672machine # [ 57.479757] systemd[1]: Reloaded -.service.1673machine # [ 57.485878] systemd[1]: Reached target Remote File Systems.1674machine # [ 57.490508] systemd[1]: Starting linger-users.service...1675machine # [ 57.494313] systemd[1]: Reached target Local File Systems.1676machine # [ 57.504138] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1677machine # [ 57.514360] systemd[1]: Starting Create SUID/SGID Wrappers...1678machine # [ 57.515375] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1679machine # [ 57.528186] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671680machine # [ 57.530588] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1681machine # [ 57.541848] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1682machine # [ 57.543283] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1683machine # [ 57.549244] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1684machine # [ 57.550704] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1685machine # [ 57.598087] systemd[1]: linger-users.service: Deactivated successfully.1686machine # [ 57.601093] systemd[1]: Finished linger-users.service.1687machine # [ 57.768238] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1688machine # [ 57.770655] systemd[1]: Finished Create SUID/SGID Wrappers.1689machine # [ 58.028383] nixos[3298]: finished switching to system configuration /nix/store/9fllxkd6vzl08hipbcd7nbwl2hqbd209-nixos-system-machine-test1690machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.99 seconds)1691machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&11692machine # [ 58.803295] nixos[3440]: switching to system configuration /nix/store/6548afcw4v6j8f07xj6pjz8hcv0j4x4b-nixos-system-machine-test1693machine # [ 58.807570] systemd[1]: Stopped target Local File Systems.1694machine # [ 58.809340] systemd[1]: Stopped target Remote File Systems.1695machine # [ 58.810190] systemd[1]: -.service: Deactivated successfully.1696machine # [ 58.811000] systemd[1]: Stopped -.service.1697machine # [ 59.111670] systemd[1]: Reload requested from client PID 3440 ('.switch-to-conf') (unit backdoor.service)...1698machine # [ 59.114032] systemd[1]: Reloading...1699machine # [ 59.478704] systemd[1]: Reloading finished in 363 ms.1700machine # [ 59.568369] systemd[538]: Reexecution requested from client PID 3509 ('switch-to-confi')...1701machine # [ 59.573154] systemd[538]: Reexecuting.1702machine # [ 59.627380] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1703machine # [ 59.744988] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1704machine # [ 59.752535] systemd[538]: Reload requested from client PID 3509 ('switch-to-confi')...1705machine # [ 59.753912] systemd[538]: Reloading...1706machine # [ 59.863361] systemd[538]: Reloading finished in 108 ms.1707machine # [ 59.880238] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1708machine # [ 59.891832] systemd[538]: Stopped Run user-specific NixOS activation.1709machine # [ 59.894534] systemd[538]: Stopping Run user-specific NixOS activation...1710machine # [ 59.896666] systemd[538]: Starting Run user-specific NixOS activation...1711machine # [ 59.929056] systemd[538]: Finished Run user-specific NixOS activation.1712machine # [ 59.933732] systemd[1]: Stopped target Reactivate sysinit units.1713machine # [ 59.935753] systemd[1]: Stopping Reactivate sysinit units...1714machine # [ 59.939191] systemd[1]: Reached target Reactivate sysinit units.1715machine # [ 59.942128] systemd[1]: Reached target Local File Systems.1716machine # [ 59.944448] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1717machine # [ 59.945860] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1718machine # [ 59.950147] systemd[1]: Reached target Remote File Systems.1719machine # [ 59.955688] systemd[1]: Starting linger-users.service...1720machine # [ 59.959453] systemd[1]: Starting required-service.service...1721machine # [ 59.965148] systemd[1]: Starting test-service.service...1722machine # [ 59.986691] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1723machine # [ 59.996239] systemd[1]: Starting Create SUID/SGID Wrappers...1724machine # [ 59.997337] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1725machine # [ 59.998614] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671726machine # [ 60.013715] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1727machine # [ 60.015484] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1728machine # [ 60.027813] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1729machine # [ 60.061980] systemd[1]: Finished test-service.service.1730machine # [ 60.074769] systemd[1]: Finished required-service.service.1731machine # [ 60.100994] systemd[1]: linger-users.service: Deactivated successfully.1732machine # [ 60.102843] systemd[1]: Finished linger-users.service.1733machine # [ 60.258713] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1734machine # [ 60.260796] systemd[1]: Finished Create SUID/SGID Wrappers.1735machine # [ 60.518828] nixos[3440]: finished switching to system configuration /nix/store/6548afcw4v6j8f07xj6pjz8hcv0j4x4b-nixos-system-machine-test1736machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 2.49 seconds)1737machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&11738machine # [ 60.757287] nixos[3584]: switching to system configuration /nix/store/cjwxxfvj33dzdswjjvjdlinkfmbw6vgh-nixos-system-machine-test1739machine # [ 60.760573] systemd[1]: Stopped target Remote File Systems.1740machine # [ 60.762304] systemd[1]: required-service.service: Deactivated successfully.1741machine # [ 60.765295] systemd[1]: Stopped required-service.service.1742machine # [ 60.766187] systemd[1]: test-service.service: Deactivated successfully.1743machine # [ 60.767129] systemd[1]: Stopped test-service.service.1744machine # [ 60.768505] systemd[1]: Stopped target Local File Systems.1745machine # [ 61.087132] systemd[1]: Reload requested from client PID 3584 ('.switch-to-conf') (unit backdoor.service)...1746machine # [ 61.089375] systemd[1]: Reloading...1747machine # [ 61.449823] systemd[1]: Reloading finished in 359 ms.1748machine # [ 61.541823] systemd[538]: Reexecution requested from client PID 3653 ('switch-to-confi')...1749machine # [ 61.543290] systemd[538]: Reexecuting.1750machine # [ 61.603637] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1751machine # [ 61.727213] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1752machine # [ 61.732642] systemd[538]: Reload requested from client PID 3653 ('switch-to-confi')...1753machine # [ 61.733989] systemd[538]: Reloading...1754machine # [ 61.841152] systemd[538]: Reloading finished in 105 ms.1755machine # [ 61.856180] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1756machine # [ 61.867854] systemd[538]: Stopped Run user-specific NixOS activation.1757machine # [ 61.870448] systemd[538]: Stopping Run user-specific NixOS activation...1758machine # [ 61.872516] systemd[538]: Starting Run user-specific NixOS activation...1759machine # [ 61.903754] systemd[538]: Finished Run user-specific NixOS activation.1760machine # [ 61.907862] systemd[1]: Stopped target Reactivate sysinit units.1761machine # [ 61.910482] systemd[1]: Stopping Reactivate sysinit units...1762machine # [ 61.911345] systemd[1]: Reached target Reactivate sysinit units.1763machine # [ 61.915851] systemd[1]: Reached target Local File Systems.1764machine # [ 61.919846] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1765machine # [ 61.924691] systemd[1]: Starting Create SUID/SGID Wrappers...1766machine # [ 61.925576] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1767machine # [ 61.926828] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671768machine # [ 61.938217] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1769machine # [ 61.939920] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1770machine # [ 61.951960] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1771machine # [ 61.954433] systemd[1]: Reached target Remote File Systems.1772machine # [ 61.956411] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1773machine # [ 61.957783] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1774machine # [ 62.117540] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1775machine # [ 62.121388] systemd[1]: Finished Create SUID/SGID Wrappers.1776machine # [ 62.127738] systemd[1]: Starting linger-users.service...1777machine # [ 62.131961] systemd[1]: Starting required-service.service...1778machine # [ 62.135938] systemd[1]: Starting test-service.service...1779machine # [ 62.194485] systemd[1]: Finished required-service.service.1780machine # [ 62.197807] systemd[1]: Finished test-service.service.1781machine # [ 62.219126] systemd[1]: linger-users.service: Deactivated successfully.1782machine # [ 62.221347] systemd[1]: Finished linger-users.service.1783machine # [ 62.478604] nixos[3584]: finished switching to system configuration /nix/store/cjwxxfvj33dzdswjjvjdlinkfmbw6vgh-nixos-system-machine-test1784machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.96 seconds)1785machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&11786machine # [ 62.719715] nixos[3728]: switching to system configuration /nix/store/h63bhwyjr0cm2hv1rjx9rabi8a7v7abl-nixos-system-machine-test1787machine # [ 62.723008] systemd[1]: Stopped target Local File Systems.1788machine # [ 62.725867] systemd[1]: required-service.service: Deactivated successfully.1789machine # [ 62.726958] systemd[1]: Stopped required-service.service.1790machine # [ 62.727771] systemd[1]: test-service.service: Deactivated successfully.1791machine # [ 62.732505] systemd[1]: Stopped test-service.service.1792machine # [ 62.733632] systemd[1]: Stopped target Remote File Systems.1793machine # [ 63.043186] systemd[1]: Reload requested from client PID 3728 ('.switch-to-conf') (unit backdoor.service)...1794machine # [ 63.045358] systemd[1]: Reloading...1795machine # [ 63.390440] systemd[1]: Reloading finished in 343 ms.1796machine # [ 63.476436] systemd[538]: Reexecution requested from client PID 3797 ('switch-to-confi')...1797machine # [ 63.479722] systemd[538]: Reexecuting.1798machine # [ 63.535262] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1799machine # [ 63.649563] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1800machine # [ 63.657198] systemd[538]: Reload requested from client PID 3797 ('switch-to-confi')...1801machine # [ 63.658571] systemd[538]: Reloading...1802machine # [ 63.767652] systemd[538]: Reloading finished in 107 ms.1803machine # [ 63.784202] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1804machine # [ 63.797598] systemd[538]: Stopped Run user-specific NixOS activation.1805machine # [ 63.798714] systemd[538]: Stopping Run user-specific NixOS activation...1806machine # [ 63.800937] systemd[538]: Starting Run user-specific NixOS activation...1807machine # [ 63.834427] systemd[538]: Finished Run user-specific NixOS activation.1808machine # [ 63.839122] systemd[1]: Stopped target Reactivate sysinit units.1809machine # [ 63.841717] systemd[1]: Stopping Reactivate sysinit units...1810machine # [ 63.842650] systemd[1]: Reached target Reactivate sysinit units.1811machine # [ 63.847910] systemd[1]: Starting required-service.service...1812machine # [ 63.853164] systemd[1]: Reached target Remote File Systems.1813machine # [ 63.857524] systemd[1]: Starting linger-users.service...1814machine # [ 63.868635] systemd[1]: Starting test-service.service...1815machine # [ 63.886023] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1816machine # [ 63.887513] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1817machine # [ 63.900944] systemd[1]: Reached target Local File Systems.1818machine # [ 63.901900] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1819machine # [ 63.903608] systemd[1]: Starting Create SUID/SGID Wrappers...1820machine # [ 63.926649] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1821machine # [ 63.933335] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671822machine # [ 63.935696] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1823machine # [ 63.947310] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1824machine # [ 63.958111] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1825machine # [ 63.967497] systemd[1]: Finished required-service.service.1826machine # [ 63.971208] systemd[1]: Finished test-service.service.1827machine # [ 64.001878] systemd[1]: linger-users.service: Deactivated successfully.1828machine # [ 64.003740] systemd[1]: Finished linger-users.service.1829machine # [ 64.143361] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1830machine # [ 64.146512] systemd[1]: Finished Create SUID/SGID Wrappers.1831machine # [ 64.402590] nixos[3728]: finished switching to system configuration /nix/store/h63bhwyjr0cm2hv1rjx9rabi8a7v7abl-nixos-system-machine-test1832machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.92 seconds)1833machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&11834machine # [ 64.634637] nixos[3872]: switching to system configuration /nix/store/1fyqb8rjaqqysqs6wfjwxzd9hginbk76-nixos-system-machine-test1835machine # [ 64.637893] systemd[1]: required-service.service: Deactivated successfully.1836machine # [ 64.641567] systemd[1]: Stopped required-service.service.1837machine # [ 64.642481] systemd[1]: test-service.service: Deactivated successfully.1838machine # [ 64.643425] systemd[1]: Stopped test-service.service.1839machine # [ 64.646278] systemd[1]: Stopped target Remote File Systems.1840machine # [ 64.647138] systemd[1]: Stopped target Local File Systems.1841machine # [ 64.941417] systemd[1]: Reload requested from client PID 3872 ('.switch-to-conf') (unit backdoor.service)...1842machine # [ 64.943417] systemd[1]: Reloading...1843machine # [ 65.283060] systemd[1]: Reloading finished in 338 ms.1844machine # [ 65.371738] systemd[538]: Reexecution requested from client PID 3941 ('switch-to-confi')...1845machine # [ 65.374298] systemd[538]: Reexecuting.1846machine # [ 65.431465] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1847machine # [ 65.545532] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1848machine # [ 65.552370] systemd[538]: Reload requested from client PID 3941 ('switch-to-confi')...1849machine # [ 65.554941] systemd[538]: Reloading...1850machine # [ 65.661297] systemd[538]: Reloading finished in 105 ms.1851machine # [ 65.677746] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1852machine # [ 65.686432] systemd[538]: Stopped Run user-specific NixOS activation.1853machine # [ 65.688885] systemd[538]: Stopping Run user-specific NixOS activation...1854machine # [ 65.691074] systemd[538]: Starting Run user-specific NixOS activation...1855machine # [ 65.725000] systemd[538]: Finished Run user-specific NixOS activation.1856machine # [ 65.729615] systemd[1]: Stopped target Reactivate sysinit units.1857machine # [ 65.731119] systemd[1]: Stopping Reactivate sysinit units...1858machine # [ 65.731990] systemd[1]: Reached target Reactivate sysinit units.1859machine # [ 65.735160] systemd[1]: Reached target Local File Systems.1860machine # [ 65.741614] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1861machine # [ 65.743215] systemd[1]: Starting Create SUID/SGID Wrappers...1862machine # [ 65.751940] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1863machine # [ 65.758859] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671864machine # [ 65.762309] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1865machine # [ 65.763933] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1866machine # [ 65.771053] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1867machine # [ 65.774915] systemd[1]: Reached target Remote File Systems.1868machine # [ 65.776484] systemd[1]: Created slice Slice /system/instantiated.1869machine # [ 65.778435] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1870machine # [ 65.780134] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1871machine # [ 65.931792] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1872machine # [ 65.936598] systemd[1]: Finished Create SUID/SGID Wrappers.1873machine # [ 65.940365] systemd[1]: Starting instantiated@one.service...1874machine # [ 65.948343] systemd[1]: Starting instantiated@two.service...1875machine # [ 65.949471] systemd[1]: Starting linger-users.service...1876machine # [ 66.006474] systemd[1]: Finished instantiated@one.service.1877machine # [ 66.009949] systemd[1]: Finished instantiated@two.service.1878machine # [ 66.029610] systemd[1]: linger-users.service: Deactivated successfully.1879machine # [ 66.031336] systemd[1]: Finished linger-users.service.1880machine # [ 66.288133] nixos[3872]: finished switching to system configuration /nix/store/1fyqb8rjaqqysqs6wfjwxzd9hginbk76-nixos-system-machine-test1881machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.89 seconds)1882machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&11883machine # [ 66.540324] nixos[4016]: switching to system configuration /nix/store/wxajqfka5jiwzb223fblgxbql1n83ih3-nixos-system-machine-test1884machine # [ 66.543066] systemd[1]: Stopped target Remote File Systems.1885machine # [ 66.546729] systemd[1]: instantiated@one.service: Deactivated successfully.1886machine # [ 66.547862] systemd[1]: Stopped instantiated@one.service.1887machine # [ 66.549314] systemd[1]: instantiated@two.service: Deactivated successfully.1888machine # [ 66.550351] systemd[1]: Stopped instantiated@two.service.1889machine # [ 66.551153] systemd[1]: Stopped target Local File Systems.1890machine # [ 66.855115] systemd[1]: Reload requested from client PID 4016 ('.switch-to-conf') (unit backdoor.service)...1891machine # [ 66.857265] systemd[1]: Reloading...1892machine # [ 67.186320] systemd[1]: Reloading finished in 327 ms.1893machine # [ 67.277487] systemd[538]: Reexecution requested from client PID 4085 ('switch-to-confi')...1894machine # [ 67.282097] systemd[538]: Reexecuting.1895machine # [ 67.343931] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1896machine # [ 67.461462] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1897machine # [ 67.468254] systemd[538]: Reload requested from client PID 4085 ('switch-to-confi')...1898machine # [ 67.470979] systemd[538]: Reloading...1899machine # [ 67.578469] systemd[538]: Reloading finished in 106 ms.1900machine # [ 67.597837] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1901machine # [ 67.606126] systemd[538]: Stopped Run user-specific NixOS activation.1902machine # [ 67.608792] systemd[538]: Stopping Run user-specific NixOS activation...1903machine # [ 67.611054] systemd[538]: Starting Run user-specific NixOS activation...1904machine # [ 67.644762] systemd[538]: Finished Run user-specific NixOS activation.1905machine # [ 67.649167] systemd[1]: Stopped target Reactivate sysinit units.1906machine # [ 67.652213] systemd[1]: Stopping Reactivate sysinit units...1907machine # [ 67.653161] systemd[1]: Reached target Reactivate sysinit units.1908machine # [ 67.654027] systemd[1]: Reached target Remote File Systems.1909machine # [ 67.656446] systemd[1]: Reached target Local File Systems.1910machine # [ 67.662202] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1911machine # [ 67.663851] systemd[1]: Starting Create SUID/SGID Wrappers...1912machine # [ 67.672700] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1913machine # [ 67.674084] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671914machine # [ 67.685340] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1915machine # [ 67.687098] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1916machine # [ 67.691156] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1917machine # [ 67.693621] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1918machine # [ 67.694987] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1919machine # [ 67.855402] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1920machine # [ 67.860679] systemd[1]: Finished Create SUID/SGID Wrappers.1921machine # [ 67.864233] systemd[1]: Starting instantiated@one.service...1922machine # [ 67.868552] systemd[1]: Starting instantiated@two.service...1923machine # [ 67.871655] systemd[1]: Starting linger-users.service...1924machine # [ 67.929610] systemd[1]: Finished instantiated@one.service.1925machine # [ 67.933818] systemd[1]: Finished instantiated@two.service.1926machine # [ 67.953635] systemd[1]: linger-users.service: Deactivated successfully.1927machine # [ 67.956582] systemd[1]: Finished linger-users.service.1928machine # [ 68.212687] nixos[4016]: finished switching to system configuration /nix/store/wxajqfka5jiwzb223fblgxbql1n83ih3-nixos-system-machine-test1929machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.93 seconds)1930(finished: subtest: services, in 46.99 seconds)1931subtest: failing units1932machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11933machine # [ 68.439924] nixos[4160]: switching to system configuration /nix/store/f9j1g17kp1cycddhw7flsj254qs35lcw-nixos-system-machine-test1934machine # [ 68.443458] systemd[1]: instantiated@two.service: Deactivated successfully.1935machine # [ 68.446523] systemd[1]: Stopped instantiated@two.service.1936machine # [ 68.447465] systemd[1]: instantiated@one.service: Deactivated successfully.1937machine # [ 68.450958] systemd[1]: Stopped instantiated@one.service.1938machine # [ 68.451859] systemd[1]: Stopped target Remote File Systems.1939machine # [ 68.453236] systemd[1]: Stopped target Local File Systems.1940machine # [ 68.738932] systemd[1]: Reload requested from client PID 4160 ('.switch-to-conf') (unit backdoor.service)...1941machine # [ 68.741211] systemd[1]: Reloading...1942machine # [ 69.067257] systemd[1]: Reloading finished in 324 ms.1943machine # [ 69.155094] systemd[538]: Reexecution requested from client PID 4229 ('switch-to-confi')...1944machine # [ 69.159621] systemd[538]: Reexecuting.1945machine # [ 69.219531] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1946machine # [ 69.334565] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1947machine # [ 69.341683] systemd[538]: Reload requested from client PID 4229 ('switch-to-confi')...1948machine # [ 69.344367] systemd[538]: Reloading...1949machine # [ 69.453125] systemd[538]: Reloading finished in 107 ms.1950machine # [ 69.469781] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1951machine # [ 69.477824] systemd[538]: Stopped Run user-specific NixOS activation.1952machine # [ 69.480083] systemd[538]: Stopping Run user-specific NixOS activation...1953machine # [ 69.482419] systemd[538]: Starting Run user-specific NixOS activation...1954machine # [ 69.511802] systemd[538]: Finished Run user-specific NixOS activation.1955machine # [ 69.516127] systemd[1]: Stopped target Reactivate sysinit units.1956machine # [ 69.519958] systemd[1]: Stopping Reactivate sysinit units...1957machine # [ 69.524778] systemd[1]: Reached target Reactivate sysinit units.1958machine # [ 69.525743] systemd[1]: Reached target Remote File Systems.1959machine # [ 69.534302] systemd[1]: Starting linger-users.service...1960machine # [ 69.535269] systemd[1]: Starting test.service...1961machine # [ 69.535976] systemd[1]: Reached target Local File Systems.1962machine # [ 69.546282] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1963machine # [ 69.547722] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1964machine # [ 69.566929] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1965machine # [ 69.574732] systemd[1]: Starting Create SUID/SGID Wrappers...1966machine # [ 69.581285] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1967machine # [ 69.585787] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671968machine # [ 69.594661] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1969machine # [ 69.605719] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1970machine # [ 69.609861] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1971machine # [ 69.611239] systemd[1]: Finished test.service.1972machine # [ 69.644766] systemd[1]: linger-users.service: Deactivated successfully.1973machine # [ 69.649304] systemd[1]: Finished linger-users.service.1974machine # [ 69.789037] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1975machine # [ 69.792315] systemd[1]: Finished Create SUID/SGID Wrappers.1976machine # [ 70.049444] nixos[4160]: finished switching to system configuration /nix/store/f9j1g17kp1cycddhw7flsj254qs35lcw-nixos-system-machine-test1977machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.84 seconds)1978machine: must fail: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&11979machine # [ 70.283111] nixos[4302]: switching to system configuration /nix/store/i6g526s5ayz1zc4597fvilb68m2kr5xd-nixos-system-machine-test1980machine # [ 70.286552] systemd[1]: Stopped target Remote File Systems.1981machine # [ 70.288863] systemd[1]: test.service: Deactivated successfully.1982machine # [ 70.289864] systemd[1]: Stopped test.service.1983machine # [ 70.291467] systemd[1]: Stopped target Local File Systems.1984machine # [ 70.611843] systemd[1]: Reload requested from client PID 4302 ('.switch-to-conf') (unit backdoor.service)...1985machine # [ 70.614707] systemd[1]: Reloading...1986machine # [ 70.942572] systemd[1]: Reloading finished in 325 ms.1987machine # [ 71.032054] systemd[538]: Reexecution requested from client PID 4371 ('switch-to-confi')...1988machine # [ 71.033489] systemd[538]: Reexecuting.1989machine # [ 71.092149] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1990machine # [ 71.205707] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1991machine # [ 71.213455] systemd[538]: Reload requested from client PID 4371 ('switch-to-confi')...1992machine # [ 71.217634] systemd[538]: Reloading...1993machine # [ 71.325411] systemd[538]: Reloading finished in 108 ms.1994machine # [ 71.341949] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1995machine # [ 71.351217] systemd[538]: Stopped Run user-specific NixOS activation.1996machine # [ 71.353837] systemd[538]: Stopping Run user-specific NixOS activation...1997machine # [ 71.356188] systemd[538]: Starting Run user-specific NixOS activation...1998machine # [ 71.389752] systemd[538]: Finished Run user-specific NixOS activation.1999machine # [ 71.393874] systemd[1]: Stopped target Reactivate sysinit units.2000machine # [ 71.396870] systemd[1]: Stopping Reactivate sysinit units...2001machine # [ 71.397843] systemd[1]: Reached target Reactivate sysinit units.2002machine # [ 71.402930] systemd[1]: Reached target Local File Systems.2003machine # [ 71.403895] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2004machine # [ 71.413979] systemd[1]: Starting Create SUID/SGID Wrappers...2005machine # [ 71.414978] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2006machine # [ 71.423095] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672007machine # [ 71.434140] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2008machine # [ 71.435950] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2009machine # [ 71.437721] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2010machine # [ 71.438969] systemd[1]: Reached target Remote File Systems.2011machine # [ 71.439778] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2012machine # [ 71.441253] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2013machine # [ 71.604364] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2014machine # [ 71.607365] systemd[1]: Finished Create SUID/SGID Wrappers.2015machine # [ 71.612189] systemd[1]: Starting linger-users.service...2016machine # [ 71.616589] systemd[1]: Starting test.service...2017machine # [ 71.656350] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE2018machine # [ 71.661008] systemd[1]: test.service: Failed with result 'exit-code'.2019machine # [ 71.662406] systemd[1]: Failed to start test.service.2020machine # [ 71.682521] systemd[1]: linger-users.service: Deactivated successfully.2021machine # [ 71.684556] systemd[1]: Finished linger-users.service.2022machine # [ 71.963599] nixos[4302]: switching to system configuration /nix/store/i6g526s5ayz1zc4597fvilb68m2kr5xd-nixos-system-machine-test failed (status 4)2023machine: (finished: must fail: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.91 seconds)2024machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12025machine # [ 72.191194] nixos[4445]: switching to system configuration /nix/store/1sf2rc83rm3b48ng52sg62s0xah540ra-nixos-system-machine-test2026machine # [ 72.193864] systemd[1]: Stopped target Local File Systems.2027machine # [ 72.196183] systemd[1]: Stopped target Remote File Systems.2028machine # [ 72.486550] systemd[1]: Reload requested from client PID 4445 ('.switch-to-conf') (unit backdoor.service)...2029machine # [ 72.488694] systemd[1]: Reloading...2030machine # [ 72.843176] systemd[1]: Reloading finished in 353 ms.2031machine # [ 72.952558] systemd[538]: Reexecution requested from client PID 4514 ('switch-to-confi')...2032machine # [ 72.954149] systemd[538]: Reexecuting.2033machine # [ 73.011750] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2034machine # [ 73.145844] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2035machine # [ 73.153426] systemd[538]: Reload requested from client PID 4514 ('switch-to-confi')...2036machine # [ 73.157690] systemd[538]: Reloading...2037machine # [ 73.272723] systemd[538]: Reloading finished in 116 ms.2038machine # [ 73.288190] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2039machine # [ 73.302051] systemd[538]: Stopped Run user-specific NixOS activation.2040machine # [ 73.303188] systemd[538]: Stopping Run user-specific NixOS activation...2041machine # [ 73.307032] systemd[538]: Starting Run user-specific NixOS activation...2042machine # [ 73.342859] systemd[538]: Finished Run user-specific NixOS activation.2043machine # [ 73.348859] systemd[1]: Stopped target Reactivate sysinit units.2044machine # [ 73.349969] systemd[1]: Stopping Reactivate sysinit units...2045machine # [ 73.350813] systemd[1]: Reached target Reactivate sysinit units.2046machine # [ 73.355979] systemd[1]: Reached target Local File Systems.2047machine # [ 73.359027] systemd[1]: Reached target Remote File Systems.2048machine # [ 73.363373] systemd[1]: Started autorestart.service.2049machine # [ 73.366974] systemd[1]: Starting linger-users.service...2050machine # [ 73.377042] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2051machine # [ 73.378697] systemd[1]: Starting Create SUID/SGID Wrappers...2052machine # [ 73.379581] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2053machine # [ 73.396624] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672054machine # [ 73.399027] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2055machine # [ 73.409315] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2056machine # [ 73.410710] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2057machine # [ 73.411978] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2058machine # [ 73.420638] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2059machine # [ 73.462193] systemd[1]: autorestart.service: Deactivated successfully.2060machine # [ 73.509754] systemd[1]: linger-users.service: Deactivated successfully.2061machine # [ 73.514064] systemd[1]: Finished linger-users.service.2062machine # [ 73.665580] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2063machine # [ 73.669915] systemd[1]: Finished Create SUID/SGID Wrappers.2064machine # [ 73.934372] nixos[4445]: finished switching to system configuration /nix/store/1sf2rc83rm3b48ng52sg62s0xah540ra-nixos-system-machine-test2065machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.97 seconds)2066machine # [ 73.986978] systemd[1]: Stopped autorestart.service.2067machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12068machine # [ 74.248481] nixos[4592]: switching to system configuration /nix/store/1sf2rc83rm3b48ng52sg62s0xah540ra-nixos-system-machine-test2069machine # [ 74.250996] systemd[1]: Stopped target Local File Systems.2070machine # [ 74.253456] systemd[1]: Stopped target Remote File Systems.2071machine # [ 74.529570] systemd[1]: Reload requested from client PID 4592 ('.switch-to-conf') (unit backdoor.service)...2072machine # [ 74.531533] systemd[1]: Reloading...2073machine # [ 74.849333] systemd[1]: Reloading finished in 316 ms.2074machine # [ 74.932200] systemd[538]: Reexecution requested from client PID 4661 ('switch-to-confi')...2075machine # [ 74.937135] systemd[538]: Reexecuting.2076machine # [ 74.995634] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2077machine # [ 75.121498] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2078machine # [ 75.128288] systemd[538]: Reload requested from client PID 4661 ('switch-to-confi')...2079machine # [ 75.132142] systemd[538]: Reloading...2080machine # [ 75.240049] systemd[538]: Reloading finished in 108 ms.2081machine # [ 75.256193] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2082machine # [ 75.267046] systemd[538]: Stopped Run user-specific NixOS activation.2083machine # [ 75.269525] systemd[538]: Stopping Run user-specific NixOS activation...2084machine # [ 75.271719] systemd[538]: Starting Run user-specific NixOS activation...2085machine # [ 75.305093] systemd[538]: Finished Run user-specific NixOS activation.2086machine # [ 75.309539] systemd[1]: Stopped target Reactivate sysinit units.2087machine # [ 75.311561] systemd[1]: Stopping Reactivate sysinit units...2088machine # [ 75.313970] systemd[1]: Reached target Reactivate sysinit units.2089machine # [ 75.319553] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2090machine # [ 75.322245] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2091machine # [ 75.325158] systemd[1]: Reached target Local File Systems.2092machine # [ 75.328884] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2093machine # [ 75.332558] systemd[1]: Starting Create SUID/SGID Wrappers...2094machine # [ 75.333456] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2095machine # [ 75.334745] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672096machine # [ 75.345892] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2097machine # [ 75.347580] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2098machine # [ 75.351451] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2099machine # [ 75.352970] systemd[1]: Reached target Remote File Systems.2100machine # [ 75.509758] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2101machine # [ 75.512979] systemd[1]: Finished Create SUID/SGID Wrappers.2102machine # [ 75.517118] systemd[1]: Started autorestart.service.2103machine # [ 75.522960] systemd[1]: Starting linger-users.service...2104machine # [ 75.560279] systemd[1]: autorestart.service: Deactivated successfully.2105machine # [ 75.580216] systemd[1]: linger-users.service: Deactivated successfully.2106machine # [ 75.583290] systemd[1]: Finished linger-users.service.2107machine # [ 75.839965] nixos[4592]: finished switching to system configuration /nix/store/1sf2rc83rm3b48ng52sg62s0xah540ra-nixos-system-machine-test2108machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.85 seconds)2109machine # [ 75.881528] systemd[1]: Stopped autorestart.service.2110machine: must fail: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&12111machine # [ 76.115718] nixos[4739]: switching to system configuration /nix/store/fl4mv0i2x8hmdrqf5xsxymhb9nyfmlp2-nixos-system-machine-test2112machine # [ 76.118378] systemd[1]: Stopped target Local File Systems.2113machine # [ 76.121063] systemd[1]: Stopped target Remote File Systems.2114machine # [ 76.431791] systemd[1]: Reload requested from client PID 4739 ('.switch-to-conf') (unit backdoor.service)...2115machine # [ 76.434259] systemd[1]: Reloading...2116machine # [ 76.805646] systemd[1]: Reloading finished in 369 ms.2117machine # [ 76.896656] systemd[538]: Reexecution requested from client PID 4808 ('switch-to-confi')...2118machine # [ 76.899372] systemd[538]: Reexecuting.2119machine # [ 76.959439] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2120machine # [ 77.073175] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2121machine # [ 77.080845] systemd[538]: Reload requested from client PID 4808 ('switch-to-confi')...2122machine # [ 77.082266] systemd[538]: Reloading...2123machine # [ 77.193543] systemd[538]: Reloading finished in 110 ms.2124machine # [ 77.208202] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2125machine # [ 77.219566] systemd[538]: Stopped Run user-specific NixOS activation.2126machine # [ 77.222182] systemd[538]: Stopping Run user-specific NixOS activation...2127machine # [ 77.224698] systemd[538]: Starting Run user-specific NixOS activation...2128machine # [ 77.256734] systemd[538]: Finished Run user-specific NixOS activation.2129machine # [ 77.260999] systemd[1]: Stopped target Reactivate sysinit units.2130machine # [ 77.263656] systemd[1]: Stopping Reactivate sysinit units...2131machine # [ 77.265806] systemd[1]: Reached target Reactivate sysinit units.2132machine # [ 77.268310] systemd[1]: Reached target Local File Systems.2133machine # [ 77.273794] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2134machine # [ 77.281982] systemd[1]: Starting Create SUID/SGID Wrappers...2135machine # [ 77.282924] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2136machine # [ 77.291925] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672137machine # [ 77.297528] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2138machine # [ 77.299526] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2139machine # [ 77.301404] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2140machine # [ 77.302804] systemd[1]: Reached target Remote File Systems.2141machine # [ 77.305610] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2142machine # [ 77.308220] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2143machine # [ 77.457701] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2144machine # [ 77.462695] systemd[1]: Finished Create SUID/SGID Wrappers.2145machine # [ 77.466616] systemd[1]: Started autorestart.service.2146machine # [ 77.469596] systemd[1]: Starting linger-users.service...2147machine # [ 77.507563] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE2148machine # [ 77.511122] systemd[1]: autorestart.service: Failed with result 'exit-code'.2149machine # [ 77.528616] systemd[1]: linger-users.service: Deactivated successfully.2150machine # [ 77.531584] systemd[1]: Finished linger-users.service.2151machine # [ 77.806885] nixos[4739]: switching to system configuration /nix/store/fl4mv0i2x8hmdrqf5xsxymhb9nyfmlp2-nixos-system-machine-test failed (status 4)2152machine: (finished: must fail: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.92 seconds)2153(finished: subtest: failing units, in 9.59 seconds)2154subtest: unit file parser2155machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12156machine # [ 78.030432] nixos[4882]: switching to system configuration /nix/store/g6wmn9xvnyx781gjs5d3s2fflnlm93dl-nixos-system-machine-test2157machine # [ 78.033337] systemd[1]: Stopped target Local File Systems.2158machine # [ 78.037384] systemd[1]: Stopped target Remote File Systems.2159machine # [ 78.038319] systemd[1]: Stopped autorestart.service.2160machine # [ 78.326682] systemd[1]: Reload requested from client PID 4882 ('.switch-to-conf') (unit backdoor.service)...2161machine # [ 78.328767] systemd[1]: Reloading...2162machine # [ 78.662833] systemd[1]: Reloading finished in 332 ms.2163machine # [ 78.762246] systemd[538]: Reexecution requested from client PID 4951 ('switch-to-confi')...2164machine # [ 78.763740] systemd[538]: Reexecuting.2165machine # [ 78.829128] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2166machine # [ 78.939471] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2167machine # [ 78.947009] systemd[538]: Reload requested from client PID 4951 ('switch-to-confi')...2168machine # [ 78.950769] systemd[538]: Reloading...2169machine # [ 79.060744] systemd[538]: Reloading finished in 111 ms.2170machine # [ 79.076163] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2171machine # [ 79.086429] systemd[538]: Stopped Run user-specific NixOS activation.2172machine # [ 79.088932] systemd[538]: Stopping Run user-specific NixOS activation...2173machine # [ 79.091366] systemd[538]: Starting Run user-specific NixOS activation...2174machine # [ 79.125460] systemd[538]: Finished Run user-specific NixOS activation.2175machine # [ 79.129988] systemd[1]: Stopped target Reactivate sysinit units.2176machine # [ 79.133638] systemd[1]: Stopping Reactivate sysinit units...2177machine # [ 79.134483] systemd[1]: Reached target Reactivate sysinit units.2178machine # [ 79.139036] systemd[1]: Reached target Local File Systems.2179machine # [ 79.142717] systemd[1]: Reached target Remote File Systems.2180machine # [ 79.143588] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2181machine # [ 79.147831] systemd[1]: Starting Create SUID/SGID Wrappers...2182machine # [ 79.153463] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2183machine # [ 79.154729] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672184machine # [ 79.166486] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2185machine # [ 79.168339] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2186machine # [ 79.169658] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2187machine # [ 79.170859] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2188machine # [ 79.173695] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2189machine # [ 79.341958] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2190machine # [ 79.345123] systemd[1]: Finished Create SUID/SGID Wrappers.2191machine # [ 79.350957] systemd[1]: Starting linger-users.service...2192machine # [ 79.354195] systemd[1]: Starting test.service...2193machine # [ 79.390223] systemd[1]: Finished test.service.2194machine # [ 79.411250] systemd[1]: linger-users.service: Deactivated successfully.2195machine # [ 79.413147] systemd[1]: Finished linger-users.service.2196machine # [ 79.673583] nixos[4882]: finished switching to system configuration /nix/store/g6wmn9xvnyx781gjs5d3s2fflnlm93dl-nixos-system-machine-test2197machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.87 seconds)2198machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&12199machine # [ 79.951339] nixos[5024]: switching to system configuration /nix/store/g9niarpr60iavc7sbhklplx61aag6y61-nixos-system-machine-test2200machine # [ 79.954422] systemd[1]: Stopped target Local File Systems.2201machine # [ 79.957212] systemd[1]: Stopped target Remote File Systems.2202machine # [ 80.278018] systemd[1]: Reload requested from client PID 5024 ('.switch-to-conf') (unit backdoor.service)...2203machine # [ 80.280168] systemd[1]: Reloading...2204machine # [ 80.639668] systemd[1]: Reloading finished in 357 ms.2205machine # [ 80.730614] systemd[538]: Reexecution requested from client PID 5093 ('switch-to-confi')...2206machine # [ 80.733633] systemd[538]: Reexecuting.2207machine # [ 80.792249] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2208machine # [ 80.910127] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2209machine # [ 80.917257] systemd[538]: Reload requested from client PID 5093 ('switch-to-confi')...2210machine # [ 80.920091] systemd[538]: Reloading...2211machine # [ 81.033540] systemd[538]: Reloading finished in 113 ms.2212machine # [ 81.048181] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2213machine # [ 81.058415] systemd[538]: Stopped Run user-specific NixOS activation.2214machine # [ 81.060934] systemd[538]: Stopping Run user-specific NixOS activation...2215machine # [ 81.063126] systemd[538]: Starting Run user-specific NixOS activation...2216machine # [ 81.096747] systemd[538]: Finished Run user-specific NixOS activation.2217machine # [ 81.101261] systemd[1]: Stopped target Reactivate sysinit units.2218machine # [ 81.103510] systemd[1]: Stopping Reactivate sysinit units...2219machine # [ 81.107877] systemd[1]: Reached target Reactivate sysinit units.2220machine # [ 81.110873] systemd[1]: test.service: Deactivated successfully.2221machine # [ 81.111805] systemd[1]: Stopped test.service.2222machine # [ 81.116480] systemd[1]: Stopping test.service...2223machine # [ 81.117367] systemd[1]: Starting test.service...2224machine # [ 81.139959] systemd[1]: Finished test.service.2225machine # [ 81.145829] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2226machine # [ 81.150098] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2227machine # [ 81.152127] systemd[1]: Reached target Local File Systems.2228machine # [ 81.156474] systemd[1]: Reached target Remote File Systems.2229machine # [ 81.159135] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2230machine # [ 81.168525] systemd[1]: Starting Create SUID/SGID Wrappers...2231machine # [ 81.169524] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2232machine # [ 81.170860] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672233machine # [ 81.182278] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2234machine # [ 81.184232] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2235machine # [ 81.185591] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2236machine # [ 81.386141] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2237machine # [ 81.391036] systemd[1]: Finished Create SUID/SGID Wrappers.2238machine # [ 81.393372] systemd[1]: Starting linger-users.service...2239machine # [ 81.437847] systemd[1]: linger-users.service: Deactivated successfully.2240machine # [ 81.441090] systemd[1]: Finished linger-users.service.2241machine # [ 81.698063] nixos[5024]: finished switching to system configuration /nix/store/g9niarpr60iavc7sbhklplx61aag6y61-nixos-system-machine-test2242machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 2.02 seconds)2243machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&12244machine # [ 81.948576] nixos[5166]: switching to system configuration /nix/store/vcxgkm239dn7022kz288y4b9d6jd7zlj-nixos-system-machine-test2245machine # [ 81.951228] systemd[1]: Stopped target Remote File Systems.2246machine # [ 81.953790] systemd[1]: Stopped target Local File Systems.2247machine # [ 82.289075] systemd[1]: Reload requested from client PID 5166 ('.switch-to-conf') (unit backdoor.service)...2248machine # [ 82.291153] systemd[1]: Reloading...2249machine # [ 82.659757] systemd[1]: Reloading finished in 365 ms.2250machine # [ 82.758018] systemd[538]: Reexecution requested from client PID 5235 ('switch-to-confi')...2251machine # [ 82.762016] systemd[538]: Reexecuting.2252machine # [ 82.819523] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2253machine # [ 82.934930] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2254machine # [ 82.942251] systemd[538]: Reload requested from client PID 5235 ('switch-to-confi')...2255machine # [ 82.946263] systemd[538]: Reloading...2256machine # [ 83.053891] systemd[538]: Reloading finished in 108 ms.2257machine # [ 83.068212] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2258machine # [ 83.079726] systemd[538]: Stopped Run user-specific NixOS activation.2259machine # [ 83.082153] systemd[538]: Stopping Run user-specific NixOS activation...2260machine # [ 83.084481] systemd[538]: Starting Run user-specific NixOS activation...2261machine # [ 83.118788] systemd[538]: Finished Run user-specific NixOS activation.2262machine # [ 83.123054] systemd[1]: Stopped target Reactivate sysinit units.2263machine # [ 83.125257] systemd[1]: Stopping Reactivate sysinit units...2264machine # [ 83.126088] systemd[1]: Reached target Reactivate sysinit units.2265machine # [ 83.128472] systemd[1]: test.service: Deactivated successfully.2266machine # [ 83.129347] systemd[1]: Stopped test.service.2267machine # [ 83.129946] systemd[1]: Stopping test.service...2268machine # [ 83.133911] systemd[1]: Starting test.service...2269machine # [ 83.157928] systemd[1]: Finished test.service.2270machine # [ 83.165077] systemd[1]: Reached target Remote File Systems.2271machine # [ 83.169998] systemd[1]: Starting linger-users.service...2272machine # [ 83.173390] systemd[1]: Reached target Local File Systems.2273machine # [ 83.176245] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2274machine # [ 83.194729] systemd[1]: Starting Create SUID/SGID Wrappers...2275machine # [ 83.195787] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2276machine # [ 83.202410] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672277machine # [ 83.205544] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2278machine # [ 83.207203] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2279machine # [ 83.211400] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2280machine # [ 83.215873] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2281machine # [ 83.222995] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2282machine # [ 83.277198] systemd[1]: linger-users.service: Deactivated successfully.2283machine # [ 83.279182] systemd[1]: Finished linger-users.service.2284machine # [ 83.470275] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2285machine # [ 83.472395] systemd[1]: Finished Create SUID/SGID Wrappers.2286machine # [ 83.729893] nixos[5166]: finished switching to system configuration /nix/store/vcxgkm239dn7022kz288y4b9d6jd7zlj-nixos-system-machine-test2287machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 2.03 seconds)2288machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12289machine # [ 84.015047] nixos[5308]: switching to system configuration /nix/store/g6wmn9xvnyx781gjs5d3s2fflnlm93dl-nixos-system-machine-test2290machine # [ 84.018629] systemd[1]: Stopped target Local File Systems.2291machine # [ 84.022139] systemd[1]: Stopped target Remote File Systems.2292machine # [ 84.344372] systemd[1]: Reload requested from client PID 5308 ('.switch-to-conf') (unit backdoor.service)...2293machine # [ 84.346516] systemd[1]: Reloading...2294machine # [ 84.726442] systemd[1]: Reloading finished in 378 ms.2295machine # [ 84.836907] systemd[538]: Reexecution requested from client PID 5377 ('switch-to-confi')...2296machine # [ 84.841074] systemd[538]: Reexecuting.2297machine # [ 84.899954] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2298machine # [ 85.063274] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2299machine # [ 85.072215] systemd[538]: Reload requested from client PID 5377 ('switch-to-confi')...2300machine # [ 85.074418] systemd[538]: Reloading...2301machine # [ 85.210856] systemd[538]: Reloading finished in 129 ms.2302machine # [ 85.228585] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2303machine # [ 85.243220] systemd[538]: Stopped Run user-specific NixOS activation.2304machine # [ 85.246183] systemd[538]: Stopping Run user-specific NixOS activation...2305machine # [ 85.248541] systemd[538]: Starting Run user-specific NixOS activation...2306machine # [ 85.286553] systemd[538]: Finished Run user-specific NixOS activation.2307machine # [ 85.291786] systemd[1]: Stopped target Reactivate sysinit units.2308machine # [ 85.297065] systemd[1]: Stopping Reactivate sysinit units...2309machine # [ 85.297982] systemd[1]: Reached target Reactivate sysinit units.2310machine # [ 85.298910] systemd[1]: test.service: Deactivated successfully.2311machine # [ 85.299761] systemd[1]: Stopped test.service.2312machine # [ 85.302996] systemd[1]: Stopping test.service...2313machine # [ 85.306636] systemd[1]: Starting test.service...2314machine # [ 85.338085] systemd[1]: Finished test.service.2315machine # [ 85.342289] systemd[1]: Reached target Local File Systems.2316machine # [ 85.347960] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2317machine # [ 85.350345] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2318machine # [ 85.356851] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2319machine # [ 85.361853] systemd[1]: Starting Create SUID/SGID Wrappers...2320machine # [ 85.362806] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2321machine # [ 85.372475] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672322machine # [ 85.374775] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2323machine # [ 85.379487] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2324machine # [ 85.381415] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2325machine # [ 85.382673] systemd[1]: Reached target Remote File Systems.2326machine # [ 85.580701] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2327machine # [ 85.586305] systemd[1]: Finished Create SUID/SGID Wrappers.2328machine # [ 85.589390] systemd[1]: Starting linger-users.service...2329machine # [ 85.650184] systemd[1]: linger-users.service: Deactivated successfully.2330machine # [ 85.652170] systemd[1]: Finished linger-users.service.2331machine # [ 85.908524] nixos[5308]: finished switching to system configuration /nix/store/g6wmn9xvnyx781gjs5d3s2fflnlm93dl-nixos-system-machine-test2332machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.18 seconds)2333machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&12334machine # [ 86.169657] nixos[5450]: switching to system configuration /nix/store/0zan7idyqln5pz4sjgrwb29kikwz6xck-nixos-system-machine-test2335machine # [ 86.172074] systemd[1]: Stopped target Local File Systems.2336machine # [ 86.174728] systemd[1]: Stopped target Remote File Systems.2337machine # [ 86.533680] systemd[1]: Reload requested from client PID 5450 ('.switch-to-conf') (unit backdoor.service)...2338machine # [ 86.535783] systemd[1]: Reloading...2339machine # [ 86.965498] systemd[1]: Reloading finished in 427 ms.2340machine # [ 87.054745] systemd[538]: Reexecution requested from client PID 5519 ('switch-to-confi')...2341machine # [ 87.059025] systemd[538]: Reexecuting.2342machine # [ 87.120955] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2343machine # [ 87.267706] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2344machine # [ 87.275697] systemd[538]: Reload requested from client PID 5519 ('switch-to-confi')...2345machine # [ 87.278414] systemd[538]: Reloading...2346machine # [ 87.408909] systemd[538]: Reloading finished in 128 ms.2347machine # [ 87.428221] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2348machine # [ 87.440818] systemd[538]: Stopped Run user-specific NixOS activation.2349machine # [ 87.443863] systemd[538]: Stopping Run user-specific NixOS activation...2350machine # [ 87.446555] systemd[538]: Starting Run user-specific NixOS activation...2351machine # [ 87.482791] systemd[538]: Finished Run user-specific NixOS activation.2352machine # [ 87.487830] systemd[1]: Stopped target Reactivate sysinit units.2353machine # [ 87.491672] systemd[1]: Stopping Reactivate sysinit units...2354machine # [ 87.495268] systemd[1]: Reached target Reactivate sysinit units.2355machine # [ 87.497354] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2356machine # [ 87.498637] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2357machine # [ 87.501097] systemd[1]: Reached target Local File Systems.2358machine # [ 87.507190] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2359machine # [ 87.509984] systemd[1]: Starting Create SUID/SGID Wrappers...2360machine # [ 87.510889] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2361machine # [ 87.512336] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672362machine # [ 87.518128] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2363machine # [ 87.527393] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2364machine # [ 87.533611] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2365machine # [ 87.535511] systemd[1]: Reached target Remote File Systems.2366machine # [ 87.744154] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2367machine # [ 87.748828] systemd[1]: Finished Create SUID/SGID Wrappers.2368machine # [ 87.752379] systemd[1]: Starting linger-users.service...2369machine # [ 87.798038] systemd[1]: linger-users.service: Deactivated successfully.2370machine # [ 87.800982] systemd[1]: Finished linger-users.service.2371machine # [ 88.057837] nixos[5450]: finished switching to system configuration /nix/store/0zan7idyqln5pz4sjgrwb29kikwz6xck-nixos-system-machine-test2372machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 2.15 seconds)2373machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&12374machine # [ 88.287478] nixos[5590]: switching to system configuration /nix/store/xky3cybs6bjvxx55j13jklvdnzd1kr3g-nixos-system-machine-test2375machine # [ 88.292569] systemd[1]: Stopped target Local File Systems.2376machine # [ 88.294018] systemd[1]: Stopped target Remote File Systems.2377machine # [ 88.667123] systemd[1]: Reload requested from client PID 5590 ('.switch-to-conf') (unit backdoor.service)...2378machine # [ 88.670341] systemd[1]: Reloading...2379machine # [ 89.086569] systemd[1]: Reloading finished in 413 ms.2380machine # [ 89.188435] systemd[538]: Reexecution requested from client PID 5659 ('switch-to-confi')...2381machine # [ 89.189752] systemd[538]: Reexecuting.2382machine # [ 89.247526] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2383machine # [ 89.384821] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2384machine # [ 89.393644] systemd[538]: Reload requested from client PID 5659 ('switch-to-confi')...2385machine # [ 89.396661] systemd[538]: Reloading...2386machine # [ 89.533809] systemd[538]: Reloading finished in 135 ms.2387machine # [ 89.552337] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2388machine # [ 89.563516] systemd[538]: Stopped Run user-specific NixOS activation.2389machine # [ 89.566889] systemd[538]: Stopping Run user-specific NixOS activation...2390machine # [ 89.570171] systemd[538]: Starting Run user-specific NixOS activation...2391machine # [ 89.609105] systemd[538]: Finished Run user-specific NixOS activation.2392machine # [ 89.613992] systemd[1]: Stopped target Reactivate sysinit units.2393machine # [ 89.619945] systemd[1]: Stopping Reactivate sysinit units...2394machine # [ 89.621634] systemd[1]: Reached target Reactivate sysinit units.2395machine # [ 89.622818] systemd[1]: test.service: Deactivated successfully.2396machine # [ 89.623936] systemd[1]: Stopped test.service.2397machine # [ 89.625128] systemd[1]: Stopping test.service...2398machine # [ 89.628274] systemd[1]: Starting test.service...2399machine # [ 89.656634] systemd[1]: Finished test.service.2400machine # [ 89.663003] systemd[1]: Reached target Local File Systems.2401machine # [ 89.668486] systemd[1]: Reached target Remote File Systems.2402machine # [ 89.676538] systemd[1]: Starting linger-users.service...2403machine # [ 89.684447] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2404machine # [ 89.695995] systemd[1]: Starting Create SUID/SGID Wrappers...2405machine # [ 89.697552] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2406machine # [ 89.699313] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672407machine # [ 89.714987] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2408machine # [ 89.723887] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2409machine # [ 89.730165] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2410machine # [ 89.731475] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2411machine # [ 89.739638] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2412machine # [ 89.782936] systemd[1]: linger-users.service: Deactivated successfully.2413machine # [ 89.786599] systemd[1]: Finished linger-users.service.2414machine # [ 89.949561] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2415machine # [ 89.953364] systemd[1]: Finished Create SUID/SGID Wrappers.2416machine # [ 90.206446] nixos[5590]: finished switching to system configuration /nix/store/xky3cybs6bjvxx55j13jklvdnzd1kr3g-nixos-system-machine-test2417machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 2.15 seconds)2418machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&12419machine # [ 90.525261] nixos[5732]: switching to system configuration /nix/store/kjzql89367myi2b8k0yckn1zcapzp1ip-nixos-system-machine-test2420machine # [ 90.528619] systemd[1]: Stopped target Local File Systems.2421machine # [ 90.531341] systemd[1]: Stopped target Remote File Systems.2422machine # [ 90.888665] systemd[1]: Reload requested from client PID 5732 ('.switch-to-conf') (unit backdoor.service)...2423machine # [ 90.891392] systemd[1]: Reloading...2424machine # [ 91.316652] systemd[1]: Reloading finished in 422 ms.2425machine # [ 91.420845] systemd[538]: Reexecution requested from client PID 5801 ('switch-to-confi')...2426machine # [ 91.424195] systemd[538]: Reexecuting.2427machine # [ 91.495447] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2428machine # [ 91.635707] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2429machine # [ 91.643813] systemd[538]: Reload requested from client PID 5801 ('switch-to-confi')...2430machine # [ 91.646229] systemd[538]: Reloading...2431machine # [ 91.786071] systemd[538]: Reloading finished in 138 ms.2432machine # [ 91.804335] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2433machine # [ 91.818559] systemd[538]: Stopped Run user-specific NixOS activation.2434machine # [ 91.821630] systemd[538]: Stopping Run user-specific NixOS activation...2435machine # [ 91.824412] systemd[538]: Starting Run user-specific NixOS activation...2436machine # [ 91.864650] systemd[538]: Finished Run user-specific NixOS activation.2437machine # [ 91.869326] systemd[1]: Stopped target Reactivate sysinit units.2438machine # [ 91.872627] systemd[1]: Stopping Reactivate sysinit units...2439machine # [ 91.873536] systemd[1]: Reached target Reactivate sysinit units.2440machine # [ 91.874367] systemd[1]: test.service: Deactivated successfully.2441machine # [ 91.875217] systemd[1]: Stopped test.service.2442machine # [ 91.877810] systemd[1]: Stopping test.service...2443machine # [ 91.879590] systemd[1]: Starting test.service...2444machine # [ 91.941477] systemd[1]: Finished test.service.2445machine # [ 91.947395] systemd[1]: Reached target Remote File Systems.2446machine # [ 91.953499] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2447machine # [ 91.954806] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2448machine # [ 91.961421] systemd[1]: Starting linger-users.service...2449machine # [ 91.962872] systemd[1]: Reached target Local File Systems.2450machine # [ 91.970926] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2451machine # [ 91.982398] systemd[1]: Starting Create SUID/SGID Wrappers...2452machine # [ 91.983894] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2453machine # [ 91.999153] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672454machine # [ 92.006925] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2455machine # [ 92.014156] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2456machine # [ 92.017213] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2457machine # [ 92.093532] systemd[1]: linger-users.service: Deactivated successfully.2458machine # [ 92.098775] systemd[1]: Finished linger-users.service.2459machine # [ 92.300170] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2460machine # [ 92.303786] systemd[1]: Finished Create SUID/SGID Wrappers.2461machine # [ 92.557289] nixos[5732]: finished switching to system configuration /nix/store/kjzql89367myi2b8k0yckn1zcapzp1ip-nixos-system-machine-test2462machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 2.35 seconds)2463machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&12464machine # [ 92.966989] nixos[5874]: switching to system configuration /nix/store/d1dyrsjvnail0kjw2kj4pwbpcj65k09a-nixos-system-machine-test2465machine # [ 92.969953] systemd[1]: Stopped target Local File Systems.2466machine # [ 92.973231] systemd[1]: Stopped target Remote File Systems.2467machine # [ 93.360956] systemd[1]: Reload requested from client PID 5874 ('.switch-to-conf') (unit backdoor.service)...2468machine # [ 93.363614] systemd[1]: Reloading...2469machine # [ 93.809480] systemd[1]: Reloading finished in 443 ms.2470machine # [ 93.946163] systemd[538]: Reexecution requested from client PID 5943 ('switch-to-confi')...2471machine # [ 93.951033] systemd[538]: Reexecuting.2472machine # [ 93.995817] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2473machine # [ 94.134081] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2474machine # [ 94.139379] systemd[538]: Reload requested from client PID 5943 ('switch-to-confi')...2475machine # [ 94.142877] systemd[538]: Reloading...2476machine # [ 94.283500] systemd[538]: Reloading finished in 141 ms.2477machine # [ 94.300256] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2478machine # [ 94.311638] systemd[538]: Stopped Run user-specific NixOS activation.2479machine # [ 94.314286] systemd[538]: Stopping Run user-specific NixOS activation...2480machine # [ 94.316941] systemd[538]: Starting Run user-specific NixOS activation...2481machine # [ 94.354268] systemd[538]: Finished Run user-specific NixOS activation.2482machine # [ 94.359058] systemd[1]: Stopped target Reactivate sysinit units.2483machine # [ 94.360879] systemd[1]: Stopping Reactivate sysinit units...2484machine # [ 94.361805] systemd[1]: Reached target Reactivate sysinit units.2485machine # [ 94.366068] systemd[1]: test.service: Deactivated successfully.2486machine # [ 94.366946] systemd[1]: Stopped test.service.2487machine # [ 94.367646] systemd[1]: Stopping test.service...2488machine # [ 94.372334] systemd[1]: Starting test.service...2489machine # [ 94.403699] systemd[1]: Finished test.service.2490machine # [ 94.415355] systemd[1]: Reached target Remote File Systems.2491machine # [ 94.419265] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2492machine # [ 94.421064] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2493machine # [ 94.424973] systemd[1]: Starting linger-users.service...2494machine # [ 94.429708] systemd[1]: Reached target Local File Systems.2495machine # [ 94.436499] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2496machine # [ 94.448439] systemd[1]: Starting Create SUID/SGID Wrappers...2497machine # [ 94.449492] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2498machine # [ 94.450777] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672499machine # [ 94.458994] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2500machine # [ 94.462500] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2501machine # [ 94.465818] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2502machine # [ 94.537756] systemd[1]: linger-users.service: Deactivated successfully.2503machine # [ 94.542437] systemd[1]: Finished linger-users.service.2504machine # [ 94.781603] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2505machine # [ 94.783497] systemd[1]: Finished Create SUID/SGID Wrappers.2506machine # [ 95.039647] nixos[5874]: finished switching to system configuration /nix/store/d1dyrsjvnail0kjw2kj4pwbpcj65k09a-nixos-system-machine-test2507machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 2.48 seconds)2508machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12509machine # [ 95.327343] nixos[6016]: switching to system configuration /nix/store/g6wmn9xvnyx781gjs5d3s2fflnlm93dl-nixos-system-machine-test2510machine # [ 95.330000] systemd[1]: Stopped target Remote File Systems.2511machine # [ 95.332493] systemd[1]: Stopped target Local File Systems.2512machine # [ 95.657547] systemd[1]: Reload requested from client PID 6016 ('.switch-to-conf') (unit backdoor.service)...2513machine # [ 95.659595] systemd[1]: Reloading...2514machine # [ 96.057491] systemd[1]: Reloading finished in 395 ms.2515machine # [ 96.147566] systemd[538]: Reexecution requested from client PID 6085 ('switch-to-confi')...2516machine # [ 96.149842] systemd[538]: Reexecuting.2517machine # [ 96.212606] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2518machine # [ 96.355785] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2519machine # [ 96.362643] systemd[538]: Reload requested from client PID 6085 ('switch-to-confi')...2520machine # [ 96.364921] systemd[538]: Reloading...2521machine # [ 96.498086] systemd[538]: Reloading finished in 131 ms.2522machine # [ 96.520703] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2523machine # [ 96.530342] systemd[538]: Stopped Run user-specific NixOS activation.2524machine # [ 96.532763] systemd[538]: Stopping Run user-specific NixOS activation...2525machine # [ 96.534992] systemd[538]: Starting Run user-specific NixOS activation...2526machine # [ 96.576090] systemd[538]: Finished Run user-specific NixOS activation.2527machine # [ 96.580890] systemd[1]: Stopped target Reactivate sysinit units.2528machine # [ 96.581866] systemd[1]: Stopping Reactivate sysinit units...2529machine # [ 96.582710] systemd[1]: Reached target Reactivate sysinit units.2530machine # [ 96.585908] systemd[1]: test.service: Deactivated successfully.2531machine # [ 96.589391] systemd[1]: Stopped test.service.2532machine # [ 96.590437] systemd[1]: Stopping test.service...2533machine # [ 96.593639] systemd[1]: Starting test.service...2534machine # [ 96.621344] systemd[1]: Finished test.service.2535machine # [ 96.624844] systemd[1]: Reached target Local File Systems.2536machine # [ 96.629294] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2537machine # [ 96.636145] systemd[1]: Starting Create SUID/SGID Wrappers...2538machine # [ 96.637614] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2539machine # [ 96.639312] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672540machine # [ 96.650641] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2541machine # [ 96.661825] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2542machine # [ 96.666903] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2543machine # [ 96.671318] systemd[1]: Reached target Remote File Systems.2544machine # [ 96.673551] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2545machine # [ 96.675320] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2546machine # [ 96.884270] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2547machine # [ 96.889073] systemd[1]: Finished Create SUID/SGID Wrappers.2548machine # [ 96.892367] systemd[1]: Starting linger-users.service...2549machine # [ 96.942078] systemd[1]: linger-users.service: Deactivated successfully.2550machine # [ 96.945145] systemd[1]: Finished linger-users.service.2551machine # [ 97.198769] nixos[6016]: finished switching to system configuration /nix/store/g6wmn9xvnyx781gjs5d3s2fflnlm93dl-nixos-system-machine-test2552machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.17 seconds)2553machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&12554machine # [ 97.516572] nixos[6158]: switching to system configuration /nix/store/6l42yhssrgcwn5pnqfv7j9yadswfairr-nixos-system-machine-test2555machine # [ 97.520876] systemd[1]: Stopped target Local File Systems.2556machine # [ 97.522259] systemd[1]: Stopped target Remote File Systems.2557machine # [ 97.860868] systemd[1]: Reload requested from client PID 6158 ('.switch-to-conf') (unit backdoor.service)...2558machine # [ 97.863434] systemd[1]: Reloading...2559machine # [ 98.234645] systemd[1]: Reloading finished in 369 ms.2560machine # [ 98.334819] systemd[538]: Reexecution requested from client PID 6227 ('switch-to-confi')...2561machine # [ 98.339303] systemd[538]: Reexecuting.2562machine # [ 98.396569] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2563machine # [ 98.531730] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2564machine # [ 98.538790] systemd[538]: Reload requested from client PID 6227 ('switch-to-confi')...2565machine # [ 98.542225] systemd[538]: Reloading...2566machine # [ 98.670728] systemd[538]: Reloading finished in 129 ms.2567machine # [ 98.684189] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2568machine # [ 98.695745] systemd[538]: Stopped Run user-specific NixOS activation.2569machine # [ 98.698827] systemd[538]: Stopping Run user-specific NixOS activation...2570machine # [ 98.701513] systemd[538]: Starting Run user-specific NixOS activation...2571machine # [ 98.739679] systemd[538]: Finished Run user-specific NixOS activation.2572machine # [ 98.744668] systemd[1]: Stopped target Reactivate sysinit units.2573machine # [ 98.749841] systemd[1]: Stopping Reactivate sysinit units...2574machine # [ 98.750790] systemd[1]: Reached target Reactivate sysinit units.2575machine # [ 98.753324] systemd[1]: Reloading test.service...2576machine # [ 98.780582] systemd[1]: Reloaded test.service.2577machine # [ 98.783040] systemd[1]: Reached target Remote File Systems.2578machine # [ 98.791180] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2579machine # [ 98.794386] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2580machine # [ 98.797277] systemd[1]: Reached target Local File Systems.2581machine # [ 98.803732] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2582machine # [ 98.809813] systemd[1]: Starting Create SUID/SGID Wrappers...2583machine # [ 98.816845] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2584machine # [ 98.818185] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672585machine # [ 98.820858] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2586machine # [ 98.822410] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2587machine # [ 98.823609] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2588machine # [ 99.046049] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2589machine # [ 99.049246] systemd[1]: Finished Create SUID/SGID Wrappers.2590machine # [ 99.054641] systemd[1]: Starting linger-users.service...2591machine # [ 99.098403] systemd[1]: linger-users.service: Deactivated successfully.2592machine # [ 99.101786] systemd[1]: Finished linger-users.service.2593machine # [ 99.358351] nixos[6158]: finished switching to system configuration /nix/store/6l42yhssrgcwn5pnqfv7j9yadswfairr-nixos-system-machine-test2594machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 2.15 seconds)2595machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&12596machine # [ 99.730958] nixos[6300]: switching to system configuration /nix/store/8h9ykb59bwqqyxr1q7186w5fiv0g6r4g-nixos-system-machine-test2597machine # [ 99.733896] systemd[1]: Stopped target Local File Systems.2598machine # [ 99.736645] systemd[1]: Stopped target Remote File Systems.2599machine # [ 100.094525] systemd[1]: Reload requested from client PID 6300 ('.switch-to-conf') (unit backdoor.service)...2600machine # [ 100.097302] systemd[1]: Reloading...2601machine # [ 100.485526] systemd[1]: Reloading finished in 385 ms.2602machine # [ 100.579021] systemd[538]: Reexecution requested from client PID 6369 ('switch-to-confi')...2603machine # [ 100.583247] systemd[538]: Reexecuting.2604machine # [ 100.635474] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2605machine # [ 100.767756] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2606machine # [ 100.776055] systemd[538]: Reload requested from client PID 6369 ('switch-to-confi')...2607machine # [ 100.778528] systemd[538]: Reloading...2608machine # [ 100.908862] systemd[538]: Reloading finished in 128 ms.2609machine # [ 100.924204] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2610machine # [ 100.936617] systemd[538]: Stopped Run user-specific NixOS activation.2611machine # [ 100.939603] systemd[538]: Stopping Run user-specific NixOS activation...2612machine # [ 100.942533] systemd[538]: Starting Run user-specific NixOS activation...2613machine # [ 100.976339] systemd[538]: Finished Run user-specific NixOS activation.2614machine # [ 100.980807] systemd[1]: Stopped target Reactivate sysinit units.2615machine # [ 100.985606] systemd[1]: Stopping Reactivate sysinit units...2616machine # [ 100.986938] systemd[1]: Reached target Reactivate sysinit units.2617machine # [ 100.989880] systemd[1]: Reloading test.service...2618machine # [ 101.014137] systemd[1]: Reloaded test.service.2619machine # [ 101.016996] systemd[1]: Reached target Local File Systems.2620machine # [ 101.020792] systemd[1]: Reached target Remote File Systems.2621machine # [ 101.023956] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2622machine # [ 101.026163] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2623machine # [ 101.032072] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2624machine # [ 101.040646] systemd[1]: Starting Create SUID/SGID Wrappers...2625machine # [ 101.041921] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2626machine # [ 101.043585] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672627machine # [ 101.052478] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2628machine # [ 101.054767] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2629machine # [ 101.058212] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2630machine # [ 101.224611] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2631machine # [ 101.229780] systemd[1]: Finished Create SUID/SGID Wrappers.2632machine # [ 101.232386] systemd[1]: Starting linger-users.service...2633machine # [ 101.270811] systemd[1]: linger-users.service: Deactivated successfully.2634machine # [ 101.274285] systemd[1]: Finished linger-users.service.2635machine # [ 101.528358] nixos[6300]: finished switching to system configuration /nix/store/8h9ykb59bwqqyxr1q7186w5fiv0g6r4g-nixos-system-machine-test2636machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 2.17 seconds)2637machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&12638machine # [ 101.817309] nixos[6442]: switching to system configuration /nix/store/5xylndr9irzs9msi9f8dzdy7q2praayb-nixos-system-machine-test2639machine # [ 101.820594] systemd[1]: Stopped target Local File Systems.2640machine # [ 101.823145] systemd[1]: Stopped target Remote File Systems.2641machine # [ 102.145454] systemd[1]: Reload requested from client PID 6442 ('.switch-to-conf') (unit backdoor.service)...2642machine # [ 102.148280] systemd[1]: Reloading...2643machine # [ 102.502043] systemd[1]: Reloading finished in 350 ms.2644machine # [ 102.585418] systemd[538]: Reexecution requested from client PID 6511 ('switch-to-confi')...2645machine # [ 102.589328] systemd[538]: Reexecuting.2646machine # [ 102.646533] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2647machine # [ 102.779628] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2648machine # [ 102.787335] systemd[538]: Reload requested from client PID 6511 ('switch-to-confi')...2649machine # [ 102.790378] systemd[538]: Reloading...2650machine # [ 102.912184] systemd[538]: Reloading finished in 119 ms.2651machine # [ 102.928157] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2652machine # [ 102.938975] systemd[538]: Stopped Run user-specific NixOS activation.2653machine # [ 102.941699] systemd[538]: Stopping Run user-specific NixOS activation...2654machine # [ 102.944250] systemd[538]: Starting Run user-specific NixOS activation...2655machine # [ 102.977389] systemd[538]: Finished Run user-specific NixOS activation.2656machine # [ 102.981614] systemd[1]: Stopped target Reactivate sysinit units.2657machine # [ 102.986616] systemd[1]: Stopping Reactivate sysinit units...2658machine # [ 102.987910] systemd[1]: Reached target Reactivate sysinit units.2659machine # [ 102.989537] systemd[1]: test.service: Deactivated successfully.2660machine # [ 102.990696] systemd[1]: Stopped test.service.2661machine # [ 102.991559] systemd[1]: Stopping test.service...2662machine # [ 102.996608] systemd[1]: Starting test.service...2663machine # [ 103.017116] systemd[1]: Finished test.service.2664machine # [ 103.023799] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2665machine # [ 103.027455] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2666machine # [ 103.032592] systemd[1]: Reached target Remote File Systems.2667machine # [ 103.034959] systemd[1]: Starting linger-users.service...2668machine # [ 103.043046] systemd[1]: Reached target Local File Systems.2669machine # [ 103.045608] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2670machine # [ 103.050879] systemd[1]: Starting Create SUID/SGID Wrappers...2671machine # [ 103.060729] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2672machine # [ 103.062534] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672673machine # [ 103.066180] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2674machine # [ 103.074482] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2675machine # [ 103.080404] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2676machine # [ 103.132866] systemd[1]: linger-users.service: Deactivated successfully.2677machine # [ 103.137356] systemd[1]: Finished linger-users.service.2678machine # [ 103.281558] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2679machine # [ 103.285104] systemd[1]: Finished Create SUID/SGID Wrappers.2680machine # [ 103.539442] nixos[6442]: finished switching to system configuration /nix/store/5xylndr9irzs9msi9f8dzdy7q2praayb-nixos-system-machine-test2681machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 2.01 seconds)2682machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&12683machine # [ 103.841094] nixos[6584]: switching to system configuration /nix/store/xky3cybs6bjvxx55j13jklvdnzd1kr3g-nixos-system-machine-test2684machine # [ 103.843791] systemd[1]: Stopped target Local File Systems.2685machine # [ 103.846884] systemd[1]: Stopped target Remote File Systems.2686machine # [ 104.153688] systemd[1]: Reload requested from client PID 6584 ('.switch-to-conf') (unit backdoor.service)...2687machine # [ 104.155835] systemd[1]: Reloading...2688machine # [ 104.597346] systemd[1]: Reloading finished in 439 ms.2689machine # [ 104.764648] systemd[538]: Reexecution requested from client PID 6653 ('switch-to-confi')...2690machine # [ 104.767757] systemd[538]: Reexecuting.2691machine # [ 104.816584] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2692machine # [ 104.939029] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2693machine # [ 104.946606] systemd[538]: Reload requested from client PID 6653 ('switch-to-confi')...2694machine # [ 104.949136] systemd[538]: Reloading...2695machine # [ 105.081499] systemd[538]: Reloading finished in 130 ms.2696machine # [ 105.096238] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2697machine # [ 105.106922] systemd[538]: Stopped Run user-specific NixOS activation.2698machine # [ 105.109645] systemd[538]: Stopping Run user-specific NixOS activation...2699machine # [ 105.112123] systemd[538]: Starting Run user-specific NixOS activation...2700machine # [ 105.145580] systemd[538]: Finished Run user-specific NixOS activation.2701machine # [ 105.150865] systemd[1]: Stopped target Reactivate sysinit units.2702machine # [ 105.153254] systemd[1]: Stopping Reactivate sysinit units...2703machine # [ 105.154182] systemd[1]: Reached target Reactivate sysinit units.2704machine # [ 105.156792] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2705machine # [ 105.158169] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2706machine # [ 105.163413] systemd[1]: Reached target Local File Systems.2707machine # [ 105.167021] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2708machine # [ 105.176750] systemd[1]: Starting Create SUID/SGID Wrappers...2709machine # [ 105.177655] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2710machine # [ 105.178870] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672711machine # [ 105.189855] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2712machine # [ 105.191495] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2713machine # [ 105.196276] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2714machine # [ 105.197618] systemd[1]: Reached target Remote File Systems.2715machine # [ 105.389658] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2716machine # [ 105.393121] systemd[1]: Finished Create SUID/SGID Wrappers.2717machine # [ 105.398635] systemd[1]: Starting linger-users.service...2718machine # [ 105.446961] systemd[1]: linger-users.service: Deactivated successfully.2719machine # [ 105.450434] systemd[1]: Finished linger-users.service.2720machine # [ 105.705762] nixos[6584]: finished switching to system configuration /nix/store/xky3cybs6bjvxx55j13jklvdnzd1kr3g-nixos-system-machine-test2721machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 2.16 seconds)2722(finished: subtest: unit file parser, in 27.90 seconds)2723subtest: restart and reload by activation script2724machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&12725machine # [ 105.932449] nixos[6724]: switching to system configuration /nix/store/3r6q2s9gw2fnc44qjn2ar03bacpqbg0a-nixos-system-machine-test2726machine # [ 105.935082] systemd[1]: Stopped target Local File Systems.2727machine # [ 105.937464] systemd[1]: Stopped target Remote File Systems.2728machine # [ 106.252644] systemd[1]: Reload requested from client PID 6724 ('.switch-to-conf') (unit backdoor.service)...2729machine # [ 106.254147] systemd[1]: Reloading...2730machine # [ 106.611076] systemd[1]: Reloading finished in 355 ms.2731machine # [ 106.711364] systemd[538]: Reexecution requested from client PID 6793 ('switch-to-confi')...2732machine # [ 106.715980] systemd[538]: Reexecuting.2733machine # [ 106.766948] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2734machine # [ 106.899673] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2735machine # [ 106.908457] systemd[538]: Reload requested from client PID 6793 ('switch-to-confi')...2736machine # [ 106.911555] systemd[538]: Reloading...2737machine # [ 107.050846] systemd[538]: Reloading finished in 138 ms.2738machine # [ 107.068228] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2739machine # [ 107.084452] systemd[538]: Stopped Run user-specific NixOS activation.2740machine # [ 107.085589] systemd[538]: Stopping Run user-specific NixOS activation...2741machine # [ 107.089139] systemd[538]: Starting Run user-specific NixOS activation...2742machine # [ 107.123346] systemd[538]: Finished Run user-specific NixOS activation.2743machine # [ 107.128826] systemd[1]: Stopped target Reactivate sysinit units.2744machine # [ 107.131071] systemd[1]: Stopping Reactivate sysinit units...2745machine # [ 107.136734] systemd[1]: Reached target Reactivate sysinit units.2746machine # [ 107.137701] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2747machine # [ 107.138961] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2748machine # [ 107.142535] systemd[1]: Reached target Local File Systems.2749machine # [ 107.147355] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2750machine # [ 107.152978] systemd[1]: Starting Create SUID/SGID Wrappers...2751machine # [ 107.154285] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2752machine # [ 107.162518] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672753machine # [ 107.174939] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2754machine # [ 107.178903] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2755machine # [ 107.182093] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2756machine # [ 107.183974] systemd[1]: Reached target Remote File Systems.2757machine # [ 107.360974] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2758machine # [ 107.366228] systemd[1]: Finished Create SUID/SGID Wrappers.2759machine # [ 107.369837] systemd[1]: Starting linger-users.service...2760machine # [ 107.417964] systemd[1]: linger-users.service: Deactivated successfully.2761machine # [ 107.421703] systemd[1]: Finished linger-users.service.2762machine # [ 107.678781] nixos[6724]: finished switching to system configuration /nix/store/3r6q2s9gw2fnc44qjn2ar03bacpqbg0a-nixos-system-machine-test2763machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.98 seconds)2764machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12765machine # [ 107.990670] nixos[6864]: switching to system configuration /nix/store/f5r6gkrcskq0zradxdjys8q3fy2178wm-nixos-system-machine-test2766machine # [ 107.994132] systemd[1]: Stopped target Remote File Systems.2767machine # [ 107.997348] systemd[1]: test.service: Deactivated successfully.2768machine # [ 107.998730] systemd[1]: Stopped test.service.2769machine # [ 108.001615] systemd[1]: Stopped target Local File Systems.2770machine # [ 108.380857] systemd[1]: Reload requested from client PID 6864 ('.switch-to-conf') (unit backdoor.service)...2771machine # [ 108.383617] systemd[1]: Reloading...2772machine # [ 108.789404] systemd[1]: Reloading finished in 404 ms.2773machine # [ 108.888620] systemd[538]: Reexecution requested from client PID 6935 ('switch-to-confi')...2774machine # [ 108.893318] systemd[538]: Reexecuting.2775machine # [ 108.943313] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2776machine # [ 109.067985] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2777machine # [ 109.076470] systemd[538]: Reload requested from client PID 6935 ('switch-to-confi')...2778machine # [ 109.079447] systemd[538]: Reloading...2779machine # [ 109.210109] systemd[538]: Reloading finished in 129 ms.2780machine # [ 109.228172] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2781machine # [ 109.244217] systemd[538]: Stopped Run user-specific NixOS activation.2782machine # [ 109.245852] systemd[538]: Stopping Run user-specific NixOS activation...2783machine # [ 109.249536] systemd[538]: Starting Run user-specific NixOS activation...2784machine # [ 109.283137] systemd[538]: Finished Run user-specific NixOS activation.2785machine # [ 109.288128] systemd[1]: Stopped target Reactivate sysinit units.2786machine # [ 109.291026] systemd[1]: Stopping Reactivate sysinit units...2787machine # [ 109.292926] systemd[1]: Reached target Reactivate sysinit units.2788machine # [ 109.300584] systemd[1]: Created slice Slice /system/templated-no-restart-service.2789machine # [ 109.305503] systemd[1]: Starting templated-no-restart-service@instance.service...2790machine # [ 109.323644] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2791machine # [ 109.332946] systemd[1]: Created slice Slice /system/templated-simple-reload-service.2792machine # [ 109.344415] systemd[1]: Starting templated-simple-reload-service@instance.service...2793machine # [ 109.358287] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2794machine # [ 109.367662] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2795machine # [ 109.378318] systemd[1]: Starting simple-service.service...2796machine # [ 109.390257] systemd[1]: Starting no-restart-service.service...2797machine # [ 109.414572] systemd[1]: Created slice Slice /system/templated-reload-triggers.2798machine # [ 109.415867] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart.2799machine # [ 109.438183] systemd[1]: Reached target Remote File Systems.2800machine # [ 109.439133] systemd[1]: Starting linger-users.service...2801machine # [ 109.463311] systemd[1]: Starting reload-triggers-and-restart.service...2802machine # [ 109.492818] systemd[1]: Starting reload-triggers.service...2803machine # [ 109.494323] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2804machine # [ 109.495905] systemd[1]: Starting templated-reload-triggers@instance.service...2805machine # [ 109.547897] systemd[1]: Finished templated-no-restart-service@instance.service.2806machine # [ 109.592661] systemd[1]: Starting simple-reload-service.service...2807machine # [ 109.593845] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2808machine # [ 109.594990] systemd[1]: Starting simple-restart-service.service...2809machine # [ 109.660797] systemd[1]: Created slice Slice /system/templated-simple-restart-service.2810machine # [ 109.687180] systemd[1]: Starting templated-simple-restart-service@instance.service...2811machine # [ 109.707300] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as.2812machine # [ 109.735763] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2813machine # [ 109.761084] systemd[1]: Reached target Local File Systems.2814machine # [ 109.777408] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2815machine # [ 109.780967] systemd[1]: Starting Create SUID/SGID Wrappers...2816machine # [ 109.792679] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2817machine # [ 109.793940] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672818machine # [ 109.798935] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2819machine # [ 109.803550] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2820machine # [ 109.813793] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2821machine # [ 109.816475] systemd[1]: Created slice Slice /system/templated-simple-service.2822machine # [ 109.817490] systemd[1]: Finished templated-simple-reload-service@instance.service.2823machine # [ 109.818464] systemd[1]: Finished simple-service.service.2824machine # [ 109.819167] systemd[1]: Finished no-restart-service.service.2825machine # [ 109.821930] systemd[1]: Finished reload-triggers.service.2826machine # [ 109.824188] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2827machine # [ 109.834230] systemd[1]: Finished reload-triggers-and-restart.service.2828machine # [ 109.848520] systemd[1]: Finished templated-reload-triggers@instance.service.2829machine # [ 109.849607] systemd[1]: Finished simple-restart-service.service.2830machine # [ 109.850454] systemd[1]: Finished simple-reload-service.service.2831machine # [ 109.851282] systemd[1]: Finished templated-simple-restart-service@instance.service.2832machine # [ 109.860310] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2833machine # [ 109.874408] systemd[1]: linger-users.service: Deactivated successfully.2834machine # [ 109.876243] systemd[1]: Finished linger-users.service.2835machine # [ 110.047520] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2836machine # [ 110.050860] systemd[1]: Finished Create SUID/SGID Wrappers.2837machine # [ 110.055661] systemd[1]: Starting templated-simple-service@instance.service...2838machine # [ 110.082058] systemd[1]: Finished templated-simple-service@instance.service.2839machine # [ 110.342258] nixos[6864]: finished switching to system configuration /nix/store/f5r6gkrcskq0zradxdjys8q3fy2178wm-nixos-system-machine-test2840machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.66 seconds)2841machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12842machine # [ 110.629081] nixos[7035]: switching to system configuration /nix/store/f5r6gkrcskq0zradxdjys8q3fy2178wm-nixos-system-machine-test2843machine # [ 110.631866] systemd[1]: Stopped target Local File Systems.2844machine # [ 110.634954] systemd[1]: Stopped target Remote File Systems.2845machine # [ 110.964252] systemd[1]: Reload requested from client PID 7035 ('.switch-to-conf') (unit backdoor.service)...2846machine # [ 110.966527] systemd[1]: Reloading...2847machine # [ 111.299440] systemd[1]: Reloading finished in 331 ms.2848machine # [ 111.388452] systemd[538]: Reexecution requested from client PID 7106 ('switch-to-confi')...2849machine # [ 111.389884] systemd[538]: Reexecuting.2850machine # [ 111.446658] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2851machine # [ 111.552737] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2852machine # [ 111.559316] systemd[538]: Reload requested from client PID 7106 ('switch-to-confi')...2853machine # [ 111.562647] systemd[538]: Reloading...2854machine # [ 111.663957] systemd[538]: Reloading finished in 102 ms.2855machine # [ 111.680153] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2856machine # [ 111.691509] systemd[538]: Stopped Run user-specific NixOS activation.2857machine # [ 111.693959] systemd[538]: Stopping Run user-specific NixOS activation...2858machine # [ 111.696183] systemd[538]: Starting Run user-specific NixOS activation...2859machine # [ 111.726083] systemd[538]: Finished Run user-specific NixOS activation.2860machine # [ 111.730423] systemd[1]: Stopped target Reactivate sysinit units.2861machine # [ 111.735835] systemd[1]: Stopping Reactivate sysinit units...2862machine # [ 111.737136] systemd[1]: Reached target Reactivate sysinit units.2863machine # [ 111.739030] systemd[1]: Reloading reload-triggers-and-restart.service...2864machine # [ 111.744269] systemd[1]: Reloading reload-triggers.service...2865machine # [ 111.757812] systemd[1]: Reloading simple-reload-service.service...2866machine # [ 111.767007] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service...2867machine # [ 111.774326] systemd[1]: Reloading templated-reload-triggers@instance.service...2868machine # [ 111.785212] systemd[1]: Reloading templated-simple-reload-service@instance.service...2869machine # [ 111.837001] systemd[1]: Reloaded reload-triggers.service.2870machine # [ 111.843200] systemd[1]: Reloaded simple-reload-service.service.2871machine # [ 111.852813] systemd[1]: Reloaded reload-triggers-and-restart.service.2872machine # [ 111.857781] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service.2873machine # [ 111.861169] systemd[1]: Reloaded templated-reload-triggers@instance.service.2874machine # [ 111.865553] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2875machine # [ 111.868746] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2876machine # [ 111.876578] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2877machine # [ 111.877626] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2878machine # [ 111.878643] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2879machine # [ 111.879633] systemd[1]: simple-restart-service.service: Deactivated successfully.2880machine # [ 111.881223] systemd[1]: Stopped simple-restart-service.service.2881machine # [ 111.882076] systemd[1]: Stopping simple-restart-service.service...2882machine # [ 111.892761] systemd[1]: Starting simple-restart-service.service...2883machine # [ 111.893695] systemd[1]: simple-service.service: Deactivated successfully.2884machine # [ 111.894646] systemd[1]: Stopped simple-service.service.2885machine # [ 111.895371] systemd[1]: Stopping simple-service.service...2886machine # [ 111.920246] systemd[1]: Starting simple-service.service...2887machine # [ 111.921150] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2888machine # [ 111.922627] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2889machine # [ 111.923862] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2890machine # [ 111.955487] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2891machine # [ 111.966676] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2892machine # [ 111.981689] systemd[1]: Stopped templated-simple-restart-service@instance.service.2893machine # [ 111.988445] systemd[1]: Stopping templated-simple-restart-service@instance.service...2894machine # [ 111.989722] systemd[1]: Starting templated-simple-restart-service@instance.service...2895machine # [ 111.990865] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2896machine # [ 111.991992] systemd[1]: Stopped templated-simple-service@instance.service.2897machine # [ 112.003127] systemd[1]: Stopping templated-simple-service@instance.service...2898machine # [ 112.009762] systemd[1]: Starting templated-simple-service@instance.service...2899machine # [ 112.010785] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2900machine # [ 112.011727] systemd[1]: Finished simple-restart-service.service.2901machine # [ 112.017279] systemd[1]: Finished simple-service.service.2902machine # [ 112.018077] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2903machine # [ 112.019203] systemd[1]: Finished templated-simple-service@instance.service.2904machine # [ 112.028534] systemd[1]: Finished templated-simple-restart-service@instance.service.2905machine # [ 112.029612] systemd[1]: Reached target Remote File Systems.2906machine # [ 112.030418] systemd[1]: Reached target Local File Systems.2907machine # [ 112.031198] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2908machine # [ 112.042531] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2909machine # [ 112.043880] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2910machine # [ 112.047714] systemd[1]: Starting Create SUID/SGID Wrappers...2911machine # [ 112.048732] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2912machine # [ 112.049959] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672913machine # [ 112.052781] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2914machine # [ 112.054416] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2915machine # [ 112.056239] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2916machine # [ 112.199799] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2917machine # [ 112.202684] systemd[1]: Finished Create SUID/SGID Wrappers.2918machine # [ 112.206768] systemd[1]: Starting linger-users.service...2919machine # [ 112.243987] systemd[1]: linger-users.service: Deactivated successfully.2920machine # [ 112.246966] systemd[1]: Finished linger-users.service.2921machine # [ 112.503821] nixos[7035]: finished switching to system configuration /nix/store/f5r6gkrcskq0zradxdjys8q3fy2178wm-nixos-system-machine-test2922machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.16 seconds)2923machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&12924machine # [ 112.854267] nixos[7201]: switching to system configuration /nix/store/axqc0npgr8ajayvfyp8aripip42ia40n-nixos-system-machine-test2925machine # [ 112.858849] systemd[1]: Stopped target Remote File Systems.2926machine # [ 112.861529] systemd[1]: Stopped target Local File Systems.2927machine # [ 113.211510] systemd[1]: Reload requested from client PID 7201 ('.switch-to-conf') (unit backdoor.service)...2928machine # [ 113.213890] systemd[1]: Reloading...2929machine # [ 113.666823] systemd[1]: Reloading finished in 452 ms.2930machine # [ 113.785632] systemd[538]: Reexecution requested from client PID 7272 ('switch-to-confi')...2931machine # [ 113.789512] systemd[538]: Reexecuting.2932machine # [ 113.848545] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2933machine # [ 114.011125] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2934machine # [ 114.019468] systemd[538]: Reload requested from client PID 7272 ('switch-to-confi')...2935machine # [ 114.022863] systemd[538]: Reloading...2936machine # [ 114.122432] systemd[538]: Reloading finished in 100 ms.2937machine # [ 114.140210] systemd[538]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2938machine # [ 114.151627] systemd[538]: Stopped Run user-specific NixOS activation.2939machine # [ 114.154057] systemd[538]: Stopping Run user-specific NixOS activation...2940machine # [ 114.155954] systemd[538]: Starting Run user-specific NixOS activation...2941machine # [ 114.186742] systemd[538]: Finished Run user-specific NixOS activation.2942machine # [ 114.190907] systemd[1]: Stopped target Reactivate sysinit units.2943machine # [ 114.196228] systemd[1]: Stopping Reactivate sysinit units...2944machine # [ 114.197121] systemd[1]: Reached target Reactivate sysinit units.2945machine # [ 114.199395] systemd[1]: Reloading reload-triggers.service...2946machine # [ 114.204468] systemd[1]: Reloading simple-reload-service.service...2947machine # [ 114.215854] systemd[1]: Reloading templated-reload-triggers@instance.service...2948machine # [ 114.224389] systemd[1]: Reloading templated-simple-reload-service@instance.service...2949machine # [ 114.276962] systemd[1]: Reloaded simple-reload-service.service.2950machine # [ 114.279891] systemd[1]: Reloaded templated-reload-triggers@instance.service.2951machine # [ 114.282781] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2952machine # [ 114.286949] systemd[1]: Reloaded reload-triggers.service.2953machine # [ 114.292261] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2954machine # [ 114.293494] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2955machine # [ 114.294437] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2956machine # [ 114.299746] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2957machine # [ 114.308924] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully.2958machine # [ 114.310066] systemd[1]: Stopped reload-triggers-and-restart.service.2959machine # [ 114.310941] systemd[1]: Stopping reload-triggers-and-restart.service...2960machine # [ 114.311848] systemd[1]: Starting reload-triggers-and-restart.service...2961machine # [ 114.328293] systemd[1]: simple-restart-service.service: Deactivated successfully.2962machine # [ 114.329411] systemd[1]: Stopped simple-restart-service.service.2963machine # [ 114.330259] systemd[1]: Stopping simple-restart-service.service...2964machine # [ 114.331138] systemd[1]: Starting simple-restart-service.service...2965machine # [ 114.361749] systemd[1]: simple-service.service: Deactivated successfully.2966machine # [ 114.362821] systemd[1]: Stopped simple-service.service.2967machine # [ 114.363717] systemd[1]: Stopping simple-service.service...2968machine # [ 114.384749] systemd[1]: Starting simple-service.service...2969machine # [ 114.396915] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2970machine # [ 114.413578] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2971machine # [ 114.432401] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2972machine # [ 114.443868] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2973machine # [ 114.453963] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully.2974machine # [ 114.466485] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service.2975machine # [ 114.468409] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service...2976machine # [ 114.469976] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2977machine # [ 114.471110] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2978machine # [ 114.474340] systemd[1]: Stopped templated-simple-restart-service@instance.service.2979machine # [ 114.475520] systemd[1]: Stopping templated-simple-restart-service@instance.service...2980machine # [ 114.480483] systemd[1]: Starting templated-simple-restart-service@instance.service...2981machine # [ 114.481608] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2982machine # [ 114.482744] systemd[1]: Stopped templated-simple-service@instance.service.2983machine # [ 114.483684] systemd[1]: Stopping templated-simple-service@instance.service...2984machine # [ 114.485147] systemd[1]: Starting templated-simple-service@instance.service...2985machine # [ 114.486187] systemd[1]: Finished simple-restart-service.service.2986machine # [ 114.487023] systemd[1]: Finished reload-triggers-and-restart.service.2987machine # [ 114.487914] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2988machine # [ 114.490266] systemd[1]: Finished simple-service.service.2989machine # [ 114.491060] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2990machine # [ 114.505209] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2991machine # [ 114.506376] systemd[1]: Finished templated-simple-restart-service@instance.service.2992machine # [ 114.507418] systemd[1]: Finished templated-simple-service@instance.service.2993machine # [ 114.510007] systemd[1]: Reached target Local File Systems.2994machine # [ 114.510854] systemd[1]: Reached target Remote File Systems.2995machine # [ 114.511682] systemd[1]: Starting linger-users.service...2996machine # [ 114.515827] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2997machine # [ 114.522933] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2998machine # [ 114.528827] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2999machine # [ 114.530948] systemd[1]: Starting Create SUID/SGID Wrappers...3000machine # [ 114.535624] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.3001machine # [ 114.538559] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc673002machine # [ 114.542367] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore3003machine # [ 114.546404] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3004machine # [ 114.547772] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3005machine # [ 114.582592] systemd[1]: linger-users.service: Deactivated successfully.3006machine # [ 114.586206] systemd[1]: Finished linger-users.service.3007machine # [ 114.713884] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.3008machine # [ 114.716857] systemd[1]: Finished Create SUID/SGID Wrappers.3009machine # [ 114.972718] nixos[7201]: finished switching to system configuration /nix/store/axqc0npgr8ajayvfyp8aripip42ia40n-nixos-system-machine-test3010machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.47 seconds)3011machine: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&13012machine: (finished: must succeed: /nix/store/jp7laqc5x2vsyywpcdkhwqzi1lnxd83w-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.34 seconds)3013(finished: subtest: restart and reload by activation script, in 9.61 seconds)3014(finished: run the VM test script, in 116.02 seconds)3015test script finished in 116.07s3016cleanup3017kill QemuMachine (pid 45)3018machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14)3019machine # [2026-10-14T03:15:50Z INFO virtiofsd] Client disconnected, shutting down3020machine # [2026-10-14T03:15:50Z INFO virtiofsd] Client disconnected, shutting down3021machine # [2026-10-14T03:15:50Z INFO virtiofsd] Client disconnected, shutting down3022(finished: cleanup, in 0.17 seconds)3023additionally exposed symbols:3024 machine, other,3025 vlan1,3026 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