nixbot

builds

succeeded vm-test-run-switch-test-services checks.aarch64-linux.switchTest · build #41 · raw

1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.01 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.qxg8ldsMSs', 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: cde7f0cc-4b78-46bc-b375-eaef85d5760117machine # 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-09-22T02:58:43Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)28machine # [2026-09-22T02:58:43Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether29machine # [2026-09-22T02:58:43Z INFO virtiofsd] Waiting for vhost-user socket connection...30machine # [2026-09-22T02:58:43Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)31machine # [2026-09-22T02:58:43Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether32machine # [2026-09-22T02:58:43Z INFO virtiofsd] Waiting for vhost-user socket connection...33machine # [2026-09-22T02:58:43Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)34machine # [2026-09-22T02:58:43Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether35machine # [2026-09-22T02:58:43Z INFO virtiofsd] Waiting for vhost-user socket connection...36machine # [2026-09-22T02:58:43Z INFO virtiofsd] Client connected, servicing requests37machine # [2026-09-22T02:58:43Z INFO virtiofsd] Client connected, servicing requests38machine # [2026-09-22T02:58:43Z INFO virtiofsd] Client connected, servicing requests39machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]40machine # [ 0.000000] Linux version 6.18.52 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 14 11:36:19 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 s186712 r8192 d116392 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/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/init regInfo=/nix/.ro-store/zf0fbr8l912346haldma0wba9iqqkwfn-closure-info/registration console=ttyAMA0,115200n8 console=tty074machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/zf0fbr8l912346haldma0wba9iqqkwfn-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 74950 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.000037] arm-pv: using stolen time PV118machine # [ 0.000675] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)119machine # [ 0.000887] Console: colour dummy device 80x25120machine # [ 0.000895] printk: legacy console [tty0] enabled121machine # [ 0.001096] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)122machine # [ 0.001102] pid_max: default: 32768 minimum: 301123machine # [ 0.001196] LSM: initializing lsm=capability,landlock,yama,bpf,ima124machine # [ 0.001362] landlock: Up and running.125machine # [ 0.001365] Yama: becoming mindful.126machine # [ 0.001972] LSM support for eBPF active127machine # [ 0.002115] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)128machine # [ 0.002135] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)129machine # [ 0.004107] rcu: Hierarchical SRCU implementation.130machine # [ 0.004112] rcu: Max phase no-delay instances is 1000.131machine # [ 0.005422] fsl-mc MSI: its@8080000 domain created132machine # [ 0.005520] EFI services will not be available.133machine # [ 0.005655] smp: Bringing up secondary CPUs ...134machine # [ 0.005665] smp: Brought up 1 node, 1 CPU135machine # [ 0.005668] SMP: Total of 1 processors activated.136machine # [ 0.005671] CPU: All CPU(s) started at EL1137machine # [ 0.005686] CPU features: detected: Branch Target Identification138machine # [ 0.005690] CPU features: detected: ARMv8.4 Translation Table Level139machine # [ 0.005693] CPU features: detected: Instruction cache invalidation not required for I/D coherence140machine # [ 0.005696] CPU features: detected: Data cache clean to the PoU not required for I/D coherence141machine # [ 0.005700] CPU features: detected: Common not Private translations142machine # [ 0.005703] CPU features: detected: CRC32 instructions143machine # [ 0.005706] CPU features: detected: Data cache clean to Point of Deep Persistence144machine # [ 0.005710] CPU features: detected: Data cache clean to Point of Persistence145machine # [ 0.005713] CPU features: detected: Data independent timing control (DIT)146machine # [ 0.005716] CPU features: detected: E0PD147machine # [ 0.005718] CPU features: detected: Enhanced Counter Virtualization148machine # [ 0.005721] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)149machine # [ 0.005725] CPU features: detected: Enhanced Virtualization Traps150machine # [ 0.005728] CPU features: detected: Fine Grained Traps151machine # [ 0.005731] CPU features: detected: Generic authentication (architected QARMA5 algorithm)152machine # [ 0.005737] CPU features: detected: RCpc load-acquire (LDAPR)153machine # [ 0.005740] CPU features: detected: LSE atomic instructions154machine # [ 0.005742] CPU features: detected: Privileged Access Never155machine # [ 0.005745] CPU features: detected: PMUv3156machine # [ 0.005748] CPU features: detected: RAS Extension Support157machine # [ 0.005751] CPU features: detected: RASv1p1 Extension Support158machine # [ 0.005753] CPU features: detected: Random Number Generator159machine # [ 0.005756] CPU features: detected: Speculation barrier (SB)160machine # [ 0.005759] CPU features: detected: Stage-2 Force Write-Back161machine # [ 0.005761] CPU features: detected: TLB range maintenance instructions162machine # [ 0.005766] CPU features: detected: Speculative Store Bypassing Safe (SSBS)163machine # [ 0.005807] alternatives: applying system-wide alternatives164machine # [ 0.008953] CPU features: detected: BBM Level 2 without TLB conflict abort165machine # [ 0.009143] Memory: 893952K/1048576K available (24448K kernel code, 7094K rwdata, 26372K rodata, 4736K init, 1107K bss, 113300K reserved, 32768K cma-reserved)166machine # [ 0.009751] devtmpfs: initialized167machine # [ 0.011548] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)168machine # [ 0.011577] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).169machine # [ 0.011781] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL170machine # [ 0.011785] 0 pages in range for non-PLT usage171machine # [ 0.011787] 508272 pages in range for PLT usage172machine # [ 0.011899] pinctrl core: initialized pinctrl subsystem173machine # [ 0.012773] DMI not present or invalid.174machine # [ 0.016404] NET: Registered PF_NETLINK/PF_ROUTE protocol family175machine # [ 0.018753] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations176machine # [ 0.018901] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations177machine # [ 0.019291] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations178machine # [ 0.019315] audit: initializing netlink subsys (disabled)179machine # [ 0.019876] thermal_sys: Registered thermal governor 'fair_share'180machine # [ 0.019878] thermal_sys: Registered thermal governor 'bang_bang'181machine # [ 0.019882] thermal_sys: Registered thermal governor 'step_wise'182machine # [ 0.019885] thermal_sys: Registered thermal governor 'user_space'183machine # [ 0.019888] thermal_sys: Registered thermal governor 'power_allocator'184machine # [ 0.019922] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1185machine # [ 0.019931] cpuidle: using governor ladder186machine # [ 0.019937] cpuidle: using governor menu187machine # [ 0.020148] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.188machine # [ 0.020171] ASID allocator initialised with 65536 entries189machine # [ 0.021487] Serial: AMBA PL011 UART driver190machine # [ 0.027322] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1191machine # [ 0.027464] printk: console [ttyAMA0] enabled192machine # [ 0.166594] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages193machine # [ 0.166624] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page194machine # [ 0.166630] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages195machine # [ 0.166634] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page196machine # [ 0.166639] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages197machine # [ 0.166644] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page198machine # [ 0.166648] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages199machine # [ 0.166653] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page200machine # [ 0.175015] fbcon: Taking over console201machine # [ 0.175039] ACPI: Interpreter disabled.202machine # [ 0.182602] iommu: Default domain type: Translated203machine # [ 0.182619] iommu: DMA domain TLB invalidation policy: strict mode204machine # [ 0.183038] SCSI subsystem initialized205machine # [ 0.185222] usbcore: registered new interface driver usbfs206machine # [ 0.185269] usbcore: registered new interface driver hub207machine # [ 0.185294] usbcore: registered new device driver usb208machine # [ 0.185625] pps_core: LinuxPPS API ver. 1 registered209machine # [ 0.185633] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>210machine # [ 0.185643] PTP clock support registered211machine # [ 0.185701] EDAC MC: Ver: 3.0.0212machine # [ 0.190664] scmi_core: SCMI protocol bus registered213machine # [ 0.191745] FPGA manager framework214machine # [ 0.192800] vgaarb: loaded215machine # [ 0.193522] clocksource: Switched to clocksource arch_sys_counter216machine # [ 0.197467] VFS: Disk quotas dquot_6.6.0217machine # [ 0.197511] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)218machine # [ 0.201750] netfs: FS-Cache loaded219machine # [ 0.201924] pnp: PnP ACPI: disabled220machine # [ 0.206286] NET: Registered PF_INET protocol family221machine # [ 0.206469] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)222machine # [ 0.237826] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)223machine # [ 0.237882] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)224machine # [ 0.237912] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)225machine # [ 0.237963] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)226machine # [ 0.238041] TCP: Hash tables configured (established 8192 bind 8192)227machine # [ 0.238164] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)228machine # [ 0.238231] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)229machine # [ 0.238260] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)230machine # [ 0.238342] NET: Registered PF_UNIX/PF_LOCAL protocol family231machine # [ 0.238365] NET: Registered PF_XDP protocol family232machine # [ 0.238387] PCI: CLS 0 bytes, default 64233machine # [ 0.238636] Trying to unpack rootfs image as initramfs...234machine # [ 0.261606] kvm [1]: HYP mode not available235machine # [ 0.370201] Initialise system trusted keyrings236machine # [ 0.371001] workingset: timestamp_bits=42 max_order=18 bucket_order=0237machine # [ 0.372261] squashfs: version 4.0 (2009/01/31) Phillip Lougher238machine # [ 0.373083] 9p: Installing v9fs 9p2000 file system support239machine # [ 0.393949] Key type asymmetric registered240machine # [ 0.393986] Asymmetric key parser 'x509' registered241machine # [ 0.394075] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)242machine # [ 0.401626] io scheduler mq-deadline registered243machine # [ 0.401652] io scheduler kyber registered244machine # [ 0.413727] pl061_gpio 9030000.pl061: PL061 GPIO chip registered245machine # [ 0.414405] ledtrig-cpu: registered to indicate activity on CPUs246machine # [ 0.414787] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:247machine # [ 0.414806] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000248machine # [ 0.414819] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000249machine # [ 0.414828] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000250machine # [ 0.414851] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits251machine # [ 0.414879] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]252machine # [ 0.414964] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00253machine # [ 0.414974] pci_bus 0000:00: root bus resource [bus 00-ff]254machine # [ 0.414980] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]255machine # [ 0.414985] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]256machine # [ 0.414991] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]257machine # [ 0.415072] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint258machine # [ 0.415547] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint259machine # [ 0.415737] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]260machine # [ 0.415755] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]261machine # [ 0.415784] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]262machine # [ 0.415801] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]263machine # [ 0.416262] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint264machine # [ 0.416449] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]265machine # [ 0.416464] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]266machine # [ 0.416494] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]267machine # [ 0.416968] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint268machine # [ 0.417159] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]269machine # [ 0.417177] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]270machine # [ 0.417208] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]271machine # [ 0.417695] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint272machine # [ 0.417884] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]273machine # [ 0.417900] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]274machine # [ 0.417929] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]275machine # [ 0.417945] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]276machine # [ 0.418410] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint277machine # [ 0.418597] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]278machine # [ 0.418628] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]279machine # [ 0.419089] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint280machine # [ 0.419281] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]281machine # [ 0.419310] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]282machine # [ 0.419711] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint283machine # [ 0.419892] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]284machine # [ 0.420141] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint285machine # [ 0.420326] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]286machine # [ 0.420356] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]287machine # [ 0.420827] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint288machine # [ 0.421014] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]289machine # [ 0.421043] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]290machine # [ 0.421489] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint291machine # [ 0.469782] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]292machine # [ 0.469830] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]293machine # [ 0.470387] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint294machine # [ 0.470685] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]295machine # [ 0.470703] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]296machine # [ 0.470732] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]297machine # [ 0.471198] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint298machine # [ 0.471390] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]299machine # [ 0.471406] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]300machine # [ 0.471436] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]301machine # [ 0.472037] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned302machine # [ 0.472048] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned303machine # [ 0.472054] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned304machine # [ 0.472101] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned305machine # [ 0.472148] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned306machine # [ 0.472196] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned307machine # [ 0.472245] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned308machine # [ 0.472293] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned309machine # [ 0.472343] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned310machine # [ 0.472392] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned311machine # [ 0.472440] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned312machine # [ 0.472488] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned313machine # [ 0.472563] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned314machine # [ 0.472609] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned315machine # [ 0.472630] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned316machine # [ 0.472655] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned317machine # [ 0.472677] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned318machine # [ 0.472699] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned319machine # [ 0.472748] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned320machine # [ 0.472771] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned321machine # [ 0.472797] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned322machine # [ 0.472822] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned323machine # [ 0.472845] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned324machine # [ 0.472867] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned325machine # [ 0.472889] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned326machine # [ 0.472911] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned327machine # [ 0.472933] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned328machine # [ 0.472955] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned329machine # [ 0.472979] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned330machine # [ 0.473001] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned331machine # [ 0.473023] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned332machine # [ 0.473051] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]333machine # [ 0.473061] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]334machine # [ 0.473065] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]335machine # [ 0.473915] pci 0000:00:07.0: enabling device (0000 -> 0002)336machine # [ 0.540505] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)337machine # [ 0.543914] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)338machine # [ 0.554204] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)339machine # [ 0.556254] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)340machine # [ 0.558802] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)341machine # [ 0.561264] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)342machine # [ 0.575105] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)343machine # [ 0.577060] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)344machine # [ 0.580595] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)345machine # [ 0.590974] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)346machine # [ 0.594740] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)347machine # [ 0.608180] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled348machine # [ 0.610988] msm_serial: driver initialized349machine # [ 0.611138] SuperH (H)SCI(F) driver initialized350machine # [ 0.611215] STM32 USART driver initialized351machine # [ 0.648716] loop: module loaded352machine # [ 0.648977] virtio_blk virtio2: 1/0/0 default/read/poll queues353machine # [ 0.651092] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)354machine # [ 0.666378] megasas: 07.734.00.00-rc1355machine # [ 0.667260] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]356machine # [ 0.669418] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000357machine # [ 0.669506] Intel/Sharp Extended Query Table at 0x0031358machine # [ 0.671276] Using buffer write method359machine # [ 0.671372] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]360machine # [ 0.673303] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000361machine # [ 0.673348] Intel/Sharp Extended Query Table at 0x0031362machine # [ 0.682834] Using buffer write method363machine # [ 0.682916] Concatenating MTD devices:364machine # [ 0.682920] (0): "0.flash"365machine # [ 0.682925] (1): "0.flash"366machine # [ 0.682928] into device "0.flash"367machine # [ 0.976351] Freeing initrd memory: 26376K368machine # [ 0.982849] tun: Universal TUN/TAP device driver, 1.6369machine # [ 0.986834] thunder_xcv, ver 1.0370machine # [ 0.986874] thunder_bgx, ver 1.0371machine # [ 0.986896] nicpf, ver 1.0372machine # [ 0.987482] e1000: Intel(R) PRO/1000 Network Driver373machine # [ 0.987489] e1000: Copyright (c) 1999-2006 Intel Corporation.374machine # [ 0.987515] e1000e: Intel(R) PRO/1000 Network Driver375machine # [ 0.987523] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.376machine # [ 0.987550] igb: Intel(R) Gigabit Ethernet Network Driver377machine # [ 0.987559] igb: Copyright (c) 2007-2014 Intel Corporation.378machine # [ 0.987605] igbvf: Intel(R) Gigabit Virtual Function Network Driver379machine # [ 0.987614] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.380machine # [ 0.987755] sky2: driver version 1.30381machine # [ 0.989415] usbcore: registered new interface driver usb-storage382machine # [ 0.989499] usbcore: registered new interface driver usbserial_generic383machine # [ 0.989513] usbserial: USB Serial support registered for generic384machine # [ 0.999654] ehci-pci 0000:00:07.0: EHCI Host Controller385machine # [ 0.999688] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1386machine # [ 0.999947] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000387machine # [ 1.003057] hv_vmbus: registering driver hyperv_keyboard388machine # [ 1.004636] rtc-pl031 9010000.pl031: registered as rtc0389machine # [ 1.004666] rtc-pl031 9010000.pl031: setting system clock to 2026-09-22T02:58:45 UTC (1790045925)390machine # [ 1.005025] i2c_dev: i2c /dev entries driver391machine # [ 1.010652] sdhci: Secure Digital Host Controller Interface driver392machine # [ 1.010668] sdhci: Copyright(c) Pierre Ossman393machine # [ 1.010960] Synopsys Designware Multimedia Card Interface Driver394machine # [ 1.011334] sdhci-pltfm: SDHCI platform and OF driver helper395machine # [ 1.012941] hid: raw HID events driver (C) Jiri Kosina396machine # [ 1.013190] usbcore: registered new interface driver usbhid397machine # [ 1.013196] usbhid: USB HID core driver398machine # [ 1.018068] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00399machine # [ 1.019128] hub 1-0:1.0: USB hub found400machine # [ 1.019624] hub 1-0:1.0: 6 ports detected401machine # [ 1.021391] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available402machine # [ 1.024165] drop_monitor: Initializing network drop monitor service403machine # [ 1.024363] NET: Registered PF_INET6 protocol family404machine # [ 1.026381] Segment Routing with IPv6405machine # [ 1.026398] In-situ OAM (IOAM) with IPv6406machine # [ 1.026430] NET: Registered PF_PACKET protocol family407machine # [ 1.028052] 9pnet: Installing 9P2000 support408machine # [ 1.028108] Key type dns_resolver registered409machine # [ 1.035345] registered taskstats version 1410machine # [ 1.035513] Loading compiled-in X.509 certificates411machine # [ 1.044938] Demotion targets for Node 0: null412machine # [ 1.045072] Key type .fscrypt registered413machine # [ 1.045084] Key type fscrypt-provisioning registered414machine # [ 1.045192] ima: No TPM chip found, activating TPM-bypass!415machine # [ 1.045215] ima: Allocated hash algorithm: sha1416machine # [ 1.045248] ima: No architecture policies found417machine # [ 1.049443] input: gpio-keys as /devices/platform/gpio-keys/input/input0418machine # [ 1.068277] clk: Disabling unused clocks419machine # [ 1.068318] PM: genpd: Disabling unused power domains420machine # [ 1.073037] Freeing unused kernel memory: 4736K421machine # [ 1.073259] Run /init as init process422machine # [ 1.092202] systemd[1]: Successfully made /usr/ read-only.423machine # [ 1.265701] usb 1-1: new high-speed USB device number 2 using ehci-pci424machine # [ 1.417648] 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/input1425machine # [ 1.427317] systemd[1]: systemd 262-e362a4e 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)426machine # [ 1.440545] systemd[1]: Detected virtualization qemu.427machine # [ 1.442773] systemd[1]: Detected architecture arm64.428machine # [ 1.444696] systemd[1]: Running in initrd.429machine # [ 1.447720] systemd[1]: Initializing machine ID from random generator.430machine # [ 1.451039] systemd[1]: Hostname set to <machine>.431machine # [ 1.517839] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0432machine # [ 1.594844] systemd[1]: bpf-restrict-fs: LSM BPF program attached433machine # [ 1.637768] usb 1-2: new high-speed USB device number 3 using ehci-pci434machine # [ 1.657010] systemd[1]: Queued start job for default target Initrd Default Target.435machine # [ 1.663787] systemd[1]: Created slice Slice /system/modprobe.436machine # [ 1.664863] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.437machine # [ 1.666009] systemd[1]: Expecting device /dev/disk/by-label/nixos...438machine # [ 1.666968] systemd[1]: Reached target Path Units.439machine # [ 1.667634] systemd[1]: Reached target Slice Units.440machine # [ 1.668304] systemd[1]: Reached target Swaps.441machine # [ 1.668955] systemd[1]: Reached target Timer Units.442machine # [ 1.669805] systemd[1]: Listening on D-Bus System Message Bus Socket.443machine # [ 1.670753] systemd[1]: Listening on Journal Socket (/dev/log).444machine # [ 1.671789] systemd[1]: Listening on Journal Sockets.445machine # [ 1.672595] systemd[1]: Listening on udev Kernel Socket.446machine # [ 1.673353] systemd[1]: Reached target Socket Units.447machine # [ 1.675649] systemd[1]: Starting Create List of Static Device Nodes...448machine # [ 1.675747] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs449machine # [ 1.685743] systemd[1]: Mounting Kernel Configuration File System...450machine # [ 1.693873] systemd[1]: Starting Journal Service...451machine # [ 1.710606] systemd[1]: Starting Load Kernel Modules...452machine # [ 1.712239] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os453machine # [ 1.748301] systemd-journald[71]: Collecting audit messages is disabled.454machine # [ 1.748519] systemd[1]: Starting Coldplug All udev Devices...455machine # [ 1.752108] systemd[1]: Finished Create List of Static Device Nodes.456machine # [ 1.754197] systemd[1]: Mounted Kernel Configuration File System.457machine # [ 1.769749] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...458machine # [ 1.783414] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.459machine # [ 1.804992] 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/input2460machine # [ 1.805146] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0461machine # [ 1.809633] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev462machine # [ 1.827329] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0463machine # [ 1.827574] [drm] features: -virgl +edid -resource_blob -host_visible464machine # [ 1.827586] [drm] features: -context_init465machine # [ 1.828345] [drm] number of scanouts: 1466machine # [ 1.828363] [drm] number of cap sets: 0467machine # [ 1.832609] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.468machine # [ 1.839599] systemd[1]: Starting Create Static Device Nodes in /dev...469machine # [ 1.853979] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic470machine # [ 1.854004] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0471machine # [ 1.881822] Console: switching to colour frame buffer device 160x50472machine # [ 1.889107] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device473machine # [ 1.902249] systemd[1]: Finished Create Static Device Nodes in /dev.474machine # [ 1.902720] systemd[1]: Reached target Preparation for Local File Systems.475machine # [ 1.902759] systemd[1]: Reached target Local File Systems.476machine # [ 1.910364] systemd[1]: Starting Rule-based Manager for Device Events and Files...477machine # [ 1.938331] systemd[1]: Finished Load Kernel Modules.478machine # [ 1.942415] systemd[1]: Starting Apply Kernel Variables...479machine # [ 1.942502] systemd-modules-load[72]: Inserted module 'dm_mod'480machine # [ 1.943851] systemd-modules-load[72]: Module 'virtio_balloon' is built in481machine # [ 1.969910] systemd[1]: Started Journal Service.482machine # [ 1.956643] systemd-modules-load[72]: Module 'virtio_console' is built in483machine # [ 1.957881] systemd-modules-load[72]: Inserted module 'virtio_gpu'484machine # [ 1.958959] systemd-modules-load[72]: Module 'virtio_rng' is built in485machine # [ 1.974055] systemd[1]: Starting Create System Files and Directories...486machine # [ 2.021348] systemd[1]: Finished Apply Kernel Variables.487machine # [ 2.025708] systemd-udevd[78]: Using default interface naming scheme 'v261'.488machine # [ 2.041243] systemd[1]: Finished Create System Files and Directories.489machine # [ 2.065508] systemd[1]: Started Rule-based Manager for Device Events and Files.490machine # [ 2.159617] systemd[1]: Starting Virtual Console Setup...491machine # [ 2.245220] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones.492machine # [ 2.252682] systemd[1]: Finished Virtual Console Setup.493machine # [ 2.892123] systemd[1]: Finished Coldplug All udev Devices.494machine # [ 2.893137] systemd[1]: Reached target System Initialization.495machine # [ 2.893962] systemd[1]: Reached target Basic System.496machine # [ 3.080134] (udev-worker)[90]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.497machine # [ 3.084621] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line.498machine # [ 3.151743] systemd[1]: Found device /dev/disk/by-label/nixos.499machine # [ 3.156231] systemd[1]: Reached target Initrd Root Device.500machine # [ 3.159422] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...501machine # [ 3.217019] systemd-fsck[109]: nixos: clean, 12/65536 files, 13019/262144 blocks502machine # [ 3.224545] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.503machine # [ 3.228953] systemd[1]: Mounting /sysroot...504machine # [ 3.291172] EXT4-fs (vda): mounted filesystem cde7f0cc-4b78-46bc-b375-eaef85d57601 r/w with ordered data mode. Quota mode: none.505machine # [ 3.275328] systemd[1]: Mounted /sysroot.506machine # [ 3.279297] systemd[1]: Reached target Initrd Root File System.507machine # [ 3.283171] systemd[1]: Starting Mountpoints Configured in the Real Root...508machine # [ 3.312477] systemd-sysroot-fstab-check[117]: /sysroot should be mounted in the initrd, will request daemon-reload.509machine # [ 3.320968] systemd[1]: Reload requested from client PID 117 ('systemd-sysroot') (unit initrd-parse-etc.service)...510machine # [ 3.324151] systemd[1]: Reloading...511machine # [ 3.534484] systemd[1]: Reloading finished in 210 ms.512machine # [ 3.571822] systemd-sysroot-fstab-check[117]: Requesting initrd-fs.target/start/replace...513machine # [ 3.576268] systemd-sysroot-fstab-check[117]: Requesting swap.target/start/replace...514machine # [ 3.584477] systemd[1]: initrd-parse-etc.service: Deactivated successfully.515machine # [ 3.585601] systemd[1]: Finished Mountpoints Configured in the Real Root.516machine # [ 3.587138] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.517machine # [ 3.732786] systemd[1]: Mounting /sysroot/nix/.ro-store...518machine # [ 3.741002] systemd[1]: Mounting /sysroot/nix/.rw-store...519machine # [ 3.756968] systemd[1]: Mounting /sysroot/run...520machine # [ 3.766353] systemd[1]: Mounting /sysroot/tmp/shared...521machine # [ 3.796297] systemd[1]: Mounting /sysroot/tmp/xchg...522machine # [ 3.872418] fuse: init (API version 7.45)523machine # [ 3.883898] virtiofs virtio6: discovered new tag: nix-store524machine # [ 3.884762] virtiofs virtio6: virtio_fs_setup_dax: No cache capability525machine # [ 3.899376] virtiofs virtio7: discovered new tag: shared526machine # [ 3.900198] virtiofs virtio7: virtio_fs_setup_dax: No cache capability527machine # [ 3.907240] virtiofs virtio8: discovered new tag: xchg528machine # [ 3.908047] virtiofs virtio8: virtio_fs_setup_dax: No cache capability529machine # [ 3.929181] systemd[1]: Mounted /sysroot/nix/.ro-store.530machine # [ 3.931116] systemd[1]: Mounted /sysroot/nix/.rw-store.531machine # [ 3.935221] systemd[1]: Mounted /sysroot/run.532machine # [ 3.936677] systemd[1]: Mounted /sysroot/tmp/shared.533machine # [ 3.938721] systemd[1]: Mounted /sysroot/tmp/xchg.534machine # [ 3.948887] systemd[1]: Starting rw-sysroot-nix-store.service...535machine # [ 3.981583] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.536machine # [ 3.984228] systemd[1]: Finished rw-sysroot-nix-store.service.537machine # [ 3.986920] systemd[1]: Mounting /sysroot/nix/store...538machine # [ 4.040942] systemd[1]: Mounted /sysroot/nix/store.539machine # [ 4.043144] systemd[1]: Reached target Initrd File Systems.540machine # [ 4.044635] systemd[1]: Starting Find NixOS closure...541machine # [ 4.064358] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...542machine # [ 4.113041] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.543machine # [ 4.127417] systemd[1]: Finished Find NixOS closure.544machine # [ 4.132279] systemd[1]: Reached target Initrd Default Target.545machine # [ 4.143010] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...546machine # [ 4.178626] systemd[1]: Stopped target Initrd Default Target.547machine # [ 4.184113] systemd[1]: Stopped target Basic System.548machine # [ 4.186498] systemd[1]: Stopped target Initrd Root Device.549machine # [ 4.187414] systemd[1]: Stopped target Path Units.550machine # [ 4.189403] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.551machine # [ 4.192404] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.552machine # [ 4.196843] systemd[1]: Stopped target Slice Units.553machine # [ 4.198548] systemd[1]: Stopped target Socket Units.554machine # [ 4.201916] systemd[1]: Stopped target System Initialization.555machine # [ 4.205654] systemd[1]: Stopped target Swaps.556machine # [ 4.206844] systemd[1]: Stopped target Timer Units.557machine # [ 4.211955] systemd[1]: dbus.socket: Deactivated successfully.558machine # [ 4.214256] systemd[1]: Closed D-Bus System Message Bus Socket.559machine # [ 4.216374] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.560machine # [ 4.225062] systemd[1]: Stopped Find NixOS closure.561machine # [ 4.227811] systemd[1]: Starting rw-sysroot-nix-store.service...562machine # [ 4.232771] systemd[1]: systemd-sysctl.service: Deactivated successfully.563machine # [ 4.233854] systemd[1]: Stopped Apply Kernel Variables.564machine # [ 4.234633] systemd[1]: systemd-modules-load.service: Deactivated successfully.565machine # [ 4.235661] systemd[1]: Stopped Load Kernel Modules.566machine # [ 4.248410] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.567machine # [ 4.252474] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.568machine # [ 4.256322] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.569machine # [ 4.257442] systemd[1]: Stopped Create System Files and Directories.570machine # [ 4.260310] systemd[1]: Stopped target Local File Systems.571machine # [ 4.261152] systemd[1]: Stopped target Preparation for Local File Systems.572machine # [ 4.264432] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.573machine # [ 4.265529] systemd[1]: Stopped Coldplug All udev Devices.574machine # [ 4.266947] systemd[1]: Stopping Rule-based Manager for Device Events and Files...575machine # [ 4.270877] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.576machine # [ 4.272120] systemd[1]: Stopped Virtual Console Setup.577machine # [ 4.272872] systemd[1]: initrd-cleanup.service: Deactivated successfully.578machine # [ 4.273801] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.579machine # [ 4.274702] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.580machine # [ 4.275721] systemd[1]: Finished rw-sysroot-nix-store.service.581machine # [ 4.281852] systemd[1]: systemd-udevd.service: Deactivated successfully.582machine # [ 4.283266] systemd[1]: Stopped Rule-based Manager for Device Events and Files.583machine # [ 4.288575] systemd[1]: systemd-udevd.service: Consumed 1.084s CPU time over 2.390s wall clock time, 16M memory peak.584machine # [ 4.290031] systemd[1]: Starting Cleanup udev Database...585machine # [ 4.290825] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.586machine # [ 4.293787] systemd[1]: Stopped Create Static Device Nodes in /dev.587machine # [ 4.294824] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.588machine # [ 4.296114] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.589machine # [ 4.297179] systemd[1]: kmod-static-nodes.service: Deactivated successfully.590machine # [ 4.298153] systemd[1]: Stopped Create List of Static Device Nodes.591machine # [ 4.328674] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.592machine # [ 4.330382] systemd[1]: Finished Cleanup udev Database.593machine # [ 4.332938] systemd[1]: Reached target Switch Root.594machine # [ 4.335850] systemd[1]: Starting NixOS Activation...595machine # [ 4.443443] initrd-nixos-activation-start[166]: booting system configuration /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test596machine # [ 4.488180] initrd-nixos-activation-start[166]: running activation script...597machine # [ 4.779539] initrd-nixos-activation-start[189]: setting up /etc...598machine # [ 4.924570] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.599machine # [ 4.927887] systemd[1]: Finished NixOS Activation.600machine # [ 4.929838] systemd[1]: Starting Switch Root...601machine # [ 4.954620] systemd[1]: Switching root.602machine # [ 5.147383] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).603machine # [ 5.648546] systemd[1]: systemd 262-e362a4e 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)604machine # [ 5.662360] systemd[1]: Detected virtualization qemu.605machine # [ 5.666027] systemd[1]: Detected architecture arm64.606machine # [ 5.670435] systemd[1]: Detected first boot.607machine # [ 5.676648] systemd[1]: Initializing machine ID from random generator.608machine # [ 5.820176] systemd[1]: bpf-restrict-fs: LSM BPF program attached609machine # [ 6.010179] systemd[1]: Applying preset policy.610machine # [ 6.261127] systemd[1]: Populated /etc with preset unit settings.611machine # [ 6.506677] systemd[1]: initrd-switch-root.service: Deactivated successfully.612machine # [ 6.508512] systemd[1]: Stopped initrd-switch-root.service.613machine # [ 6.512605] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.614machine # [ 6.516387] systemd[1]: Created slice Slice /system/getty.615machine # [ 6.519776] systemd[1]: Created slice User and Session Slice.616machine # [ 6.521185] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.617machine # [ 6.523670] systemd[1]: Started Forward Password Requests to Wall Directory Watch.618machine # [ 6.525110] systemd[1]: Expecting device /dev/hvc0...619machine # [ 6.526685] systemd[1]: Expecting device /dev/ttyAMA0...620machine # [ 6.528167] systemd[1]: Reached target Local Encrypted Volumes.621machine # [ 6.529985] systemd[1]: Stopped target initrd-fs.target.622machine # [ 6.531454] systemd[1]: Stopped target initrd-root-fs.target.623machine # [ 6.532975] systemd[1]: Stopped target initrd-switch-root.target.624machine # [ 6.534655] systemd[1]: Reached target Virtual Machines and Containers.625machine # [ 6.536295] systemd[1]: Reached target Path Units.626machine # [ 6.537795] systemd[1]: Reached target Remote File Systems.627machine # [ 6.539370] systemd[1]: Reached target Slice Units.628machine # [ 6.540846] systemd[1]: Reached target Swaps.629machine # [ 6.543697] systemd[1]: Listening on Query the User Interactively for a Password.630machine # [ 6.546996] systemd[1]: Listening on Process Core Dump Socket.631machine # [ 6.549324] systemd[1]: Listening on Credential Encryption/Decryption.632machine # [ 6.551557] systemd[1]: Listening on Factory Reset Management.633machine # [ 6.552843] systemd[1]: Listening on Hostname Service Socket.634machine # [ 6.557387] systemd[1]: Starting Journal Log Access Socket...635machine # [ 6.559657] systemd[1]: Listening on Journal Audit Socket.636machine # [ 6.563633] systemd[1]: Listening on Console Output Muting Service Socket.637machine # [ 6.565340] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.638machine # [ 6.567054] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os639machine # [ 6.570739] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki640machine # [ 6.576785] systemd[1]: Listening on Disk Repartitioning Service Socket.641machine # [ 6.578390] systemd[1]: Listening on udev Varlink Socket.642machine # [ 6.582292] systemd[1]: Mounting Huge Pages File System...643machine # [ 6.591099] systemd[1]: Mounting POSIX Message Queue File System...644machine # [ 6.606030] systemd[1]: Mounting Kernel Debug File System...645machine # [ 6.615109] systemd[1]: Mounting Kernel Trace File System...646machine # [ 6.640417] systemd[1]: Starting Create List of Static Device Nodes...647machine # [ 6.651641] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs648machine # [ 6.669929] systemd[1]: Mounting Kernel Configuration File System...649machine # [ 6.673741] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm650machine # [ 6.686193] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore651machine # [ 6.689299] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse652machine # [ 6.712658] systemd[1]: Mounting FUSE Control File System...653machine # [ 6.718031] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67654machine # [ 6.737410] systemd[1]: Starting Journal Service...655machine # [ 6.754919] systemd[1]: Starting Load Kernel Modules...656machine # [ 6.777930] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...657machine # [ 6.799515] systemd[1]: Starting Remount Root and Kernel File Systems...658machine # [ 6.801246] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os659machine # [ 6.805359] systemd-journald[261]: Collecting audit messages is enabled.660machine # [ 6.791971] systemd[1]: Queued start job for default target Multi-User System.661machine # [ 6.797740] systemd[1]: systemd-journald.service: Deactivated successfully.662machine # [ 6.823676] systemd[1]: Starting Coldplug All udev Devices...663machine # [ 6.832727] systemd[1]: Started Journal Service.664machine # [ 6.826942] systemd[1]: Listening on Journal Log Access Socket.665machine # [ 6.834348] systemd[1]: Mounted Huge Pages File System.666machine # [ 6.835343] systemd[1]: Mounted POSIX Message Queue File System.667machine # [ 6.841060] systemd[1]: Mounted Kernel Debug File System.668machine # [ 6.841924] systemd[1]: Mounted Kernel Trace File System.669machine # [ 6.848460] systemd[1]: Finished Create List of Static Device Nodes.670machine # [ 6.852006] systemd[1]: Mounted Kernel Configuration File System.671machine # [ 6.866648] systemd-modules-load[262]: Module 'atkbd' is built in672machine # [ 6.877186] systemd-modules-load[262]: Module 'loop' is built in673machine # [ 6.897470] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...674machine # [ 6.902328] systemd[1]: Finished Load Kernel Modules.675machine # [ 6.918143] systemd[1]: Starting Firewall...676machine # [ 6.933829] systemd[1]: Starting Apply Kernel Variables...677machine # [ 6.941163] systemd[1]: Mounted FUSE Control File System.678machine # [ 6.958147] systemd-oomd[264]: No swap; memory pressure usage will be degraded679machine # [ 6.985646] EXT4-fs (vda): re-mounted cde7f0cc-4b78-46bc-b375-eaef85d57601.680machine # [ 6.983423] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.681machine # [ 6.993329] systemd[1]: Finished Remount Root and Kernel File Systems.682machine # [ 6.998360] systemd[1]: Listening on Disk Image Download Service Socket.683machine # [ 7.010190] systemd[1]: Starting Flush Journal to Persistent Storage...684machine # [ 7.011310] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore685machine # [ 7.028522] systemd[1]: Starting Load/Save OS Random Seed...686machine # [ 7.029515] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os687machine # [ 7.147178] systemd-journald[261]: Received client request to flush runtime journal.688machine # [ 7.193629] systemd[1]: Finished Load/Save OS Random Seed.689machine # [ 7.194629] systemd[1]: Reached target First Boot Complete.690machine # [ 7.195471] systemd[1]: Finished Apply Kernel Variables.691machine # [ 7.201910] systemd[1]: Finished Flush Journal to Persistent Storage.692machine # [ 7.237327] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.693machine # [ 7.250295] systemd[1]: Starting Create Static Device Nodes in /dev...694machine # [ 7.530734] systemd[1]: Finished Create Static Device Nodes in /dev.695machine # [ 7.531904] systemd[1]: Reached target Preparation for Local File Systems.696machine # [ 7.542587] systemd[1]: Mounting /run/wrappers...697machine # [ 7.549314] systemd[1]: Starting Rule-based Manager for Device Events and Files...698machine # [ 7.656891] systemd[1]: Mounted /run/wrappers.699machine # [ 7.657762] systemd[1]: Reached target Local File Systems.700machine # [ 7.665909] systemd[1]: Listening on Boot Loader Control Service Socket.701machine # [ 7.670802] systemd[1]: Starting Create SUID/SGID Wrappers...702machine # [ 7.671876] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.703machine # [ 7.683963] systemd[1]: Starting Save Transient machine-id to Disk...704machine # [ 7.690306] systemd[1]: Starting Create System Files and Directories...705machine # [ 7.918630] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.706machine # [ 7.933365] systemd[1]: Finished Save Transient machine-id to Disk.707machine # [ 8.014669] systemd[1]: Finished Create System Files and Directories.708machine # [ 8.021810] systemd[1]: Starting Rebuild Journal Catalog...709machine # [ 8.030620] systemd[1]: Starting Record System Boot/Shutdown in UTMP...710machine # [ 8.042021] systemd-udevd[301]: Using default interface naming scheme 'v261'.711machine # [ 8.188284] systemd[1]: Finished Record System Boot/Shutdown in UTMP.712machine # [ 8.226855] systemd[1]: Finished Rebuild Journal Catalog.713machine # [ 8.241659] systemd[1]: Starting Update is Completed...714machine # [ 8.242640] systemd[1]: Started Rule-based Manager for Device Events and Files.715machine # [ 8.389525] systemd[1]: Finished Update is Completed.716machine # [ 8.578008] systemd[1]: Finished Coldplug All udev Devices.717machine # [ 8.839248] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.718machine # [ 8.844426] systemd[1]: Finished Create SUID/SGID Wrappers.719machine # [ 8.850022] systemd[1]: Reached target System Initialization.720machine # [ 8.851082] systemd[1]: Started Discard unused filesystem blocks once a week.721machine # [ 8.854733] systemd[1]: Started Daily Cleanup of Temporary Directories.722machine # [ 8.855906] systemd[1]: Reached target Timer Units.723machine # [ 8.863378] systemd[1]: Listening on D-Bus System Message Bus Socket.724machine # [ 8.866342] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.725machine # [ 8.867662] systemd[1]: Reached target Socket Units.726machine # [ 8.874667] systemd[1]: Reached target Basic System.727machine # [ 8.875516] systemd[1]: Starting Import lastlog data into lastlog2 database...728machine # [ 8.886364] systemd[1]: Starting Name Service Cache Daemon (nsncd)...729machine # [ 8.896999] systemd[1]: Starting Post-Boot Actions...730machine # [ 8.915824] systemd[1]: Started Reset console on configuration changes.731machine # [ 8.933461] systemd[1]: Starting resolvconf update...732machine # [ 8.992290] systemd[1]: Starting D-Bus System Message Bus...733machine # [ 9.039950] nsncd[416]: Sep 22 02:58:53.556 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"734machine # [ 9.059234] systemd[1]: Started Name Service Cache Daemon (nsncd).735machine # [ 9.072726] systemd[1]: Finished Post-Boot Actions.736machine # [ 9.117269] systemd[1]: Reached target Host and Network Name Lookups.737machine # [ 9.118410] systemd[1]: Reached target User and Group Name Lookups.738machine # [ 9.149937] systemd[1]: Starting User Login Management...739machine # [ 9.228922] systemd[1]: Finished Import lastlog data into lastlog2 database.740machine # [ 9.245341] dbus-broker-launch[423]: Looking up NSS user entry for 'systemd-timesync'...741machine # [ 9.257100] dbus-broker-launch[423]: NSS returned no entry for 'systemd-timesync'742machine # [ 9.258327] dbus-broker-launch[423]: Invalid user-name in /nix/store/kpsc35llka2514wxv7gim1g51s6hmkb2-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"743machine # [ 9.312522] systemd[1]: Started D-Bus System Message Bus.744machine # [ 9.394451] dbus-broker-launch[423]: Ready745machine # [ 9.405086] systemd-logind[442]: New seat seat0.746machine # [ 9.410165] systemd[1]: Started User Login Management.747machine # [ 9.418872] systemd[1]: Starting linger-users.service...748machine # [ 9.522346] systemd[1]: Stopped target Host and Network Name Lookups.749machine # [ 9.523564] systemd[1]: Stopping Host and Network Name Lookups...750machine # [ 9.534973] systemd[1]: Stopped target User and Group Name Lookups.751machine # [ 9.540779] systemd[1]: Stopping User and Group Name Lookups...752machine # [ 9.543942] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...753machine # [ 9.548461] systemd[1]: nscd.service: Deactivated successfully.754machine # [ 9.549431] systemd[1]: Stopped Name Service Cache Daemon (nsncd).755machine # [ 9.581713] systemd[1]: Starting Name Service Cache Daemon (nsncd)...756machine # [ 9.678799] systemd[1]: Created slice Slice /user/1001.757machine # [ 9.679849] systemd[1]: Starting User Runtime Directory /run/user/1001...758machine # [ 9.735096] systemd[1]: linger-users.service: Deactivated successfully.759machine # [ 9.761944] systemd[1]: Finished linger-users.service.760machine # [ 9.843062] nsncd[506]: Sep 22 02:58:54.352 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"761machine # [ 9.883580] systemd[1]: Finished User Runtime Directory /run/user/1001.762machine # [ 9.904803] systemd[1]: Starting User Manager for UID 1001...763machine # [ 9.905822] systemd[1]: Started Name Service Cache Daemon (nsncd).764machine # [ 9.954795] systemd[1]: Reached target Host and Network Name Lookups.765machine # [ 9.980738] systemd[1]: Reached target User and Group Name Lookups.766machine # [ 9.999993] systemd[1]: Finished resolvconf update.767machine # [ 10.015697] systemd[1]: Starting DHCP Client...768machine # [ 10.055698] (systemd)[527]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0)769machine # [ 10.101988] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3770machine # [ 10.107234] systemd-logind[442]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'.771machine # [ 10.191350] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy772machine # [ 10.513578] systemd[527]: Queued start job for default target Main User Target.773machine # [ 10.547797] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy774machine # [ 10.617485] systemd[527]: Created slice User Application Slice.775machine # [ 10.666122] systemd[527]: Started Daily Cleanup of User's Temporary Directories.776machine # [ 10.695544] systemd[527]: Reached target Paths.777machine # [ 10.714203] systemd[527]: Reached target Timers.778machine # [ 10.741054] systemd[527]: Starting D-Bus User Message Bus Socket...779machine # [ 10.742199] systemd[527]: Starting Create User Files and Directories...780machine # [ 10.743172] systemd[527]: Finished Create User Files and Directories.781machine # [ 10.808538] systemd[527]: Listening on D-Bus User Message Bus Socket.782machine # [ 10.809803] systemd[527]: Reached target Sockets.783machine # [ 10.810561] systemd[527]: Reached target Basic System.784machine # [ 10.811378] systemd[1]: Started User Manager for UID 1001.785machine # [ 10.867641] systemd[527]: Starting Run user-specific NixOS activation...786machine # [ 10.891473] systemd[527]: Finished Run user-specific NixOS activation.787machine # [ 10.906697] systemd[527]: Reached target Main User Target.788machine # [ 10.922966] systemd[527]: Startup finished in 574ms.789machine # [ 10.938847] systemd[1]: Starting Virtual Console Setup...790machine # [ 10.952548] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs791machine # [ 10.987983] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.792machine # [ 11.012259] systemd[1]: Stopped Virtual Console Setup.793machine # [ 11.024915] systemd[1]: Starting Virtual Console Setup...794machine # [ 11.028283] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.795machine # [ 11.136535] dhcpcd[560]: dhcpcd-10.3.2 starting796machine # [ 11.217693] dhcpcd[586]: dev: loaded udev797machine # [ 11.292862] 8021q: 802.1Q VLAN Support v1.8798machine # [ 11.404217] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.799machine # [ 11.421932] systemd[1]: Started backdoor.service.800machine # [ 11.469446] cfg80211: Loading compiled-in X.509 certificates for regulatory database801machine # [ 11.507490] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'802machine # [ 11.508012] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'803machine # [ 11.511834] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2804machine # [ 11.512175] cfg80211: failed to load regulatory.db805machine # [ 11.518419] (udev-worker)[587]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.806machine # [ 11.565260] (udev-worker)[587]: Network interface NamePolicy= disabled on kernel command line.807machine # [ 11.796622] systemd[1]: Condition check resulted in Virtio network device being skipped.808machine # [ 11.826697] systemd[1]: Finished Firewall.809machine # [ 11.843397] systemd[1]: Reached target Preparation for Network.810machine # [ 11.868899] systemd[1]: Starting Address configuration of eth1...811machine # [ 11.886850] systemd[1]: Starting Extra networking commands....812machine # [ 11.982571] systemd-logind[442]: Watching system buttons on /dev/input/event0 (gpio-keys)813machine # connecting to host...814machine # [ 12.116581] 8021q: adding VLAN 0 to HW filter on device eth0815machine # [ 12.124133] mousedev: PS/2 mouse device common for all mice816machine # [ 12.116532] dhcpcd[586]: eth0: waiting for carrier817machine: Guest shell says: b'Spawning backdoor root shell...\n'818machine: connected to guest root shell819machine # [ 12.137897] dhcpcd[586]: eth0: waiting for carrier820machine: (connecting took 12.52 seconds)821machine # [ 12.138723] dhcpcd[586]: eth0: carrier acquired822machine: (finished: waiting for the VM to finish booting, in 13.03 seconds)823machine # [ 12.263449] dhcpcd[586]: DUID 00:01:00:01:32:44:ab:70:52:54:00:12:34:56824machine # [ 12.287020] dhcpcd[586]: eth0: IAID 00:12:34:56825machine # [ 12.287831] dhcpcd[586]: eth0: adding address fe80::5054:ff:fe12:3456826machine # [ 12.319336] systemd-logind[442]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)827machine # [ 12.358945] 8021q: adding VLAN 0 to HW filter on device eth1828machine # [ 12.356604] systemd-vconsole-setup[574]: Configuration of first virtual console was skipped, ignoring remaining ones.829machine # [ 12.358861] systemd[1]: Finished Virtual Console Setup.830machine # [ 12.490400] network-addresses-eth1-start[618]: adding address 192.168.1.1/24... done831machine # [ 12.605969] network-addresses-eth1-start[618]: adding address 2001:db8:1::1/64... done832machine # [ 12.707950] dhcpcd[586]: eth0: soliciting a DHCP lease833machine # [ 12.726047] dhcpcd[586]: eth0: offered 10.0.2.15 from 10.0.2.2834machine # [ 12.727135] dhcpcd[586]: eth0: probing address 10.0.2.15/24835machine # [ 12.763165] systemd[1]: Finished Address configuration of eth1.836machine # [ 13.457756] systemd[1]: Finished Extra networking commands..837machine # [ 13.458752] systemd[1]: Reached target Network.838machine # [ 13.489964] systemd[1]: Starting Permit User Sessions...839machine # [ 13.755298] systemd[1]: Finished Permit User Sessions.840machine # [ 13.767057] systemd[1]: Started Getty on tty1.841machine # [ 13.767910] systemd[1]: Reached target Login Prompts.842machine # [ 13.864179] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.843machine # [ 13.865433] systemd[1]: Stopped Virtual Console Setup.844machine # [ 13.866203] systemd[1]: Stopping Virtual Console Setup...845machine # [ 13.918383] systemd[1]: Starting Virtual Console Setup...846machine # [ 13.938635] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.847machine # [ 13.962211] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.848machine # [ 13.974466] systemd[1]: Stopped Virtual Console Setup.849machine # [ 13.975434] systemd[1]: Starting Virtual Console Setup...850machine # [ 13.987243] systemd-logind[442]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)851machine # [ 14.163010] systemd-vconsole-setup[703]: Configuration of first virtual console was skipped, ignoring remaining ones.852machine # [ 14.171548] systemd[1]: Finished Virtual Console Setup.853machine # [ 14.194477] dhcpcd[586]: eth0: soliciting an IPv6 router854machine # [ 14.196237] dhcpcd[586]: eth0: Router Advertisement from fe80::2855machine # [ 14.197190] dhcpcd[586]: eth0: adding address fec0::5054:ff:fe12:3456/64856machine # [ 14.198131] dhcpcd[586]: eth0: adding route to fec0::/64857machine # [ 14.198889] dhcpcd[586]: eth0: adding default route via fe80::2858machine # [ 17.166422] dhcpcd[586]: eth0: leased 10.0.2.15 for 86400 seconds859machine # [ 17.171867] dhcpcd[586]: eth0: adding route to 10.0.2.0/24860machine # [ 17.177750] dhcpcd[586]: eth0: adding default route via 10.0.2.2861machine # [ 17.362176] systemd[1]: Started DHCP Client.862machine # [ 17.365547] systemd[1]: Reached target Multi-User System.863machine # [ 17.370989] systemd[1]: Startup finished in 1.056s (kernel) + 4.145s (initrd) + 12.164s (userspace) = 17.366s.864machine: (finished: waiting for unit multi-user.target, in 18.34 seconds)865machine: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/bin/switch-to-configuration test866machine # Checking switch inhibitors... done867machine # [ 17.728164] nixos[801]: switching to system configuration /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test868machine # [ 17.731325] systemd[1]: Stopped target Remote File Systems.869machine # activating the configuration...870machine # [ 17.734533] systemd[1]: Stopped target Local File Systems.871machine # setting up /etc...872machine # [ 18.119904] systemd[1]: Reload requested from client PID 801 ('.switch-to-conf') (unit backdoor.service)...873machine # [ 18.122335] systemd[1]: Reloading...874machine # [ 18.599795] systemd[1]: Reloading finished in 472 ms.875machine # reloading user units for usertest...876machine # [ 18.662142] systemd[527]: Created slice User Core Session Slice.877machine # [ 18.667943] systemd[527]: Starting D-Bus User Message Bus...878machine # [ 18.729175] dbus-broker-launch[871]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/kpsc35llka2514wxv7gim1g51s6hmkb2-system-path/share/dbus-1/services/org.freedesktop.import1.service'879machine # [ 18.732403] dbus-broker-launch[871]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/kpsc35llka2514wxv7gim1g51s6hmkb2-system-path/share/dbus-1/services/org.freedesktop.machine1.service'880machine # [ 18.735614] dbus-broker-launch[871]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/kpsc35llka2514wxv7gim1g51s6hmkb2-system-path/share/dbus-1/services/org.freedesktop.portable1.service'881machine # [ 18.738954] dbus-broker-launch[871]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/kpsc35llka2514wxv7gim1g51s6hmkb2-system-path/share/dbus-1/services/org.freedesktop.systemd1.service'882machine # [ 18.744205] dbus-broker-launch[871]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored883machine # [ 18.746030] dbus-broker-launch[871]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored884machine # [ 18.747815] systemd[527]: Started D-Bus User Message Bus.885machine # [ 18.754758] dbus-broker-launch[871]: Ready886machine # [ 18.811073] systemd[527]: Reexecution requested from client PID 869 ('switch-to-confi')...887machine # [ 18.812946] systemd[527]: Reexecuting.888machine # [ 18.873092] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy889machine # [ 19.009843] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy890machine # [ 19.018712] systemd[527]: Reload requested from client PID 869 ('switch-to-confi')...891machine # [ 19.021237] systemd[527]: Reloading...892machine # [ 19.170144] systemd[527]: Reloading finished in 147 ms.893machine # [ 19.188231] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy894machine # restarting the following user units: nixos-activation.service895machine # [ 19.201882] systemd[527]: Stopped Run user-specific NixOS activation.896machine # [ 19.204147] systemd[527]: Stopping Run user-specific NixOS activation...897machine # [ 19.207888] systemd[527]: Starting Run user-specific NixOS activation...898machine # [ 19.251416] systemd[527]: Finished Run user-specific NixOS activation.899machine # restarting sysinit-reactivation.target900machine # [ 19.268386] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....901machine # [ 19.387406] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..902machine # [ 19.390322] systemd[1]: Reached target Reactivate sysinit units.903machine # [ 19.399028] systemd[1]: Reached target Local File Systems.904machine # [ 19.405344] systemd[1]: Reached target Remote File Systems.905machine # [ 19.411780] systemd[1]: Starting linger-users.service...906machine # [ 19.428438] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore907machine # [ 19.440917] systemd[1]: Starting Create SUID/SGID Wrappers...908machine # [ 19.442073] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.909machine # [ 19.443471] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67910machine # [ 19.457895] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore911machine # [ 19.459758] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os912machine # [ 19.461989] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os913machine # [ 19.463361] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os914machine # [ 19.469183] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki915machine # [ 19.549923] systemd[1]: linger-users.service: Deactivated successfully.916machine # [ 19.553665] systemd[1]: Finished linger-users.service.917machine # [ 19.786439] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.918machine # [ 19.790878] systemd[1]: Finished Create SUID/SGID Wrappers.919machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service920machine # [ 20.054077] nixos[801]: finished switching to system configuration /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test921machine: (finished: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/bin/switch-to-configuration test, in 2.61 seconds)922machine: must succeed: rm /etc/NIXOS923machine: (finished: must succeed: rm /etc/NIXOS, in 0.04 seconds)924machine: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/yjnagk81wxiy7hj08z5qv6svp27g8kmk-nixos-system-other-test/bin/switch-to-configuration test925machine # this should succeed (config: /nix/store/yjnagk81wxiy7hj08z5qv6svp27g8kmk-nixos-system-other-test, action: test)926machine # Checking switch inhibitors... done927machine # [ 20.381349] nixos[949]: switching to system configuration /nix/store/yjnagk81wxiy7hj08z5qv6svp27g8kmk-nixos-system-other-test928machine # [ 20.384046] systemd[1]: Stopped target Local File Systems.929machine # activating the configuration...930machine # [ 20.387078] systemd[1]: Stopped target Remote File Systems.931machine # removing user ‘usertest’932machine # setting up /etc...933machine # [ 20.692767] systemd[1]: Reload requested from client PID 949 ('.switch-to-conf') (unit backdoor.service)...934machine # [ 20.694729] systemd[1]: Reloading...935machine # [ 21.044948] systemd[1]: Reloading finished in 348 ms.936machine # reloading user units for usertest...937machine # [ 21.139758] systemd[527]: Reexecution requested from client PID 1020 ('switch-to-confi')...938machine # [ 21.142900] systemd[527]: Reexecuting.939machine # [ 21.200436] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy940machine # [ 21.328834] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy941machine # [ 21.335380] systemd[527]: Reload requested from client PID 1020 ('switch-to-confi')...942machine # [ 21.339398] systemd[527]: Reloading...943machine # [ 21.455853] systemd[527]: Reloading finished in 117 ms.944machine # [ 21.474167] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy945machine # restarting the following user units: nixos-activation.service946machine # [ 21.496097] systemd[527]: Stopped Run user-specific NixOS activation.947machine # [ 21.497875] systemd[527]: Stopping Run user-specific NixOS activation...948machine # [ 21.501745] systemd[527]: Starting Run user-specific NixOS activation...949machine # [ 21.554354] systemd[527]: Finished Run user-specific NixOS activation.950machine # restarting sysinit-reactivation.target951machine # [ 21.560858] systemd[1]: Stopped target Reactivate sysinit units.952machine # reloading the following units: dbus-broker.service953machine # [ 21.566414] systemd[1]: Stopping Reactivate sysinit units...954machine # [ 21.567408] systemd[1]: Reached target Reactivate sysinit units.955machine # [ 21.574428] systemd[1]: Reloading D-Bus System Message Bus...956machine # [ 21.575903] dbus-broker-launch[423]: Caught SIGHUP, trigger reload.957machine # [ 21.582709] dbus-broker-launch[423]: Looking up NSS user entry for 'systemd-timesync'...958machine # [ 21.585180] dbus-broker-launch[423]: NSS returned no entry for 'systemd-timesync'959machine # [ 21.586267] dbus-broker-launch[423]: Invalid user-name in /nix/store/vd92pv1qjgrwvlwmklz7wvklvghppc5n-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"960machine # [ 21.614250] systemd[1]: Reloaded D-Bus System Message Bus.961machine # restarting the following units: network-addresses-eth1.service962machine # [ 21.621633] systemd[1]: Stopping Address configuration of eth1...963machine # [ 21.658582] network-addresses-eth1-pre-stop[1033]: deleting address 192.168.1.1/24... done964machine # [ 21.665977] network-addresses-eth1-pre-stop[1033]: deleting address 2001:db8:1::1/64... done965machine # [ 21.673629] systemd[1]: network-addresses-eth1.service: Deactivated successfully.966machine # [ 21.676143] systemd[1]: Stopped Address configuration of eth1.967machine # [ 21.680731] systemd[1]: Starting Address configuration of eth1...968machine # [ 21.724798] network-addresses-eth1-start[1038]: adding address 192.168.1.2/24... done969machine # [ 21.732591] network-addresses-eth1-start[1038]: adding address 2001:db8:1::2/64... done970machine # [ 21.742584] systemd[1]: Finished Address configuration of eth1.971machine # [ 21.749117] systemd[1]: Reached target Remote File Systems.972machine # [ 21.757566] systemd[1]: Reached target Local File Systems.973machine # [ 21.762692] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore974machine # [ 21.767667] systemd[1]: Starting Create SUID/SGID Wrappers...975machine # [ 21.773108] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.976machine # [ 21.774584] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67977machine # [ 21.785293] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore978machine # [ 21.787009] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os979machine # [ 21.788530] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os980machine # [ 21.789786] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os981machine # [ 21.791125] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki982machine # [ 21.997426] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.983machine # [ 21.999386] systemd[1]: Finished Create SUID/SGID Wrappers.984machine # [ 22.005428] systemd[1]: Starting linger-users.service...985machine # [ 22.037436] linger-users-start[1110]: id: ‘usertest’: no such user986machine # [ 22.039663] linger-users-start[1108]: Removing linger for missing user usertest987machine # [ 22.047629] systemd[1]: linger-users.service: Deactivated successfully.988machine # [ 22.049776] systemd[1]: Finished linger-users.service.989machine # [ 22.310865] nixos[949]: finished switching to system configuration /nix/store/yjnagk81wxiy7hj08z5qv6svp27g8kmk-nixos-system-other-test990machine: (finished: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/yjnagk81wxiy7hj08z5qv6svp27g8kmk-nixos-system-other-test/bin/switch-to-configuration test, in 2.23 seconds)991subtest: services992machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/bin/switch-to-configuration test 2>&1993machine # [ 22.627549] nixos[1116]: switching to system configuration /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test994machine # [ 22.630845] systemd[1]: Stopped target Local File Systems.995machine # [ 22.633630] systemd[1]: Stopped target Remote File Systems.996machine # [ 22.930332] systemd[1]: Reload requested from client PID 1116 ('.switch-to-conf') (unit backdoor.service)...997machine # [ 22.932611] systemd[1]: Reloading...998machine # [ 23.477600] systemd[1]: Reloading finished in 543 ms.999machine # [ 23.581387] systemd[527]: Reexecution requested from client PID 1184 ('switch-to-confi')...1000machine # [ 23.585657] systemd[527]: Reexecuting.1001machine # [ 23.636051] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1002machine # [ 23.755069] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1003machine # [ 23.763114] systemd[527]: Reload requested from client PID 1184 ('switch-to-confi')...1004machine # [ 23.766411] systemd[527]: Reloading...1005machine # [ 23.885919] systemd[527]: Reloading finished in 120 ms.1006machine # [ 23.900204] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1007machine # [ 23.911836] systemd[527]: Stopped Run user-specific NixOS activation.1008machine # [ 23.914434] systemd[527]: Stopping Run user-specific NixOS activation...1009machine # [ 23.916716] systemd[527]: Starting Run user-specific NixOS activation...1010machine # [ 23.950017] systemd[527]: Finished Run user-specific NixOS activation.1011machine # [ 23.954248] systemd[1]: Stopped target Reactivate sysinit units.1012machine # [ 23.958419] systemd[1]: Stopping Reactivate sysinit units...1013machine # [ 23.959652] systemd[1]: Reached target Reactivate sysinit units.1014machine # [ 23.961312] systemd[1]: Reloading D-Bus System Message Bus...1015machine # [ 23.963839] dbus-broker-launch[423]: Caught SIGHUP, trigger reload.1016machine # [ 23.967192] dbus-broker-launch[423]: Looking up NSS user entry for 'systemd-timesync'...1017machine # [ 23.969657] dbus-broker-launch[423]: NSS returned no entry for 'systemd-timesync'1018machine # [ 23.970748] dbus-broker-launch[423]: Invalid user-name in /nix/store/kpsc35llka2514wxv7gim1g51s6hmkb2-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1019machine # [ 23.984468] systemd[1]: Reloaded D-Bus System Message Bus.1020machine # [ 23.990750] systemd[1]: Stopping Address configuration of eth1...1021machine # [ 24.024437] network-addresses-eth1-pre-stop[1197]: deleting address 192.168.1.2/24... done1022machine # [ 24.031769] network-addresses-eth1-pre-stop[1197]: deleting address 2001:db8:1::2/64... done1023machine # [ 24.039385] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1024machine # [ 24.042054] systemd[1]: Stopped Address configuration of eth1.1025machine # [ 24.046786] systemd[1]: Starting Address configuration of eth1...1026machine # [ 24.100629] network-addresses-eth1-start[1202]: adding address 192.168.1.1/24... done1027machine # [ 24.109874] network-addresses-eth1-start[1202]: adding address 2001:db8:1::1/64... done1028machine # [ 24.120840] systemd[1]: Finished Address configuration of eth1.1029machine # [ 24.123908] systemd[1]: Reached target Remote File Systems.1030machine # [ 24.126836] systemd[1]: Reached target Local File Systems.1031machine # [ 24.129879] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1032machine # [ 24.137554] systemd[1]: Starting Create SUID/SGID Wrappers...1033machine # [ 24.138629] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1034machine # [ 24.140000] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671035machine # [ 24.151933] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1036machine # [ 24.157629] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1037machine # [ 24.159157] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1038machine # [ 24.163366] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1039machine # [ 24.165829] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1040machine # [ 24.348991] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1041machine # [ 24.353006] systemd[1]: Finished Create SUID/SGID Wrappers.1042machine # [ 24.357301] systemd[1]: Starting linger-users.service...1043machine # [ 24.398094] systemd[1]: linger-users.service: Deactivated successfully.1044machine # [ 24.400158] systemd[1]: Finished linger-users.service.1045machine # [ 24.662380] nixos[1116]: finished switching to system configuration /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test1046machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.34 seconds)1047machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/bin/switch-to-configuration test 2>&11048machine # [ 24.979541] nixos[1271]: switching to system configuration /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test1049machine # [ 24.982726] systemd[1]: Stopped target Local File Systems.1050machine # [ 24.985248] systemd[1]: Stopped target Remote File Systems.1051machine # [ 25.287048] systemd[1]: Reload requested from client PID 1271 ('.switch-to-conf') (unit backdoor.service)...1052machine # [ 25.289502] systemd[1]: Reloading...1053machine # [ 25.633447] systemd[1]: Reloading finished in 342 ms.1054machine # [ 25.726682] systemd[527]: Reexecution requested from client PID 1341 ('switch-to-confi')...1055machine # [ 25.731294] systemd[527]: Reexecuting.1056machine # [ 25.783834] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1057machine # [ 25.900700] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1058machine # [ 25.907612] systemd[527]: Reload requested from client PID 1341 ('switch-to-confi')...1059machine # [ 25.911138] systemd[527]: Reloading...1060machine # [ 26.022621] systemd[527]: Reloading finished in 112 ms.1061machine # [ 26.041697] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1062machine # [ 26.050332] systemd[527]: Stopped Run user-specific NixOS activation.1063machine # [ 26.052849] systemd[527]: Stopping Run user-specific NixOS activation...1064machine # [ 26.055118] systemd[527]: Starting Run user-specific NixOS activation...1065machine # [ 26.090150] systemd[527]: Finished Run user-specific NixOS activation.1066machine # [ 26.094258] systemd[1]: Stopped target Reactivate sysinit units.1067machine # [ 26.096430] systemd[1]: Stopping Reactivate sysinit units...1068machine # [ 26.097334] systemd[1]: Reached target Reactivate sysinit units.1069machine # [ 26.100431] systemd[1]: Reached target Remote File Systems.1070machine # [ 26.104445] systemd[1]: Starting linger-users.service...1071machine # [ 26.116772] systemd[1]: Reached target Local File Systems.1072machine # [ 26.118939] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1073machine # [ 26.120486] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1074machine # [ 26.121789] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1075machine # [ 26.136535] systemd[1]: Starting Create SUID/SGID Wrappers...1076machine # [ 26.141065] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1077machine # [ 26.152318] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671078machine # [ 26.154590] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1079machine # [ 26.159137] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1080machine # [ 26.161151] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1081machine # [ 26.203806] systemd[1]: linger-users.service: Deactivated successfully.1082machine # [ 26.208661] systemd[1]: Finished linger-users.service.1083machine # [ 26.362901] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1084machine # [ 26.365974] systemd[1]: Finished Create SUID/SGID Wrappers.1085machine # [ 26.625618] nixos[1271]: finished switching to system configuration /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test1086machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.96 seconds)1087machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11088machine # [ 26.924517] nixos[1412]: switching to system configuration /nix/store/wamnkqnjjrfs98fs5b697n0za8k6gqa6-nixos-system-machine-test1089machine # [ 26.927053] systemd[1]: Stopped target Local File Systems.1090machine # [ 26.929379] systemd[1]: Stopped target Remote File Systems.1091machine # [ 27.223971] systemd[1]: Reload requested from client PID 1412 ('.switch-to-conf') (unit backdoor.service)...1092machine # [ 27.226255] systemd[1]: Reloading...1093machine # [ 27.571245] systemd[1]: Reloading finished in 342 ms.1094machine # [ 27.657650] systemd[527]: Reexecution requested from client PID 1481 ('switch-to-confi')...1095machine # [ 27.659084] systemd[527]: Reexecuting.1096machine # [ 27.723924] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1097machine # [ 27.864226] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1098machine # [ 27.878268] systemd[527]: Reload requested from client PID 1481 ('switch-to-confi')...1099machine # [ 27.880898] systemd[527]: Reloading...1100machine # [ 28.003790] systemd[527]: Reloading finished in 121 ms.1101machine # [ 28.020193] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1102machine # [ 28.029590] systemd[527]: Stopped Run user-specific NixOS activation.1103machine # [ 28.032157] systemd[527]: Stopping Run user-specific NixOS activation...1104machine # [ 28.034651] systemd[527]: Starting Run user-specific NixOS activation...1105machine # [ 28.070566] systemd[527]: Finished Run user-specific NixOS activation.1106machine # [ 28.074511] systemd[1]: Stopped target Reactivate sysinit units.1107machine # [ 28.076633] systemd[1]: Stopping Reactivate sysinit units...1108machine # [ 28.077578] systemd[1]: Reached target Reactivate sysinit units.1109machine # [ 28.082524] systemd[1]: Reached target Local File Systems.1110machine # [ 28.088274] systemd[1]: Reached target Remote File Systems.1111machine # [ 28.089259] systemd[1]: Starting linger-users.service...1112machine # [ 28.100619] systemd[1]: Starting test.service...1113machine # [ 28.102603] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1114machine # [ 28.111286] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1115machine # [ 28.117992] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1116machine # [ 28.119607] systemd[1]: Starting Create SUID/SGID Wrappers...1117machine # [ 28.132430] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1118machine # [ 28.133870] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671119machine # [ 28.151278] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1120machine # [ 28.164416] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1121machine # [ 28.169166] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1122machine # [ 28.183430] systemd[1]: Finished test.service.1123machine # [ 28.236287] systemd[1]: linger-users.service: Deactivated successfully.1124machine # [ 28.237363] systemd[1]: Finished linger-users.service.1125machine # [ 28.473783] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1126machine # [ 28.476929] systemd[1]: Finished Create SUID/SGID Wrappers.1127machine # [ 28.737751] nixos[1412]: finished switching to system configuration /nix/store/wamnkqnjjrfs98fs5b697n0za8k6gqa6-nixos-system-machine-test1128machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 2.11 seconds)1129machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11130machine # [ 29.017388] nixos[1555]: switching to system configuration /nix/store/wamnkqnjjrfs98fs5b697n0za8k6gqa6-nixos-system-machine-test1131machine # [ 29.019931] systemd[1]: Stopped target Local File Systems.1132machine # [ 29.022425] systemd[1]: Stopped target Remote File Systems.1133machine # [ 29.301031] systemd[1]: Reload requested from client PID 1555 ('.switch-to-conf') (unit backdoor.service)...1134machine # [ 29.302925] systemd[1]: Reloading...1135machine # [ 29.629681] systemd[1]: Reloading finished in 325 ms.1136machine # [ 29.715652] systemd[527]: Reexecution requested from client PID 1624 ('switch-to-confi')...1137machine # [ 29.719613] systemd[527]: Reexecuting.1138machine # [ 29.779873] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1139machine # [ 29.897763] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1140machine # [ 29.904693] systemd[527]: Reload requested from client PID 1624 ('switch-to-confi')...1141machine # [ 29.907200] systemd[527]: Reloading...1142machine # [ 30.017771] systemd[527]: Reloading finished in 109 ms.1143machine # [ 30.032188] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1144machine # [ 30.041270] systemd[527]: Stopped Run user-specific NixOS activation.1145machine # [ 30.043703] systemd[527]: Stopping Run user-specific NixOS activation...1146machine # [ 30.045874] systemd[527]: Starting Run user-specific NixOS activation...1147machine # [ 30.080883] systemd[527]: Finished Run user-specific NixOS activation.1148machine # [ 30.084773] systemd[1]: Stopped target Reactivate sysinit units.1149machine # [ 30.086713] systemd[1]: Stopping Reactivate sysinit units...1150machine # [ 30.087620] systemd[1]: Reached target Reactivate sysinit units.1151machine # [ 30.092624] systemd[1]: Reached target Remote File Systems.1152machine # [ 30.100523] systemd[1]: Starting linger-users.service...1153machine # [ 30.101424] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1154machine # [ 30.102719] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1155machine # [ 30.110560] systemd[1]: Reached target Local File Systems.1156machine # [ 30.113085] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1157machine # [ 30.122448] systemd[1]: Starting Create SUID/SGID Wrappers...1158machine # [ 30.123479] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1159machine # [ 30.132212] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671160machine # [ 30.134783] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1161machine # [ 30.145168] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1162machine # [ 30.146730] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1163machine # [ 30.189171] systemd[1]: linger-users.service: Deactivated successfully.1164machine # [ 30.191781] systemd[1]: Finished linger-users.service.1165machine # [ 30.360895] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1166machine # [ 30.365038] systemd[1]: Finished Create SUID/SGID Wrappers.1167machine # [ 30.622453] nixos[1555]: finished switching to system configuration /nix/store/wamnkqnjjrfs98fs5b697n0za8k6gqa6-nixos-system-machine-test1168machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.89 seconds)1169machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&11170machine # [ 30.937871] nixos[1695]: switching to system configuration /nix/store/cf3dlyy9k54p0dfs9xcgcz1wb3yqvbnh-nixos-system-machine-test1171machine # [ 30.942162] systemd[1]: Stopped target Remote File Systems.1172machine # [ 30.944750] systemd[1]: Stopped target Local File Systems.1173machine # [ 31.247683] systemd[1]: Reload requested from client PID 1695 ('.switch-to-conf') (unit backdoor.service)...1174machine # [ 31.250037] systemd[1]: Reloading...1175machine # [ 31.700144] systemd[1]: Reloading finished in 448 ms.1176machine # [ 31.826298] systemd[527]: Reexecution requested from client PID 1764 ('switch-to-confi')...1177machine # [ 31.827765] systemd[527]: Reexecuting.1178machine # [ 31.887635] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1179machine # [ 32.006301] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1180machine # [ 32.013585] systemd[527]: Reload requested from client PID 1764 ('switch-to-confi')...1181machine # [ 32.016336] systemd[527]: Reloading...1182machine # [ 32.129506] systemd[527]: Reloading finished in 112 ms.1183machine # [ 32.144211] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1184machine # [ 32.156106] systemd[527]: Stopped Run user-specific NixOS activation.1185machine # [ 32.157127] systemd[527]: Stopping Run user-specific NixOS activation...1186machine # [ 32.159748] systemd[527]: Starting Run user-specific NixOS activation...1187machine # [ 32.189680] systemd[527]: Finished Run user-specific NixOS activation.1188machine # [ 32.193425] systemd[1]: Stopped target Reactivate sysinit units.1189machine # [ 32.195471] systemd[1]: Stopping Reactivate sysinit units...1190machine # [ 32.198336] systemd[1]: Reached target Reactivate sysinit units.1191machine # [ 32.199371] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1192machine # [ 32.202628] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1193machine # [ 32.206234] systemd[1]: Reached target Local File Systems.1194machine # [ 32.209199] systemd[1]: Reached target Remote File Systems.1195machine # [ 32.214863] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1196machine # [ 32.224109] systemd[1]: Starting Create SUID/SGID Wrappers...1197machine # [ 32.225222] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1198machine # [ 32.226439] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671199machine # [ 32.231751] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1200machine # [ 32.233870] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1201machine # [ 32.235243] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1202machine # [ 32.401795] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1203machine # [ 32.403907] systemd[1]: Finished Create SUID/SGID Wrappers.1204machine # [ 32.409060] systemd[1]: Starting linger-users.service...1205machine # [ 32.451594] systemd[1]: linger-users.service: Deactivated successfully.1206machine # [ 32.454473] systemd[1]: Finished linger-users.service.1207machine # [ 32.716207] nixos[1695]: finished switching to system configuration /nix/store/cf3dlyy9k54p0dfs9xcgcz1wb3yqvbnh-nixos-system-machine-test1208machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 2.09 seconds)1209machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11210machine # [ 33.017041] nixos[1836]: switching to system configuration /nix/store/ijl55ziz03scd38hmlj5rhw0mnk7rbax-nixos-system-machine-test1211machine # [ 33.020584] systemd[1]: Stopped target Remote File Systems.1212machine # [ 33.021878] systemd[1]: test.service: Deactivated successfully.1213machine # [ 33.024750] systemd[1]: Stopped Test unit.1214machine # [ 33.025826] systemd[1]: Stopped target Local File Systems.1215machine # [ 33.335213] systemd[1]: Reload requested from client PID 1836 ('.switch-to-conf') (unit backdoor.service)...1216machine # [ 33.337308] systemd[1]: Reloading...1217machine # [ 33.711207] systemd[1]: Reloading finished in 372 ms.1218machine # [ 33.800726] systemd[527]: Reexecution requested from client PID 1905 ('switch-to-confi')...1219machine # [ 33.804390] systemd[527]: Reexecuting.1220machine # [ 33.863561] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1221machine # [ 34.005324] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1222machine # [ 34.012207] systemd[527]: Reload requested from client PID 1905 ('switch-to-confi')...1223machine # [ 34.016074] systemd[527]: Reloading...1224machine # [ 34.132943] systemd[527]: Reloading finished in 117 ms.1225machine # [ 34.150038] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1226machine # [ 34.159867] systemd[527]: Stopped Run user-specific NixOS activation.1227machine # [ 34.162348] systemd[527]: Stopping Run user-specific NixOS activation...1228machine # [ 34.164292] systemd[527]: Starting Run user-specific NixOS activation...1229machine # [ 34.198494] systemd[527]: Finished Run user-specific NixOS activation.1230machine # [ 34.202938] systemd[1]: Stopped target Reactivate sysinit units.1231machine # [ 34.205862] systemd[1]: Stopping Reactivate sysinit units...1232machine # [ 34.206801] systemd[1]: Reached target Reactivate sysinit units.1233machine # [ 34.214102] systemd[1]: Starting test.service...1234machine # [ 34.219439] systemd[1]: Reached target Remote File Systems.1235machine # [ 34.228379] systemd[1]: Starting linger-users.service...1236machine # [ 34.233873] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1237machine # [ 34.235372] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1238machine # [ 34.249810] systemd[1]: Reached target Local File Systems.1239machine # [ 34.250785] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1240machine # [ 34.262053] systemd[1]: Starting Create SUID/SGID Wrappers...1241machine # [ 34.263093] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1242machine # [ 34.271484] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671243machine # [ 34.281045] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1244machine # [ 34.282845] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1245machine # [ 34.295909] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1246machine # [ 34.300963] systemd[1]: Finished test.service.1247machine # [ 34.330502] systemd[1]: linger-users.service: Deactivated successfully.1248machine # [ 34.334617] systemd[1]: Finished linger-users.service.1249machine # [ 34.543410] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1250machine # [ 34.546582] systemd[1]: Finished Create SUID/SGID Wrappers.1251machine # [ 34.810741] nixos[1836]: finished switching to system configuration /nix/store/ijl55ziz03scd38hmlj5rhw0mnk7rbax-nixos-system-machine-test1252machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 2.10 seconds)1253machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&11254machine # [ 35.135916] nixos[1978]: switching to system configuration /nix/store/haj41h0p4x0qrkkaycgivzipfxs0a5m0-nixos-system-machine-test1255machine # [ 35.138639] systemd[1]: Stopped target Local File Systems.1256machine # [ 35.141137] systemd[1]: Stopped target Remote File Systems.1257machine # [ 35.445407] systemd[1]: Reload requested from client PID 1978 ('.switch-to-conf') (unit backdoor.service)...1258machine # [ 35.447407] systemd[1]: Reloading...1259machine # [ 35.827538] systemd[1]: Reloading finished in 378 ms.1260machine # [ 35.922175] systemd[527]: Reexecution requested from client PID 2048 ('switch-to-confi')...1261machine # [ 35.926427] systemd[527]: Reexecuting.1262machine # [ 35.979827] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1263machine # [ 36.097499] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1264machine # [ 36.104286] systemd[527]: Reload requested from client PID 2048 ('switch-to-confi')...1265machine # [ 36.106764] systemd[527]: Reloading...1266machine # [ 36.220420] systemd[527]: Reloading finished in 112 ms.1267machine # [ 36.236212] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1268machine # [ 36.248086] systemd[527]: Stopped Run user-specific NixOS activation.1269machine # [ 36.249109] systemd[527]: Stopping Run user-specific NixOS activation...1270machine # [ 36.251932] systemd[527]: Starting Run user-specific NixOS activation...1271machine # [ 36.286572] systemd[527]: Finished Run user-specific NixOS activation.1272machine # [ 36.290707] systemd[1]: Stopped target Reactivate sysinit units.1273machine # [ 36.292881] systemd[1]: Stopping Reactivate sysinit units...1274machine # [ 36.293757] systemd[1]: Reached target Reactivate sysinit units.1275machine # [ 36.296447] systemd[1]: test.service: Deactivated successfully.1276machine # [ 36.297355] systemd[1]: Stopped test.service.1277machine # [ 36.297997] systemd[1]: Stopping test.service...1278machine # [ 36.301083] systemd[1]: Starting test.service...1279machine # [ 36.325757] systemd[1]: Finished test.service.1280machine # [ 36.332440] systemd[1]: Reached target Remote File Systems.1281machine # [ 36.337017] systemd[1]: Starting linger-users.service...1282machine # [ 36.344858] systemd[1]: Reached target Local File Systems.1283machine # [ 36.345752] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1284machine # [ 36.356237] systemd[1]: Starting Create SUID/SGID Wrappers...1285machine # [ 36.357200] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1286machine # [ 36.358432] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671287machine # [ 36.373513] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1288machine # [ 36.375255] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1289machine # [ 36.383743] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1290machine # [ 36.390051] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1291machine # [ 36.391443] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1292machine # [ 36.426286] systemd[1]: linger-users.service: Deactivated successfully.1293machine # [ 36.429321] systemd[1]: Finished linger-users.service.1294machine # [ 36.568602] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1295machine # [ 36.571949] systemd[1]: Finished Create SUID/SGID Wrappers.1296machine # [ 36.828796] nixos[1978]: finished switching to system configuration /nix/store/haj41h0p4x0qrkkaycgivzipfxs0a5m0-nixos-system-machine-test1297machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.01 seconds)1298machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&11299machine # [ 37.123103] nixos[2121]: switching to system configuration /nix/store/lam8hlwxccngczn1rn2n5jyg9h7jmszr-nixos-system-machine-test1300machine # [ 37.125757] systemd[1]: Stopped target Remote File Systems.1301machine # [ 37.128266] systemd[1]: Stopped target Local File Systems.1302machine # [ 37.423712] systemd[1]: Reload requested from client PID 2121 ('.switch-to-conf') (unit backdoor.service)...1303machine # [ 37.426009] systemd[1]: Reloading...1304machine # [ 37.763770] systemd[1]: Reloading finished in 335 ms.1305machine # [ 37.861311] systemd[527]: Reexecution requested from client PID 2190 ('switch-to-confi')...1306machine # [ 37.865900] systemd[527]: Reexecuting.1307machine # [ 37.915383] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1308machine # [ 38.029964] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1309machine # [ 38.036674] systemd[527]: Reload requested from client PID 2190 ('switch-to-confi')...1310machine # [ 38.040120] systemd[527]: Reloading...1311machine # [ 38.190837] systemd[527]: Reloading finished in 151 ms.1312machine # [ 38.216597] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1313machine # [ 38.229973] systemd[527]: Stopped Run user-specific NixOS activation.1314machine # [ 38.233019] systemd[527]: Stopping Run user-specific NixOS activation...1315machine # [ 38.235217] systemd[527]: Starting Run user-specific NixOS activation...1316machine # [ 38.270232] systemd[527]: Finished Run user-specific NixOS activation.1317machine # [ 38.274420] systemd[1]: Stopped target Reactivate sysinit units.1318machine # [ 38.279020] systemd[1]: Stopping Reactivate sysinit units...1319machine # [ 38.279950] systemd[1]: Reached target Reactivate sysinit units.1320machine # [ 38.282113] systemd[1]: Reloading test.service...1321machine # [ 38.310626] systemd[1]: Reloaded test.service.1322machine # [ 38.316510] systemd[1]: Reached target Local File Systems.1323machine # [ 38.322485] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1324machine # [ 38.326490] systemd[1]: Starting Create SUID/SGID Wrappers...1325machine # [ 38.327473] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1326machine # [ 38.336582] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671327machine # [ 38.338899] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1328machine # [ 38.347610] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1329machine # [ 38.349137] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1330machine # [ 38.350348] systemd[1]: Reached target Remote File Systems.1331machine # [ 38.351177] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1332machine # [ 38.353042] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1333machine # [ 38.524163] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1334machine # [ 38.528851] systemd[1]: Finished Create SUID/SGID Wrappers.1335machine # [ 38.530927] systemd[1]: Starting linger-users.service...1336machine # [ 38.574438] systemd[1]: linger-users.service: Deactivated successfully.1337machine # [ 38.577268] systemd[1]: Finished linger-users.service.1338machine # [ 38.835786] nixos[2121]: finished switching to system configuration /nix/store/lam8hlwxccngczn1rn2n5jyg9h7jmszr-nixos-system-machine-test1339machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 2.01 seconds)1340machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&11341machine # [ 39.148534] nixos[2264]: switching to system configuration /nix/store/5v7sf5lcjls65m8azcd473j1vn2igdnx-nixos-system-machine-test1342machine # [ 39.151611] systemd[1]: Stopped target Local File Systems.1343machine # [ 39.153861] systemd[1]: Stopped target Remote File Systems.1344machine # [ 39.450102] systemd[1]: Reload requested from client PID 2264 ('.switch-to-conf') (unit backdoor.service)...1345machine # [ 39.452147] systemd[1]: Reloading...1346machine # [ 39.800776] systemd[1]: Reloading finished in 347 ms.1347machine # [ 39.897004] systemd[527]: Reexecution requested from client PID 2333 ('switch-to-confi')...1348machine # [ 39.900639] systemd[527]: Reexecuting.1349machine # [ 39.951382] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1350machine # [ 40.082986] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1351machine # [ 40.090786] systemd[527]: Reload requested from client PID 2333 ('switch-to-confi')...1352machine # [ 40.094151] systemd[527]: Reloading...1353machine # [ 40.205498] systemd[527]: Reloading finished in 112 ms.1354machine # [ 40.220320] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1355machine # [ 40.234758] systemd[527]: Stopped Run user-specific NixOS activation.1356machine # [ 40.239062] systemd[527]: Stopping Run user-specific NixOS activation...1357machine # [ 40.242851] systemd[527]: Starting Run user-specific NixOS activation...1358machine # [ 40.278065] systemd[527]: Finished Run user-specific NixOS activation.1359machine # [ 40.284872] systemd[1]: Stopped target Reactivate sysinit units.1360machine # [ 40.285944] systemd[1]: Stopping Reactivate sysinit units...1361machine # [ 40.286802] systemd[1]: Reached target Reactivate sysinit units.1362machine # [ 40.293584] systemd[1]: Reached target Local File Systems.1363machine # [ 40.296698] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1364machine # [ 40.301678] systemd[1]: Starting Create SUID/SGID Wrappers...1365machine # [ 40.302706] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1366machine # [ 40.303986] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671367machine # [ 40.313366] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1368machine # [ 40.315108] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1369machine # [ 40.323206] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1370machine # [ 40.324669] systemd[1]: Reached target Remote File Systems.1371machine # [ 40.325509] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1372machine # [ 40.326891] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1373machine # [ 40.505133] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1374machine # [ 40.508382] systemd[1]: Finished Create SUID/SGID Wrappers.1375machine # [ 40.513002] systemd[1]: Starting linger-users.service...1376machine # [ 40.555890] systemd[1]: linger-users.service: Deactivated successfully.1377machine # [ 40.559099] systemd[1]: Finished linger-users.service.1378machine # [ 40.819476] nixos[2264]: finished switching to system configuration /nix/store/5v7sf5lcjls65m8azcd473j1vn2igdnx-nixos-system-machine-test1379machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.98 seconds)1380machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&11381machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.35 seconds)1382machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/bin/switch-to-configuration test 2>&11383machine # [ 41.400566] nixos[2414]: switching to system configuration /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test1384machine # [ 41.403586] systemd[1]: test.service: Deactivated successfully.1385machine # [ 41.407874] systemd[1]: Stopped test.service.1386machine # [ 41.409445] systemd[1]: Stopped target Local File Systems.1387machine # [ 41.410288] systemd[1]: Stopped target Remote File Systems.1388machine # [ 41.755493] systemd[1]: Reload requested from client PID 2414 ('.switch-to-conf') (unit backdoor.service)...1389machine # [ 41.757672] systemd[1]: Reloading...1390machine # [ 42.089356] systemd[1]: Reloading finished in 330 ms.1391machine # [ 42.178504] systemd[527]: Reexecution requested from client PID 2484 ('switch-to-confi')...1392machine # [ 42.179923] systemd[527]: Reexecuting.1393machine # [ 42.231479] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1394machine # [ 42.353309] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1395machine # [ 42.359787] systemd[527]: Reload requested from client PID 2484 ('switch-to-confi')...1396machine # [ 42.362319] systemd[527]: Reloading...1397machine # [ 42.476381] systemd[527]: Reloading finished in 113 ms.1398machine # [ 42.492188] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1399machine # [ 42.501556] systemd[527]: Stopped Run user-specific NixOS activation.1400machine # [ 42.504042] systemd[527]: Stopping Run user-specific NixOS activation...1401machine # [ 42.506208] systemd[527]: Starting Run user-specific NixOS activation...1402machine # [ 42.558611] systemd[527]: Finished Run user-specific NixOS activation.1403machine # [ 42.566536] systemd[1]: Stopped target Reactivate sysinit units.1404machine # [ 42.572422] systemd[1]: Stopping Reactivate sysinit units...1405machine # [ 42.573877] systemd[1]: Reached target Reactivate sysinit units.1406machine # [ 42.575320] systemd[1]: Reached target Remote File Systems.1407machine # [ 42.583713] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1408machine # [ 42.585324] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1409machine # [ 42.587678] systemd[1]: Starting linger-users.service...1410machine # [ 42.602382] systemd[1]: Reached target Local File Systems.1411machine # [ 42.603362] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1412machine # [ 42.614223] systemd[1]: Starting Create SUID/SGID Wrappers...1413machine # [ 42.615162] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1414machine # [ 42.618177] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671415machine # [ 42.620595] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1416machine # [ 42.622169] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1417machine # [ 42.623443] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1418machine # [ 42.681707] systemd[1]: linger-users.service: Deactivated successfully.1419machine # [ 42.687436] systemd[1]: Finished linger-users.service.1420machine # [ 42.839483] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1421machine # [ 42.841890] systemd[1]: Finished Create SUID/SGID Wrappers.1422machine # [ 43.101429] nixos[2414]: finished switching to system configuration /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test1423machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.94 seconds)1424machine: must succeed: /nix/store/g4gwwljhlwpqwl3xv48qmcbz5dm6j6r0-separate-activation-script/bin/switch-to-configuration test 2>&11425machine # [ 43.389033] nixos[2555]: switching to system configuration /nix/store/n1dzxqbxl28xyfvyr2wv6b6ryn584vpb-nixos-system-machine-test1426machine # [ 43.391636] systemd[1]: Stopped target Local File Systems.1427machine # [ 43.394090] systemd[1]: Stopped target Remote File Systems.1428machine # [ 43.689727] systemd[1]: Reload requested from client PID 2555 ('.switch-to-conf') (unit backdoor.service)...1429machine # [ 43.691637] systemd[1]: Reloading...1430machine # [ 44.018157] systemd[1]: Reloading finished in 324 ms.1431machine # [ 44.111931] systemd[527]: Stopped Run user-specific NixOS activation.1432machine # [ 44.115370] systemd[527]: Reexecution requested from client PID 2624 ('switch-to-confi')...1433machine # [ 44.117891] systemd[527]: Reexecuting.1434machine # [ 44.176295] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1435machine # [ 44.297932] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1436machine # [ 44.304880] systemd[527]: Reload requested from client PID 2624 ('switch-to-confi')...1437machine # [ 44.306270] systemd[527]: Reloading...1438machine # [ 44.418612] systemd[527]: Reloading finished in 110 ms.1439machine # [ 44.440239] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1440machine # [ 44.457029] systemd[1]: Stopped target Reactivate sysinit units.1441machine # [ 44.458136] systemd[1]: Stopping Reactivate sysinit units...1442machine # [ 44.461857] systemd[1]: Reached target Reactivate sysinit units.1443machine # [ 44.462871] systemd[1]: Reached target Remote File Systems.1444machine # [ 44.465660] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1445machine # [ 44.470396] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1446machine # [ 44.471846] systemd[1]: Reached target Local File Systems.1447machine # [ 44.480185] systemd[1]: Starting linger-users.service...1448machine # [ 44.495833] systemd[1]: Starting test.service...1449machine # [ 44.497695] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1450machine # [ 44.508158] systemd[1]: Starting Create SUID/SGID Wrappers...1451machine # [ 44.509230] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1452machine # [ 44.510558] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671453machine # [ 44.522334] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1454machine # [ 44.531479] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1455machine # [ 44.543159] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1456machine # [ 44.564218] systemd[1]: Finished test.service.1457machine # [ 44.591651] systemd[1]: linger-users.service: Deactivated successfully.1458machine # [ 44.596275] systemd[1]: Finished linger-users.service.1459machine # [ 44.733135] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1460machine # [ 44.736531] systemd[1]: Finished Create SUID/SGID Wrappers.1461machine # [ 44.995387] nixos[2555]: finished switching to system configuration /nix/store/n1dzxqbxl28xyfvyr2wv6b6ryn584vpb-nixos-system-machine-test1462machine: (finished: must succeed: /nix/store/g4gwwljhlwpqwl3xv48qmcbz5dm6j6r0-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.89 seconds)1463machine: must succeed: ! test -e /run/current-system/activate1464machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.03 seconds)1465machine: must succeed: ! test -e /run/current-system/dry-activate1466machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.03 seconds)1467machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration1468machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.02 seconds)1469machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&11470machine # [ 45.340823] nixos[2704]: switching to system configuration /nix/store/dkb1kddvdw0slkgawicdri6yyjbclmr2-nixos-system-machine-test1471machine # [ 45.343800] systemd[1]: test.service: Deactivated successfully.1472machine # [ 45.346037] systemd[1]: Stopped test.service.1473machine # [ 45.346705] systemd[1]: Stopped target Local File Systems.1474machine # [ 45.347921] systemd[1]: Stopped target Remote File Systems.1475machine # [ 45.637704] systemd[1]: Reload requested from client PID 2704 ('.switch-to-conf') (unit backdoor.service)...1476machine # [ 45.639645] systemd[1]: Reloading...1477machine # [ 45.975165] systemd[1]: Reloading finished in 333 ms.1478machine # [ 46.061167] systemd[527]: Reexecution requested from client PID 2773 ('switch-to-confi')...1479machine # [ 46.065486] systemd[527]: Reexecuting.1480machine # [ 46.119671] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1481machine # [ 46.244831] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1482machine # [ 46.252129] systemd[527]: Reload requested from client PID 2773 ('switch-to-confi')...1483machine # [ 46.253494] systemd[527]: Reloading...1484machine # [ 46.374955] systemd[527]: Reloading finished in 119 ms.1485machine # [ 46.392172] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1486machine # [ 46.404285] systemd[527]: Starting Run user-specific NixOS activation...1487machine # [ 46.440892] systemd[527]: Finished Run user-specific NixOS activation.1488machine # [ 46.444508] systemd[527]: Stopped Run user-specific NixOS activation.1489machine # [ 46.446876] systemd[527]: Stopping Run user-specific NixOS activation...1490machine # [ 46.448781] systemd[527]: Starting Run user-specific NixOS activation...1491machine # [ 46.456534] systemd[1]: Stopped target Reactivate sysinit units.1492machine # [ 46.457475] systemd[1]: Stopping Reactivate sysinit units...1493machine # [ 46.458258] systemd[1]: Reached target Reactivate sysinit units.1494machine # [ 46.474119] systemd[1]: Started test.service.1495machine # [ 46.480326] systemd[1]: Reached target Remote File Systems.1496machine # [ 46.486606] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1497machine # [ 46.493235] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1498machine # [ 46.494678] systemd[1]: Reached target Local File Systems.1499machine # [ 46.499779] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1500machine # [ 46.505803] systemd[1]: Starting Create SUID/SGID Wrappers...1501machine # [ 46.506682] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1502machine # [ 46.524425] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671503machine # [ 46.527145] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1504machine # [ 46.542700] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1505machine # [ 46.547029] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1506machine # [ 46.551842] systemd[527]: Finished Run user-specific NixOS activation.1507machine # [ 46.561828] systemd[1]: test.service: Deactivated successfully.1508machine # [ 46.749950] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1509machine # [ 46.752209] systemd[1]: Finished Create SUID/SGID Wrappers.1510machine # [ 46.758012] systemd[1]: Starting linger-users.service...1511machine # [ 46.802960] systemd[1]: linger-users.service: Deactivated successfully.1512machine # [ 46.806039] systemd[1]: Finished linger-users.service.1513machine # [ 47.062648] nixos[2704]: finished switching to system configuration /nix/store/dkb1kddvdw0slkgawicdri6yyjbclmr2-nixos-system-machine-test1514machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.98 seconds)1515machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&11516machine # [ 47.347711] nixos[2849]: switching to system configuration /nix/store/3bl21xac2l7wxzfs06p2f9rvj0qd6y7w-nixos-system-machine-test1517machine # [ 47.350524] systemd[1]: Stopped target Remote File Systems.1518machine # [ 47.352769] systemd[1]: Stopped target Local File Systems.1519machine # [ 47.636668] systemd[1]: Reload requested from client PID 2849 ('.switch-to-conf') (unit backdoor.service)...1520machine # [ 47.638608] systemd[1]: Reloading...1521machine # [ 48.045892] systemd[1]: Reloading finished in 404 ms.1522machine # [ 48.136091] systemd[527]: Reexecution requested from client PID 2918 ('switch-to-confi')...1523machine # [ 48.141217] systemd[527]: Reexecuting.1524machine # [ 48.187326] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1525machine # [ 48.301263] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1526machine # [ 48.308130] systemd[527]: Reload requested from client PID 2918 ('switch-to-confi')...1527machine # [ 48.310640] systemd[527]: Reloading...1528machine # [ 48.422445] systemd[527]: Reloading finished in 110 ms.1529machine # [ 48.440176] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1530machine # [ 48.450176] systemd[527]: Stopped Run user-specific NixOS activation.1531machine # [ 48.452796] systemd[527]: Stopping Run user-specific NixOS activation...1532machine # [ 48.454961] systemd[527]: Starting Run user-specific NixOS activation...1533machine # [ 48.489950] systemd[527]: Finished Run user-specific NixOS activation.1534machine # [ 48.494158] systemd[1]: Stopped target Reactivate sysinit units.1535machine # [ 48.496355] systemd[1]: Stopping Reactivate sysinit units...1536machine # [ 48.497196] systemd[1]: Reached target Reactivate sysinit units.1537machine # [ 48.499421] systemd[1]: Reached target Local File Systems.1538machine # [ 48.504003] systemd[1]: Reached target Remote File Systems.1539machine # [ 48.507109] systemd[1]: Starting escaped\x2ddash.service...1540machine # [ 48.511198] systemd[1]: Starting linger-users.service...1541machine # [ 48.523255] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1542machine # [ 48.533865] systemd[1]: Starting Create SUID/SGID Wrappers...1543machine # [ 48.534765] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1544machine # [ 48.548587] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671545machine # [ 48.550936] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1546machine # [ 48.564126] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1547machine # [ 48.565493] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1548machine # [ 48.566751] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1549machine # [ 48.579021] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1550machine # [ 48.583601] systemd[1]: Finished escaped\x2ddash.service.1551machine # [ 48.614135] systemd[1]: linger-users.service: Deactivated successfully.1552machine # [ 48.618375] systemd[1]: Finished linger-users.service.1553machine # [ 48.755163] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1554machine # [ 48.758426] systemd[1]: Finished Create SUID/SGID Wrappers.1555machine # [ 49.016620] nixos[2849]: finished switching to system configuration /nix/store/3bl21xac2l7wxzfs06p2f9rvj0qd6y7w-nixos-system-machine-test1556machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 1.95 seconds)1557machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&11558machine # [ 49.309611] nixos[2991]: switching to system configuration /nix/store/l343976di0mbky3iy3ab6c5lq8g7ljli-nixos-system-machine-test1559machine # [ 49.312083] systemd[1]: Stopped target Remote File Systems.1560machine # [ 49.315560] systemd[1]: Stopped target Local File Systems.1561machine # [ 49.316884] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1562machine # [ 49.317819] systemd[1]: Stopped escaped\x2ddash.service.1563machine # [ 49.592778] systemd[1]: Reload requested from client PID 2991 ('.switch-to-conf') (unit backdoor.service)...1564machine # [ 49.594620] systemd[1]: Reloading...1565machine # [ 49.920299] systemd[1]: Reloading finished in 324 ms.1566machine # [ 50.003960] systemd[527]: Reexecution requested from client PID 3059 ('switch-to-confi')...1567machine # [ 50.008562] systemd[527]: Reexecuting.1568machine # [ 50.067763] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1569machine # [ 50.184810] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1570machine # [ 50.191357] systemd[527]: Reload requested from client PID 3059 ('switch-to-confi')...1571machine # [ 50.194635] systemd[527]: Reloading...1572machine # [ 50.301639] systemd[527]: Reloading finished in 108 ms.1573machine # [ 50.320187] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1574machine # [ 50.329628] systemd[527]: Stopped Run user-specific NixOS activation.1575machine # [ 50.331991] systemd[527]: Stopping Run user-specific NixOS activation...1576machine # [ 50.334159] systemd[527]: Starting Run user-specific NixOS activation...1577machine # [ 50.364772] systemd[527]: Finished Run user-specific NixOS activation.1578machine # [ 50.368814] systemd[1]: Stopped target Reactivate sysinit units.1579machine # [ 50.370742] systemd[1]: Stopping Reactivate sysinit units...1580machine # [ 50.371623] systemd[1]: Reached target Reactivate sysinit units.1581machine # [ 50.376962] systemd[1]: Reached target Local File Systems.1582machine # [ 50.377762] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1583machine # [ 50.381078] systemd[1]: Starting Create SUID/SGID Wrappers...1584machine # [ 50.381927] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1585machine # [ 50.383142] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671586machine # [ 50.400402] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1587machine # [ 50.402024] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1588machine # [ 50.403258] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1589machine # [ 50.404614] systemd[1]: Reached target Remote File Systems.1590machine # [ 50.405376] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1591machine # [ 50.406589] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1592machine # [ 50.560416] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1593machine # [ 50.563217] systemd[1]: Finished Create SUID/SGID Wrappers.1594machine # [ 50.568296] systemd[1]: Starting escaped\x2ddash.service...1595machine # [ 50.572450] systemd[1]: Starting linger-users.service...1596machine # [ 50.611456] systemd[1]: Finished escaped\x2ddash.service.1597machine # [ 50.629711] systemd[1]: linger-users.service: Deactivated successfully.1598machine # [ 50.632331] systemd[1]: Finished linger-users.service.1599machine # [ 50.890651] nixos[2991]: finished switching to system configuration /nix/store/l343976di0mbky3iy3ab6c5lq8g7ljli-nixos-system-machine-test1600machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 1.88 seconds)1601machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&11602machine # [ 51.219741] nixos[3133]: switching to system configuration /nix/store/21l0j63qdkzv26jr7j9d1n24x1g3xk4s-nixos-system-machine-test1603machine # [ 51.222711] systemd[1]: Stopped target Remote File Systems.1604machine # [ 51.226570] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1605machine # [ 51.228316] systemd[1]: Stopped escaped\x2ddash.service.1606machine # [ 51.229189] systemd[1]: Stopped target Local File Systems.1607machine # [ 51.517006] systemd[1]: Reload requested from client PID 3133 ('.switch-to-conf') (unit backdoor.service)...1608machine # [ 51.519090] systemd[1]: Reloading...1609machine # [ 51.849593] systemd[1]: Reloading finished in 327 ms.1610machine # [ 51.934821] systemd[527]: Reexecution requested from client PID 3202 ('switch-to-confi')...1611machine # [ 51.938786] systemd[527]: Reexecuting.1612machine # [ 51.999399] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1613machine # [ 52.115280] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1614machine # [ 52.122186] systemd[527]: Reload requested from client PID 3202 ('switch-to-confi')...1615machine # [ 52.125651] systemd[527]: Reloading...1616machine # [ 52.232504] systemd[527]: Reloading finished in 107 ms.1617machine # [ 52.249602] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1618machine # [ 52.258498] systemd[527]: Stopped Run user-specific NixOS activation.1619machine # [ 52.260870] systemd[527]: Stopping Run user-specific NixOS activation...1620machine # [ 52.262995] systemd[527]: Starting Run user-specific NixOS activation...1621machine # [ 52.295581] systemd[527]: Finished Run user-specific NixOS activation.1622machine # [ 52.299370] systemd[1]: Stopped target Reactivate sysinit units.1623machine # [ 52.301054] systemd[1]: Stopping Reactivate sysinit units...1624machine # [ 52.301898] systemd[1]: Reached target Reactivate sysinit units.1625machine # [ 52.303993] systemd[1]: Reached target Remote File Systems.1626machine # [ 52.307297] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1627machine # [ 52.309299] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1628machine # [ 52.311272] systemd[1]: Reached target Local File Systems.1629machine # [ 52.315835] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1630machine # [ 52.319486] systemd[1]: Starting Create SUID/SGID Wrappers...1631machine # [ 52.323107] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1632machine # [ 52.328701] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671633machine # [ 52.330981] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1634machine # [ 52.337443] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1635machine # [ 52.338778] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1636machine # [ 52.497487] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1637machine # [ 52.499991] systemd[1]: Finished Create SUID/SGID Wrappers.1638machine # [ 52.504335] systemd[1]: Starting -.service...1639machine # [ 52.507845] systemd[1]: Starting linger-users.service...1640machine # [ 52.546483] systemd[1]: Finished -.service.1641machine # [ 52.564972] systemd[1]: linger-users.service: Deactivated successfully.1642machine # [ 52.567547] systemd[1]: Finished linger-users.service.1643machine # [ 52.827067] nixos[3133]: finished switching to system configuration /nix/store/21l0j63qdkzv26jr7j9d1n24x1g3xk4s-nixos-system-machine-test1644machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.93 seconds)1645machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&11646machine # [ 53.121680] nixos[3275]: switching to system configuration /nix/store/j5qjij09mwzmwdw59wz2hxik5bma4a3p-nixos-system-machine-test1647machine # [ 53.124463] systemd[1]: Stopped target Local File Systems.1648machine # [ 53.126769] systemd[1]: Stopped target Remote File Systems.1649machine # [ 53.408750] systemd[1]: Reload requested from client PID 3275 ('.switch-to-conf') (unit backdoor.service)...1650machine # [ 53.410609] systemd[1]: Reloading...1651machine # [ 53.737690] systemd[1]: Reloading finished in 325 ms.1652machine # [ 53.840199] systemd[527]: Reexecution requested from client PID 3344 ('switch-to-confi')...1653machine # [ 53.844670] systemd[527]: Reexecuting.1654machine # [ 53.887574] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1655machine # [ 54.001074] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1656machine # [ 54.007998] systemd[527]: Reload requested from client PID 3344 ('switch-to-confi')...1657machine # [ 54.009431] systemd[527]: Reloading...1658machine # [ 54.120441] systemd[527]: Reloading finished in 109 ms.1659machine # [ 54.140184] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1660machine # [ 54.151196] systemd[527]: Stopped Run user-specific NixOS activation.1661machine # [ 54.152294] systemd[527]: Stopping Run user-specific NixOS activation...1662machine # [ 54.154551] systemd[527]: Starting Run user-specific NixOS activation...1663machine # [ 54.188742] systemd[527]: Finished Run user-specific NixOS activation.1664machine # [ 54.193023] systemd[1]: Stopped target Reactivate sysinit units.1665machine # [ 54.197339] systemd[1]: Stopping Reactivate sysinit units...1666machine # [ 54.198277] systemd[1]: Reached target Reactivate sysinit units.1667machine # [ 54.200346] systemd[1]: Reloading -.service...1668machine # [ 54.225467] systemd[1]: Reloaded -.service.1669machine # [ 54.232842] systemd[1]: Reached target Local File Systems.1670machine # [ 54.236815] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1671machine # [ 54.244868] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1672machine # [ 54.246259] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1673machine # [ 54.247757] systemd[1]: Starting Create SUID/SGID Wrappers...1674machine # [ 54.256575] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1675machine # [ 54.257889] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671676machine # [ 54.260235] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1677machine # [ 54.261833] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1678machine # [ 54.263119] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1679machine # [ 54.264403] systemd[1]: Reached target Remote File Systems.1680machine # [ 54.424835] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1681machine # [ 54.429640] systemd[1]: Finished Create SUID/SGID Wrappers.1682machine # [ 54.431737] systemd[1]: Starting linger-users.service...1683machine # [ 54.473113] systemd[1]: linger-users.service: Deactivated successfully.1684machine # [ 54.475552] systemd[1]: Finished linger-users.service.1685machine # [ 54.735563] nixos[3275]: finished switching to system configuration /nix/store/j5qjij09mwzmwdw59wz2hxik5bma4a3p-nixos-system-machine-test1686machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.91 seconds)1687machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&11688machine # [ 55.017366] nixos[3417]: switching to system configuration /nix/store/ric6cl470b68bnxy2bg9qs952p2rlz8c-nixos-system-machine-test1689machine # [ 55.019885] systemd[1]: Stopped target Remote File Systems.1690machine # [ 55.023165] systemd[1]: Stopped target Local File Systems.1691machine # [ 55.024127] systemd[1]: -.service: Deactivated successfully.1692machine # [ 55.025184] systemd[1]: Stopped -.service.1693machine # [ 55.299993] systemd[1]: Reload requested from client PID 3417 ('.switch-to-conf') (unit backdoor.service)...1694machine # [ 55.302011] systemd[1]: Reloading...1695machine # [ 55.642140] systemd[1]: Reloading finished in 338 ms.1696machine # [ 55.731027] systemd[527]: Reexecution requested from client PID 3486 ('switch-to-confi')...1697machine # [ 55.735274] systemd[527]: Reexecuting.1698machine # [ 55.787620] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1699machine # [ 55.903645] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1700machine # [ 55.910356] systemd[527]: Reload requested from client PID 3486 ('switch-to-confi')...1701machine # [ 55.914037] systemd[527]: Reloading...1702machine # [ 56.023620] systemd[527]: Reloading finished in 110 ms.1703machine # [ 56.040172] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1704machine # [ 56.050321] systemd[527]: Stopped Run user-specific NixOS activation.1705machine # [ 56.051396] systemd[527]: Stopping Run user-specific NixOS activation...1706machine # [ 56.053795] systemd[527]: Starting Run user-specific NixOS activation...1707machine # [ 56.084364] systemd[527]: Finished Run user-specific NixOS activation.1708machine # [ 56.088582] systemd[1]: Stopped target Reactivate sysinit units.1709machine # [ 56.089558] systemd[1]: Stopping Reactivate sysinit units...1710machine # [ 56.090352] systemd[1]: Reached target Reactivate sysinit units.1711machine # [ 56.092521] systemd[1]: Reached target Local File Systems.1712machine # [ 56.095178] systemd[1]: Reached target Remote File Systems.1713machine # [ 56.104252] systemd[1]: Starting linger-users.service...1714machine # [ 56.108115] systemd[1]: Starting required-service.service...1715machine # [ 56.124952] systemd[1]: Starting test-service.service...1716machine # [ 56.125858] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1717machine # [ 56.127372] systemd[1]: Starting Create SUID/SGID Wrappers...1718machine # [ 56.143994] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1719machine # [ 56.145371] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671720machine # [ 56.147573] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1721machine # [ 56.164453] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1722machine # [ 56.165833] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1723machine # [ 56.181723] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1724machine # [ 56.191833] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1725machine # [ 56.201049] systemd[1]: Finished required-service.service.1726machine # [ 56.202086] systemd[1]: Finished test-service.service.1727machine # [ 56.233115] systemd[1]: linger-users.service: Deactivated successfully.1728machine # [ 56.236486] systemd[1]: Finished linger-users.service.1729machine # [ 56.369034] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1730machine # [ 56.371428] systemd[1]: Finished Create SUID/SGID Wrappers.1731machine # [ 56.631976] nixos[3417]: finished switching to system configuration /nix/store/ric6cl470b68bnxy2bg9qs952p2rlz8c-nixos-system-machine-test1732machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.90 seconds)1733machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&11734machine # [ 56.918531] nixos[3561]: switching to system configuration /nix/store/cv3mrzx5dxls140gn49gyz05fcxgdcbh-nixos-system-machine-test1735machine # [ 56.921149] systemd[1]: required-service.service: Deactivated successfully.1736machine # [ 56.924312] systemd[1]: Stopped required-service.service.1737machine # [ 56.925145] systemd[1]: test-service.service: Deactivated successfully.1738machine # [ 56.926033] systemd[1]: Stopped test-service.service.1739machine # [ 56.926749] systemd[1]: Stopped target Local File Systems.1740machine # [ 56.928114] systemd[1]: Stopped target Remote File Systems.1741machine # [ 57.209532] systemd[1]: Reload requested from client PID 3561 ('.switch-to-conf') (unit backdoor.service)...1742machine # [ 57.211410] systemd[1]: Reloading...1743machine # [ 57.533914] systemd[1]: Reloading finished in 320 ms.1744machine # [ 57.616406] systemd[527]: Reexecution requested from client PID 3630 ('switch-to-confi')...1745machine # [ 57.619929] systemd[527]: Reexecuting.1746machine # [ 57.679385] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1747machine # [ 57.794442] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1748machine # [ 57.800802] systemd[527]: Reload requested from client PID 3630 ('switch-to-confi')...1749machine # [ 57.804076] systemd[527]: Reloading...1750machine # [ 57.911247] systemd[527]: Reloading finished in 108 ms.1751machine # [ 57.932168] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1752machine # [ 57.941081] systemd[527]: Stopped Run user-specific NixOS activation.1753machine # [ 57.943357] systemd[527]: Stopping Run user-specific NixOS activation...1754machine # [ 57.945452] systemd[527]: Starting Run user-specific NixOS activation...1755machine # [ 57.975997] systemd[527]: Finished Run user-specific NixOS activation.1756machine # [ 57.979329] systemd[1]: Stopped target Reactivate sysinit units.1757machine # [ 57.980932] systemd[1]: Stopping Reactivate sysinit units...1758machine # [ 57.981724] systemd[1]: Reached target Reactivate sysinit units.1759machine # [ 57.984748] systemd[1]: Reached target Remote File Systems.1760machine # [ 57.992229] systemd[1]: Starting required-service.service...1761machine # [ 57.995186] systemd[1]: Starting test-service.service...1762machine # [ 58.005182] systemd[1]: Reached target Local File Systems.1763machine # [ 58.012312] systemd[1]: Starting linger-users.service...1764machine # [ 58.020349] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1765machine # [ 58.021646] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1766machine # [ 58.022902] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1767machine # [ 58.037445] systemd[1]: Starting Create SUID/SGID Wrappers...1768machine # [ 58.038324] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1769machine # [ 58.049247] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671770machine # [ 58.060677] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1771machine # [ 58.072454] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1772machine # [ 58.079582] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1773machine # [ 58.084502] systemd[1]: Finished required-service.service.1774machine # [ 58.085307] systemd[1]: Finished test-service.service.1775machine # [ 58.118524] systemd[1]: linger-users.service: Deactivated successfully.1776machine # [ 58.122419] systemd[1]: Finished linger-users.service.1777machine # [ 58.257380] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1778machine # [ 58.260446] systemd[1]: Finished Create SUID/SGID Wrappers.1779machine # [ 58.518644] nixos[3561]: finished switching to system configuration /nix/store/cv3mrzx5dxls140gn49gyz05fcxgdcbh-nixos-system-machine-test1780machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.89 seconds)1781machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&11782machine # [ 58.811419] nixos[3705]: switching to system configuration /nix/store/f085d2klz1cydafy975as9xmlz8kjaym-nixos-system-machine-test1783machine # [ 58.814327] systemd[1]: Stopped target Remote File Systems.1784machine # [ 58.818348] systemd[1]: required-service.service: Deactivated successfully.1785machine # [ 58.819423] systemd[1]: Stopped required-service.service.1786machine # [ 58.820867] systemd[1]: test-service.service: Deactivated successfully.1787machine # [ 58.821794] systemd[1]: Stopped test-service.service.1788machine # [ 58.822495] systemd[1]: Stopped target Local File Systems.1789machine # [ 59.147481] systemd[1]: Reload requested from client PID 3705 ('.switch-to-conf') (unit backdoor.service)...1790machine # [ 59.149809] systemd[1]: Reloading...1791machine # [ 59.483156] systemd[1]: Reloading finished in 332 ms.1792machine # [ 59.575275] systemd[527]: Reexecution requested from client PID 3774 ('switch-to-confi')...1793machine # [ 59.577857] systemd[527]: Reexecuting.1794machine # [ 59.640315] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1795machine # [ 59.758492] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1796machine # [ 59.765214] systemd[527]: Reload requested from client PID 3774 ('switch-to-confi')...1797machine # [ 59.767729] systemd[527]: Reloading...1798machine # [ 59.883168] systemd[527]: Reloading finished in 114 ms.1799machine # [ 59.900181] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1800machine # [ 59.909143] systemd[527]: Stopped Run user-specific NixOS activation.1801machine # [ 59.911635] systemd[527]: Stopping Run user-specific NixOS activation...1802machine # [ 59.913889] systemd[527]: Starting Run user-specific NixOS activation...1803machine # [ 59.949259] systemd[527]: Finished Run user-specific NixOS activation.1804machine # [ 59.953694] systemd[1]: Stopped target Reactivate sysinit units.1805machine # [ 59.957150] systemd[1]: Stopping Reactivate sysinit units...1806machine # [ 59.958078] systemd[1]: Reached target Reactivate sysinit units.1807machine # [ 59.959561] systemd[1]: Reached target Remote File Systems.1808machine # [ 59.964268] systemd[1]: Reached target Local File Systems.1809machine # [ 59.965164] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1810machine # [ 59.970057] systemd[1]: Starting Create SUID/SGID Wrappers...1811machine # [ 59.971005] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1812machine # [ 59.980626] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671813machine # [ 59.982863] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1814machine # [ 59.991432] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1815machine # [ 59.992877] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1816machine # [ 59.994079] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1817machine # [ 59.995373] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1818machine # [ 60.153826] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1819machine # [ 60.158460] systemd[1]: Finished Create SUID/SGID Wrappers.1820machine # [ 60.161821] systemd[1]: Starting linger-users.service...1821machine # [ 60.165997] systemd[1]: Starting required-service.service...1822machine # [ 60.173197] systemd[1]: Starting test-service.service...1823machine # [ 60.219880] systemd[1]: Finished required-service.service.1824machine # [ 60.223448] systemd[1]: Finished test-service.service.1825machine # [ 60.241100] systemd[1]: linger-users.service: Deactivated successfully.1826machine # [ 60.242958] systemd[1]: Finished linger-users.service.1827machine # [ 60.502087] nixos[3705]: finished switching to system configuration /nix/store/f085d2klz1cydafy975as9xmlz8kjaym-nixos-system-machine-test1828machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.98 seconds)1829machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&11830machine # [ 60.786856] nixos[3849]: switching to system configuration /nix/store/swlqqd0i4bb1iasknxfsbqlwgxxkjr9l-nixos-system-machine-test1831machine # [ 60.789382] systemd[1]: test-service.service: Deactivated successfully.1832machine # [ 60.792360] systemd[1]: Stopped test-service.service.1833machine # [ 60.793140] systemd[1]: required-service.service: Deactivated successfully.1834machine # [ 60.794055] systemd[1]: Stopped required-service.service.1835machine # [ 60.795392] systemd[1]: Stopped target Local File Systems.1836machine # [ 60.797434] systemd[1]: Stopped target Remote File Systems.1837machine # [ 61.071429] systemd[1]: Reload requested from client PID 3849 ('.switch-to-conf') (unit backdoor.service)...1838machine # [ 61.073502] systemd[1]: Reloading...1839machine # [ 61.409096] systemd[1]: Reloading finished in 334 ms.1840machine # [ 61.495183] systemd[527]: Reexecution requested from client PID 3918 ('switch-to-confi')...1841machine # [ 61.499464] systemd[527]: Reexecuting.1842machine # [ 61.564382] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1843machine # [ 61.690981] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1844machine # [ 61.698705] systemd[527]: Reload requested from client PID 3918 ('switch-to-confi')...1845machine # [ 61.702915] systemd[527]: Reloading...1846machine # [ 61.823553] systemd[527]: Reloading finished in 121 ms.1847machine # [ 61.841778] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1848machine # [ 61.849864] systemd[527]: Stopped Run user-specific NixOS activation.1849machine # [ 61.852173] systemd[527]: Stopping Run user-specific NixOS activation...1850machine # [ 61.854623] systemd[527]: Starting Run user-specific NixOS activation...1851machine # [ 61.888689] systemd[527]: Finished Run user-specific NixOS activation.1852machine # [ 61.892750] systemd[1]: Stopped target Reactivate sysinit units.1853machine # [ 61.895561] systemd[1]: Stopping Reactivate sysinit units...1854machine # [ 61.898080] systemd[1]: Reached target Reactivate sysinit units.1855machine # [ 61.905010] systemd[1]: Created slice Slice /system/instantiated.1856machine # [ 61.907960] systemd[1]: Reached target Remote File Systems.1857machine # [ 61.911643] systemd[1]: Starting instantiated@one.service...1858machine # [ 61.916644] systemd[1]: Starting instantiated@two.service...1859machine # [ 61.928269] systemd[1]: Starting linger-users.service...1860machine # [ 61.934441] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1861machine # [ 61.935811] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1862machine # [ 61.946819] systemd[1]: Reached target Local File Systems.1863machine # [ 61.947639] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1864machine # [ 61.955920] systemd[1]: Starting Create SUID/SGID Wrappers...1865machine # [ 61.960725] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1866machine # [ 61.970007] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671867machine # [ 61.981304] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1868machine # [ 61.983093] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1869machine # [ 62.000859] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1870machine # [ 62.005970] systemd[1]: Finished instantiated@one.service.1871machine # [ 62.006857] systemd[1]: Finished instantiated@two.service.1872machine # [ 62.037697] systemd[1]: linger-users.service: Deactivated successfully.1873machine # [ 62.041734] systemd[1]: Finished linger-users.service.1874machine # [ 62.172361] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1875machine # [ 62.175357] systemd[1]: Finished Create SUID/SGID Wrappers.1876machine # [ 62.433586] nixos[3849]: finished switching to system configuration /nix/store/swlqqd0i4bb1iasknxfsbqlwgxxkjr9l-nixos-system-machine-test1877machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.93 seconds)1878machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&11879machine # [ 62.732817] nixos[3993]: switching to system configuration /nix/store/753pi2abh34gzql03mfpk097icfp7xvn-nixos-system-machine-test1880machine # [ 62.735752] systemd[1]: instantiated@one.service: Deactivated successfully.1881machine # [ 62.738267] systemd[1]: Stopped instantiated@one.service.1882machine # [ 62.739090] systemd[1]: instantiated@two.service: Deactivated successfully.1883machine # [ 62.741766] systemd[1]: Stopped instantiated@two.service.1884machine # [ 62.743201] systemd[1]: Stopped target Local File Systems.1885machine # [ 62.743991] systemd[1]: Stopped target Remote File Systems.1886machine # [ 63.019743] systemd[1]: Reload requested from client PID 3993 ('.switch-to-conf') (unit backdoor.service)...1887machine # [ 63.021878] systemd[1]: Reloading...1888machine # [ 63.348910] systemd[1]: Reloading finished in 325 ms.1889machine # [ 63.438617] systemd[527]: Reexecution requested from client PID 4062 ('switch-to-confi')...1890machine # [ 63.441573] systemd[527]: Reexecuting.1891machine # [ 63.503464] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1892machine # [ 63.626135] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1893machine # [ 63.632640] systemd[527]: Reload requested from client PID 4062 ('switch-to-confi')...1894machine # [ 63.636163] systemd[527]: Reloading...1895machine # [ 63.746954] systemd[527]: Reloading finished in 111 ms.1896machine # [ 63.764184] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1897machine # [ 63.773705] systemd[527]: Stopped Run user-specific NixOS activation.1898machine # [ 63.775984] systemd[527]: Stopping Run user-specific NixOS activation...1899machine # [ 63.778123] systemd[527]: Starting Run user-specific NixOS activation...1900machine # [ 63.812009] systemd[527]: Finished Run user-specific NixOS activation.1901machine # [ 63.815475] systemd[1]: Stopped target Reactivate sysinit units.1902machine # [ 63.817521] systemd[1]: Stopping Reactivate sysinit units...1903machine # [ 63.818337] systemd[1]: Reached target Reactivate sysinit units.1904machine # [ 63.822320] systemd[1]: Reached target Local File Systems.1905machine # [ 63.823158] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1906machine # [ 63.832396] systemd[1]: Starting Create SUID/SGID Wrappers...1907machine # [ 63.833258] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1908machine # [ 63.834421] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671909machine # [ 63.846912] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1910machine # [ 63.849684] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1911machine # [ 63.850965] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1912machine # [ 63.852799] systemd[1]: Reached target Remote File Systems.1913machine # [ 63.853616] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1914machine # [ 63.855396] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1915machine # [ 64.011769] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1916machine # [ 64.016656] systemd[1]: Finished Create SUID/SGID Wrappers.1917machine # [ 64.019827] systemd[1]: Starting instantiated@one.service...1918machine # [ 64.023562] systemd[1]: Starting instantiated@two.service...1919machine # [ 64.028382] systemd[1]: Starting linger-users.service...1920machine # [ 64.076329] systemd[1]: Finished instantiated@one.service.1921machine # [ 64.077923] systemd[1]: Finished instantiated@two.service.1922machine # [ 64.099442] systemd[1]: linger-users.service: Deactivated successfully.1923machine # [ 64.102503] systemd[1]: Finished linger-users.service.1924machine # [ 64.359085] nixos[3993]: finished switching to system configuration /nix/store/753pi2abh34gzql03mfpk097icfp7xvn-nixos-system-machine-test1925machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.93 seconds)1926(finished: subtest: services, in 42.04 seconds)1927subtest: failing units1928machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11929machine # [ 64.628328] nixos[4137]: switching to system configuration /nix/store/ijl55ziz03scd38hmlj5rhw0mnk7rbax-nixos-system-machine-test1930machine # [ 64.631170] systemd[1]: Stopped target Local File Systems.1931machine # [ 64.635623] systemd[1]: instantiated@one.service: Deactivated successfully.1932machine # [ 64.637862] systemd[1]: Stopped instantiated@one.service.1933machine # [ 64.638674] systemd[1]: instantiated@two.service: Deactivated successfully.1934machine # [ 64.639593] systemd[1]: Stopped instantiated@two.service.1935machine # [ 64.640616] systemd[1]: Stopped target Remote File Systems.1936machine # [ 64.893722] systemd[1]: Reload requested from client PID 4137 ('.switch-to-conf') (unit backdoor.service)...1937machine # [ 64.895591] systemd[1]: Reloading...1938machine # [ 65.206560] systemd[1]: Reloading finished in 309 ms.1939machine # [ 65.295203] systemd[527]: Reexecution requested from client PID 4206 ('switch-to-confi')...1940machine # [ 65.297920] systemd[527]: Reexecuting.1941machine # [ 65.355415] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1942machine # [ 65.470676] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1943machine # [ 65.477047] systemd[527]: Reload requested from client PID 4206 ('switch-to-confi')...1944machine # [ 65.480795] systemd[527]: Reloading...1945machine # [ 65.589128] systemd[527]: Reloading finished in 109 ms.1946machine # [ 65.604178] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1947machine # [ 65.612695] systemd[527]: Stopped Run user-specific NixOS activation.1948machine # [ 65.614968] systemd[527]: Stopping Run user-specific NixOS activation...1949machine # [ 65.617014] systemd[527]: Starting Run user-specific NixOS activation...1950machine # [ 65.647377] systemd[527]: Finished Run user-specific NixOS activation.1951machine # [ 65.651619] systemd[1]: Stopped target Reactivate sysinit units.1952machine # [ 65.652949] systemd[1]: Stopping Reactivate sysinit units...1953machine # [ 65.653747] systemd[1]: Reached target Reactivate sysinit units.1954machine # [ 65.656634] systemd[1]: Reached target Local File Systems.1955machine # [ 65.659250] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1956machine # [ 65.668732] systemd[1]: Starting Create SUID/SGID Wrappers...1957machine # [ 65.669593] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1958machine # [ 65.670806] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671959machine # [ 65.683049] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1960machine # [ 65.684690] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1961machine # [ 65.685901] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1962machine # [ 65.687052] systemd[1]: Reached target Remote File Systems.1963machine # [ 65.687801] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1964machine # [ 65.689408] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1965machine # [ 65.843555] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1966machine # [ 65.848349] systemd[1]: Finished Create SUID/SGID Wrappers.1967machine # [ 65.851408] systemd[1]: Starting linger-users.service...1968machine # [ 65.853979] systemd[1]: Starting test.service...1969machine # [ 65.890190] systemd[1]: Finished test.service.1970machine # [ 65.907054] systemd[1]: linger-users.service: Deactivated successfully.1971machine # [ 65.909469] systemd[1]: Finished linger-users.service.1972machine # [ 66.169309] nixos[4137]: finished switching to system configuration /nix/store/ijl55ziz03scd38hmlj5rhw0mnk7rbax-nixos-system-machine-test1973machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.81 seconds)1974machine: must fail: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&11975machine # [ 66.455105] nixos[4279]: switching to system configuration /nix/store/m0s53gwrilyzcx14h11llnp4fnic6spb-nixos-system-machine-test1976machine # [ 66.457588] systemd[1]: test.service: Deactivated successfully.1977machine # [ 66.460936] systemd[1]: Stopped test.service.1978machine # [ 66.462129] systemd[1]: Stopped target Local File Systems.1979machine # [ 66.462918] systemd[1]: Stopped target Remote File Systems.1980machine # [ 66.733838] systemd[1]: Reload requested from client PID 4279 ('.switch-to-conf') (unit backdoor.service)...1981machine # [ 66.735343] systemd[1]: Reloading...1982machine # [ 67.057266] systemd[1]: Reloading finished in 319 ms.1983machine # [ 67.142170] systemd[527]: Reexecution requested from client PID 4348 ('switch-to-confi')...1984machine # [ 67.143528] systemd[527]: Reexecuting.1985machine # [ 67.203663] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1986machine # [ 67.319221] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1987machine # [ 67.325544] systemd[527]: Reload requested from client PID 4348 ('switch-to-confi')...1988machine # [ 67.327816] systemd[527]: Reloading...1989machine # [ 67.435837] systemd[527]: Reloading finished in 107 ms.1990machine # [ 67.452147] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1991machine # [ 67.461380] systemd[527]: Stopped Run user-specific NixOS activation.1992machine # [ 67.463651] systemd[527]: Stopping Run user-specific NixOS activation...1993machine # [ 67.465702] systemd[527]: Starting Run user-specific NixOS activation...1994machine # [ 67.495891] systemd[527]: Finished Run user-specific NixOS activation.1995machine # [ 67.499865] systemd[1]: Stopped target Reactivate sysinit units.1996machine # [ 67.502773] systemd[1]: Stopping Reactivate sysinit units...1997machine # [ 67.503623] systemd[1]: Reached target Reactivate sysinit units.1998machine # [ 67.508139] systemd[1]: Reached target Remote File Systems.1999machine # [ 67.511538] systemd[1]: Starting linger-users.service...2000machine # [ 67.514794] systemd[1]: Starting test.service...2001machine # [ 67.527320] systemd[1]: Reached target Local File Systems.2002machine # [ 67.530839] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2003machine # [ 67.536807] systemd[1]: Starting Create SUID/SGID Wrappers...2004machine # [ 67.537677] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2005machine # [ 67.538896] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672006machine # [ 67.555810] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2007machine # [ 67.563910] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2008machine # [ 67.571720] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2009machine # [ 67.577805] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2010machine # [ 67.579215] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2011machine # [ 67.590344] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE2012machine # [ 67.591697] systemd[1]: test.service: Failed with result 'exit-code'.2013machine # [ 67.596333] systemd[1]: Failed to start test.service.2014machine # [ 67.623031] systemd[1]: linger-users.service: Deactivated successfully.2015machine # [ 67.624692] systemd[1]: Finished linger-users.service.2016machine # [ 67.755375] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2017machine # [ 67.758237] systemd[1]: Finished Create SUID/SGID Wrappers.2018machine # [ 68.049682] nixos[4279]: switching to system configuration /nix/store/m0s53gwrilyzcx14h11llnp4fnic6spb-nixos-system-machine-test failed (status 4)2019machine: (finished: must fail: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.88 seconds)2020machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12021machine # [ 68.317345] nixos[4422]: switching to system configuration /nix/store/rpc128j2k0vykfwq1q19hbzhvi9467d0-nixos-system-machine-test2022machine # [ 68.319796] systemd[1]: Stopped target Remote File Systems.2023machine # [ 68.322592] systemd[1]: Stopped target Local File Systems.2024machine # [ 68.598643] systemd[1]: Reload requested from client PID 4422 ('.switch-to-conf') (unit backdoor.service)...2025machine # [ 68.600654] systemd[1]: Reloading...2026machine # [ 68.921745] systemd[1]: Reloading finished in 319 ms.2027machine # [ 69.005136] systemd[527]: Reexecution requested from client PID 4491 ('switch-to-confi')...2028machine # [ 69.008576] systemd[527]: Reexecuting.2029machine # [ 69.067354] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2030machine # [ 69.182917] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2031machine # [ 69.189535] systemd[527]: Reload requested from client PID 4491 ('switch-to-confi')...2032machine # [ 69.193222] systemd[527]: Reloading...2033machine # [ 69.299909] systemd[527]: Reloading finished in 107 ms.2034machine # [ 69.316158] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2035machine # [ 69.324779] systemd[527]: Stopped Run user-specific NixOS activation.2036machine # [ 69.327072] systemd[527]: Stopping Run user-specific NixOS activation...2037machine # [ 69.329159] systemd[527]: Starting Run user-specific NixOS activation...2038machine # [ 69.360488] systemd[527]: Finished Run user-specific NixOS activation.2039machine # [ 69.363862] systemd[1]: Stopped target Reactivate sysinit units.2040machine # [ 69.366777] systemd[1]: Stopping Reactivate sysinit units...2041machine # [ 69.367618] systemd[1]: Reached target Reactivate sysinit units.2042machine # [ 69.369377] systemd[1]: Reached target Remote File Systems.2043machine # [ 69.376216] systemd[1]: Started autorestart.service.2044machine # [ 69.380270] systemd[1]: Starting linger-users.service...2045machine # [ 69.394672] systemd[1]: Reached target Local File Systems.2046machine # [ 69.395565] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2047machine # [ 69.407257] systemd[1]: Starting Create SUID/SGID Wrappers...2048machine # [ 69.408244] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2049machine # [ 69.409477] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672050machine # [ 69.411657] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2051machine # [ 69.424744] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2052machine # [ 69.426075] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2053machine # [ 69.437148] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2054machine # [ 69.438680] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2055machine # [ 69.450574] systemd[1]: autorestart.service: Deactivated successfully.2056machine # [ 69.479983] systemd[1]: linger-users.service: Deactivated successfully.2057machine # [ 69.483630] systemd[1]: Finished linger-users.service.2058machine # [ 69.611688] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2059machine # [ 69.615345] systemd[1]: Finished Create SUID/SGID Wrappers.2060machine # [ 69.874024] nixos[4422]: finished switching to system configuration /nix/store/rpc128j2k0vykfwq1q19hbzhvi9467d0-nixos-system-machine-test2061machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.82 seconds)2062machine # [ 69.943917] systemd[1]: Stopped autorestart.service.2063machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12064machine # [ 70.170056] nixos[4569]: switching to system configuration /nix/store/rpc128j2k0vykfwq1q19hbzhvi9467d0-nixos-system-machine-test2065machine # [ 70.172440] systemd[1]: Stopped target Remote File Systems.2066machine # [ 70.174577] systemd[1]: Stopped target Local File Systems.2067machine # [ 70.426040] systemd[1]: Reload requested from client PID 4569 ('.switch-to-conf') (unit backdoor.service)...2068machine # [ 70.427980] systemd[1]: Reloading...2069machine # [ 70.734935] systemd[1]: Reloading finished in 305 ms.2070machine # [ 70.856637] systemd[527]: Reexecution requested from client PID 4638 ('switch-to-confi')...2071machine # [ 70.858880] systemd[527]: Reexecuting.2072machine # [ 70.919648] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2073machine # [ 71.039732] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2074machine # [ 71.046978] systemd[527]: Reload requested from client PID 4638 ('switch-to-confi')...2075machine # [ 71.050765] systemd[527]: Reloading...2076machine # [ 71.165471] systemd[527]: Reloading finished in 115 ms.2077machine # [ 71.180164] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2078machine # [ 71.191412] systemd[527]: Stopped Run user-specific NixOS activation.2079machine # [ 71.193699] systemd[527]: Stopping Run user-specific NixOS activation...2080machine # [ 71.195788] systemd[527]: Starting Run user-specific NixOS activation...2081machine # [ 71.227405] systemd[527]: Finished Run user-specific NixOS activation.2082machine # [ 71.231509] systemd[1]: Stopped target Reactivate sysinit units.2083machine # [ 71.233809] systemd[1]: Stopping Reactivate sysinit units...2084machine # [ 71.234684] systemd[1]: Reached target Reactivate sysinit units.2085machine # [ 71.238331] systemd[1]: Reached target Local File Systems.2086machine # [ 71.239201] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2087machine # [ 71.248294] systemd[1]: Starting Create SUID/SGID Wrappers...2088machine # [ 71.249172] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2089machine # [ 71.250383] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672090machine # [ 71.264224] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2091machine # [ 71.265899] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2092machine # [ 71.267613] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2093machine # [ 71.269744] systemd[1]: Reached target Remote File Systems.2094machine # [ 71.270998] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2095machine # [ 71.274925] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2096machine # [ 71.421690] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2097machine # [ 71.423970] systemd[1]: Finished Create SUID/SGID Wrappers.2098machine # [ 71.430047] systemd[1]: Started autorestart.service.2099machine # [ 71.432502] systemd[1]: Starting linger-users.service...2100machine # [ 71.469282] systemd[1]: autorestart.service: Deactivated successfully.2101machine # [ 71.486602] systemd[1]: linger-users.service: Deactivated successfully.2102machine # [ 71.489598] systemd[1]: Finished linger-users.service.2103machine # [ 71.748599] nixos[4569]: finished switching to system configuration /nix/store/rpc128j2k0vykfwq1q19hbzhvi9467d0-nixos-system-machine-test2104machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.80 seconds)2105machine # [ 71.818317] systemd[1]: Stopped autorestart.service.2106machine: must fail: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&12107machine # [ 72.063734] nixos[4716]: switching to system configuration /nix/store/x9jmr14h2lll0mab9xxpxwlhjsnzplrm-nixos-system-machine-test2108machine # [ 72.066277] systemd[1]: Stopped target Local File Systems.2109machine # [ 72.068624] systemd[1]: Stopped target Remote File Systems.2110machine # [ 72.338631] systemd[1]: Reload requested from client PID 4716 ('.switch-to-conf') (unit backdoor.service)...2111machine # [ 72.340631] systemd[1]: Reloading...2112machine # [ 72.662360] systemd[1]: Reloading finished in 320 ms.2113machine # [ 72.752526] systemd[527]: Reexecution requested from client PID 4785 ('switch-to-confi')...2114machine # [ 72.756103] systemd[527]: Reexecuting.2115machine # [ 72.815526] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2116machine # [ 72.935874] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2117machine # [ 72.942551] systemd[527]: Reload requested from client PID 4785 ('switch-to-confi')...2118machine # [ 72.946220] systemd[527]: Reloading...2119machine # [ 73.053628] systemd[527]: Reloading finished in 108 ms.2120machine # [ 73.068166] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2121machine # [ 73.078498] systemd[527]: Stopped Run user-specific NixOS activation.2122machine # [ 73.081027] systemd[527]: Stopping Run user-specific NixOS activation...2123machine # [ 73.083152] systemd[527]: Starting Run user-specific NixOS activation...2124machine # [ 73.115884] systemd[527]: Finished Run user-specific NixOS activation.2125machine # [ 73.119553] systemd[1]: Stopped target Reactivate sysinit units.2126machine # [ 73.122135] systemd[1]: Stopping Reactivate sysinit units...2127machine # [ 73.122986] systemd[1]: Reached target Reactivate sysinit units.2128machine # [ 73.125851] systemd[1]: Reached target Remote File Systems.2129machine # [ 73.130693] systemd[1]: Reached target Local File Systems.2130machine # [ 73.134367] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2131machine # [ 73.141099] systemd[1]: Starting Create SUID/SGID Wrappers...2132machine # [ 73.141986] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2133machine # [ 73.143178] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672134machine # [ 73.153211] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2135machine # [ 73.154858] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2136machine # [ 73.156220] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2137machine # [ 73.157372] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2138machine # [ 73.158598] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2139machine # [ 73.312129] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2140machine # [ 73.313846] systemd[1]: Finished Create SUID/SGID Wrappers.2141machine # [ 73.320152] systemd[1]: Started autorestart.service.2142machine # [ 73.323138] systemd[1]: Starting linger-users.service...2143machine # [ 73.360685] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE2144machine # [ 73.365314] systemd[1]: autorestart.service: Failed with result 'exit-code'.2145machine # [ 73.381830] systemd[1]: linger-users.service: Deactivated successfully.2146machine # [ 73.384156] systemd[1]: Finished linger-users.service.2147machine # [ 73.676304] nixos[4716]: switching to system configuration /nix/store/x9jmr14h2lll0mab9xxpxwlhjsnzplrm-nixos-system-machine-test failed (status 4)2148machine: (finished: must fail: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.86 seconds)2149(finished: subtest: failing units, in 9.32 seconds)2150subtest: unit file parser2151machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12152machine # [ 73.932103] nixos[4859]: switching to system configuration /nix/store/haj41h0p4x0qrkkaycgivzipfxs0a5m0-nixos-system-machine-test2153machine # [ 73.934675] systemd[1]: Stopped autorestart.service.2154machine # [ 73.938144] systemd[1]: Stopped target Local File Systems.2155machine # [ 73.939026] systemd[1]: Stopped target Remote File Systems.2156machine # [ 74.198343] systemd[1]: Reload requested from client PID 4859 ('.switch-to-conf') (unit backdoor.service)...2157machine # [ 74.200311] systemd[1]: Reloading...2158machine # [ 74.503429] systemd[1]: Reloading finished in 301 ms.2159machine # [ 74.589629] systemd[527]: Reexecution requested from client PID 4928 ('switch-to-confi')...2160machine # [ 74.591071] systemd[527]: Reexecuting.2161machine # [ 74.651269] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2162machine # [ 74.765534] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2163machine # [ 74.771653] systemd[527]: Reload requested from client PID 4928 ('switch-to-confi')...2164machine # [ 74.773980] systemd[527]: Reloading...2165machine # [ 74.880656] systemd[527]: Reloading finished in 105 ms.2166machine # [ 74.897543] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2167machine # [ 74.905506] systemd[527]: Stopped Run user-specific NixOS activation.2168machine # [ 74.907765] systemd[527]: Stopping Run user-specific NixOS activation...2169machine # [ 74.909783] systemd[527]: Starting Run user-specific NixOS activation...2170machine # [ 74.938752] systemd[527]: Finished Run user-specific NixOS activation.2171machine # [ 74.942089] systemd[1]: Stopped target Reactivate sysinit units.2172machine # [ 74.944459] systemd[1]: Stopping Reactivate sysinit units...2173machine # [ 74.945278] systemd[1]: Reached target Reactivate sysinit units.2174machine # [ 74.949904] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2175machine # [ 74.952733] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2176machine # [ 74.956241] systemd[1]: Reached target Remote File Systems.2177machine # [ 74.960084] systemd[1]: Starting linger-users.service...2178machine # [ 74.964396] systemd[1]: Starting test.service...2179machine # [ 74.976576] systemd[1]: Reached target Local File Systems.2180machine # [ 74.977420] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2181machine # [ 74.978835] systemd[1]: Starting Create SUID/SGID Wrappers...2182machine # [ 74.979616] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2183machine # [ 74.993347] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672184machine # [ 74.995540] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2185machine # [ 75.009950] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2186machine # [ 75.015930] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2187machine # [ 75.027814] systemd[1]: Finished test.service.2188machine # [ 75.054449] systemd[1]: linger-users.service: Deactivated successfully.2189machine # [ 75.058807] systemd[1]: Finished linger-users.service.2190machine # [ 75.189312] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2191machine # [ 75.192766] systemd[1]: Finished Create SUID/SGID Wrappers.2192machine # [ 75.451074] nixos[4859]: finished switching to system configuration /nix/store/haj41h0p4x0qrkkaycgivzipfxs0a5m0-nixos-system-machine-test2193machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.77 seconds)2194machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&12195machine # [ 75.737501] nixos[5001]: switching to system configuration /nix/store/k1m9sj9ashaxhi95zbk8y1q4wrv5dbyj-nixos-system-machine-test2196machine # [ 75.740313] systemd[1]: Stopped target Remote File Systems.2197machine # [ 75.742786] systemd[1]: Stopped target Local File Systems.2198machine # [ 76.014580] systemd[1]: Reload requested from client PID 5001 ('.switch-to-conf') (unit backdoor.service)...2199machine # [ 76.016571] systemd[1]: Reloading...2200machine # [ 76.336273] systemd[1]: Reloading finished in 318 ms.2201machine # [ 76.428158] systemd[527]: Reexecution requested from client PID 5070 ('switch-to-confi')...2202machine # [ 76.432201] systemd[527]: Reexecuting.2203machine # [ 76.487316] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2204machine # [ 76.606561] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2205machine # [ 76.612830] systemd[527]: Reload requested from client PID 5070 ('switch-to-confi')...2206machine # [ 76.616062] systemd[527]: Reloading...2207machine # [ 76.724451] systemd[527]: Reloading finished in 109 ms.2208machine # [ 76.740153] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2209machine # [ 76.749082] systemd[527]: Stopped Run user-specific NixOS activation.2210machine # [ 76.751355] systemd[527]: Stopping Run user-specific NixOS activation...2211machine # [ 76.753373] systemd[527]: Starting Run user-specific NixOS activation...2212machine # [ 76.782811] systemd[527]: Finished Run user-specific NixOS activation.2213machine # [ 76.786404] systemd[1]: Stopped target Reactivate sysinit units.2214machine # [ 76.790779] systemd[1]: Stopping Reactivate sysinit units...2215machine # [ 76.791635] systemd[1]: Reached target Reactivate sysinit units.2216machine # [ 76.792757] systemd[1]: test.service: Deactivated successfully.2217machine # [ 76.793571] systemd[1]: Stopped test.service.2218machine # [ 76.794184] systemd[1]: Stopping test.service...2219machine # [ 76.795758] systemd[1]: Starting test.service...2220machine # [ 76.819936] systemd[1]: Finished test.service.2221machine # [ 76.823536] systemd[1]: Reached target Local File Systems.2222machine # [ 76.825817] systemd[1]: Reached target Remote File Systems.2223machine # [ 76.831141] systemd[1]: Starting linger-users.service...2224machine # [ 76.838491] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2225machine # [ 76.849087] systemd[1]: Starting Create SUID/SGID Wrappers...2226machine # [ 76.850011] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2227machine # [ 76.851222] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672228machine # [ 76.857778] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2229machine # [ 76.859398] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2230machine # [ 76.866502] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2231machine # [ 76.867819] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2232machine # [ 76.876587] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2233machine # [ 76.909125] systemd[1]: linger-users.service: Deactivated successfully.2234machine # [ 76.912270] systemd[1]: Finished linger-users.service.2235machine # [ 77.042440] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2236machine # [ 77.045727] systemd[1]: Finished Create SUID/SGID Wrappers.2237machine # [ 77.302341] nixos[5001]: finished switching to system configuration /nix/store/k1m9sj9ashaxhi95zbk8y1q4wrv5dbyj-nixos-system-machine-test2238machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.85 seconds)2239machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&12240machine # [ 77.587492] nixos[5143]: switching to system configuration /nix/store/6idgs8a887n19n7nah2ymsf9dqj0swb8-nixos-system-machine-test2241machine # [ 77.589909] systemd[1]: Stopped target Local File Systems.2242machine # [ 77.592057] systemd[1]: Stopped target Remote File Systems.2243machine # [ 77.862483] systemd[1]: Reload requested from client PID 5143 ('.switch-to-conf') (unit backdoor.service)...2244machine # [ 77.864467] systemd[1]: Reloading...2245machine # [ 78.184994] systemd[1]: Reloading finished in 319 ms.2246machine # [ 78.273173] systemd[527]: Reexecution requested from client PID 5212 ('switch-to-confi')...2247machine # [ 78.277090] systemd[527]: Reexecuting.2248machine # [ 78.322867] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2249machine # [ 78.438861] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2250machine # [ 78.445328] systemd[527]: Reload requested from client PID 5212 ('switch-to-confi')...2251machine # [ 78.447615] systemd[527]: Reloading...2252machine # [ 78.555758] systemd[527]: Reloading finished in 107 ms.2253machine # [ 78.572174] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2254machine # [ 78.581928] systemd[527]: Stopped Run user-specific NixOS activation.2255machine # [ 78.584394] systemd[527]: Stopping Run user-specific NixOS activation...2256machine # [ 78.586640] systemd[527]: Starting Run user-specific NixOS activation...2257machine # [ 78.619405] systemd[527]: Finished Run user-specific NixOS activation.2258machine # [ 78.622769] systemd[1]: Stopped target Reactivate sysinit units.2259machine # [ 78.624651] systemd[1]: Stopping Reactivate sysinit units...2260machine # [ 78.625503] systemd[1]: Reached target Reactivate sysinit units.2261machine # [ 78.628518] systemd[1]: test.service: Deactivated successfully.2262machine # [ 78.629383] systemd[1]: Stopped test.service.2263machine # [ 78.630031] systemd[1]: Stopping test.service...2264machine # [ 78.632954] systemd[1]: Starting test.service...2265machine # [ 78.656449] systemd[1]: Finished test.service.2266machine # [ 78.659412] systemd[1]: Reached target Local File Systems.2267machine # [ 78.664540] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2268machine # [ 78.668691] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2269machine # [ 78.670018] systemd[1]: Reached target Remote File Systems.2270machine # [ 78.674359] systemd[1]: Starting linger-users.service...2271machine # [ 78.680122] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2272machine # [ 78.688314] systemd[1]: Starting Create SUID/SGID Wrappers...2273machine # [ 78.689216] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2274machine # [ 78.690424] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672275machine # [ 78.697666] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2276machine # [ 78.699298] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2277machine # [ 78.700597] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2278machine # [ 78.753214] systemd[1]: linger-users.service: Deactivated successfully.2279machine # [ 78.756682] systemd[1]: Finished linger-users.service.2280machine # [ 78.885210] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2281machine # [ 78.888634] systemd[1]: Finished Create SUID/SGID Wrappers.2282machine # [ 79.146388] nixos[5143]: finished switching to system configuration /nix/store/6idgs8a887n19n7nah2ymsf9dqj0swb8-nixos-system-machine-test2283machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.84 seconds)2284machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12285machine # [ 79.426659] nixos[5285]: switching to system configuration /nix/store/haj41h0p4x0qrkkaycgivzipfxs0a5m0-nixos-system-machine-test2286machine # [ 79.429084] systemd[1]: Stopped target Local File Systems.2287machine # [ 79.431608] systemd[1]: Stopped target Remote File Systems.2288machine # [ 79.679794] systemd[1]: Reload requested from client PID 5285 ('.switch-to-conf') (unit backdoor.service)...2289machine # [ 79.681838] systemd[1]: Reloading...2290machine # [ 79.990480] systemd[1]: Reloading finished in 306 ms.2291machine # [ 80.073515] systemd[527]: Reexecution requested from client PID 5353 ('switch-to-confi')...2292machine # [ 80.077558] systemd[527]: Reexecuting.2293machine # [ 80.135220] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2294machine # [ 80.249214] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2295machine # [ 80.255370] systemd[527]: Reload requested from client PID 5353 ('switch-to-confi')...2296machine # [ 80.258733] systemd[527]: Reloading...2297machine # [ 80.364880] systemd[527]: Reloading finished in 107 ms.2298machine # [ 80.380157] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2299machine # [ 80.390330] systemd[527]: Stopped Run user-specific NixOS activation.2300machine # [ 80.391395] systemd[527]: Stopping Run user-specific NixOS activation...2301machine # [ 80.393738] systemd[527]: Starting Run user-specific NixOS activation...2302machine # [ 80.423156] systemd[527]: Finished Run user-specific NixOS activation.2303machine # [ 80.426814] systemd[1]: Stopped target Reactivate sysinit units.2304machine # [ 80.431168] systemd[1]: Stopping Reactivate sysinit units...2305machine # [ 80.432331] systemd[1]: Reached target Reactivate sysinit units.2306machine # [ 80.433194] systemd[1]: test.service: Deactivated successfully.2307machine # [ 80.434008] systemd[1]: Stopped test.service.2308machine # [ 80.434644] systemd[1]: Stopping test.service...2309machine # [ 80.436365] systemd[1]: Starting test.service...2310machine # [ 80.460505] systemd[1]: Finished test.service.2311machine # [ 80.466221] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2312machine # [ 80.470179] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2313machine # [ 80.471493] systemd[1]: Reached target Local File Systems.2314machine # [ 80.477210] systemd[1]: Reached target Remote File Systems.2315machine # [ 80.478062] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2316machine # [ 80.479524] systemd[1]: Starting Create SUID/SGID Wrappers...2317machine # [ 80.488637] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2318machine # [ 80.489921] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672319machine # [ 80.493686] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2320machine # [ 80.495258] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2321machine # [ 80.496599] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2322machine # [ 80.652850] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2323machine # [ 80.656863] systemd[1]: Finished Create SUID/SGID Wrappers.2324machine # [ 80.658997] systemd[1]: Starting linger-users.service...2325machine # [ 80.699685] systemd[1]: linger-users.service: Deactivated successfully.2326machine # [ 80.702681] systemd[1]: Finished linger-users.service.2327machine # [ 80.959372] nixos[5285]: finished switching to system configuration /nix/store/haj41h0p4x0qrkkaycgivzipfxs0a5m0-nixos-system-machine-test2328machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.81 seconds)2329machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&12330machine # [ 81.253811] nixos[5427]: switching to system configuration /nix/store/9j2mzl2dkjplk4qygr1xwv0adg3dwira-nixos-system-machine-test2331machine # [ 81.257120] systemd[1]: Stopped target Local File Systems.2332machine # [ 81.258958] systemd[1]: Stopped target Remote File Systems.2333machine # [ 81.602698] systemd[1]: Reload requested from client PID 5427 ('.switch-to-conf') (unit backdoor.service)...2334machine # [ 81.604811] systemd[1]: Reloading...2335machine # [ 81.969118] systemd[1]: Reloading finished in 362 ms.2336machine # [ 82.072483] systemd[527]: Reexecution requested from client PID 5496 ('switch-to-confi')...2337machine # [ 82.076361] systemd[527]: Reexecuting.2338machine # [ 82.136028] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2339machine # [ 82.270049] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2340machine # [ 82.277024] systemd[527]: Reload requested from client PID 5496 ('switch-to-confi')...2341machine # [ 82.280276] systemd[527]: Reloading...2342machine # [ 82.399073] systemd[527]: Reloading finished in 119 ms.2343machine # [ 82.416168] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2344machine # [ 82.426036] systemd[527]: Stopped Run user-specific NixOS activation.2345machine # [ 82.428495] systemd[527]: Stopping Run user-specific NixOS activation...2346machine # [ 82.430655] systemd[527]: Starting Run user-specific NixOS activation...2347machine # [ 82.465648] systemd[527]: Finished Run user-specific NixOS activation.2348machine # [ 82.470877] systemd[1]: Stopped target Reactivate sysinit units.2349machine # [ 82.474649] systemd[1]: Stopping Reactivate sysinit units...2350machine # [ 82.475509] systemd[1]: Reached target Reactivate sysinit units.2351machine # [ 82.478080] systemd[1]: Reached target Remote File Systems.2352machine # [ 82.480967] systemd[1]: Reached target Local File Systems.2353machine # [ 82.484525] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2354machine # [ 82.487308] systemd[1]: Starting Create SUID/SGID Wrappers...2355machine # [ 82.490863] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2356machine # [ 82.496987] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672357machine # [ 82.499191] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2358machine # [ 82.506654] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2359machine # [ 82.507969] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2360machine # [ 82.513141] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2361machine # [ 82.514485] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2362machine # [ 82.717531] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2363machine # [ 82.722530] systemd[1]: Finished Create SUID/SGID Wrappers.2364machine # [ 82.724699] systemd[1]: Starting linger-users.service...2365machine # [ 82.767553] systemd[1]: linger-users.service: Deactivated successfully.2366machine # [ 82.769589] systemd[1]: Finished linger-users.service.2367machine # [ 83.032737] nixos[5427]: finished switching to system configuration /nix/store/9j2mzl2dkjplk4qygr1xwv0adg3dwira-nixos-system-machine-test2368machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 2.07 seconds)2369machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&12370machine # [ 83.403280] nixos[5567]: switching to system configuration /nix/store/y5ncdi7qndi3rx6bimmlnwv0czlmj3ms-nixos-system-machine-test2371machine # [ 83.406241] systemd[1]: Stopped target Local File Systems.2372machine # [ 83.409181] systemd[1]: Stopped target Remote File Systems.2373machine # [ 83.733112] systemd[1]: Reload requested from client PID 5567 ('.switch-to-conf') (unit backdoor.service)...2374machine # [ 83.734671] systemd[1]: Reloading...2375machine # [ 84.125822] systemd[1]: Reloading finished in 389 ms.2376machine # [ 84.223744] systemd[527]: Reexecution requested from client PID 5636 ('switch-to-confi')...2377machine # [ 84.225673] systemd[527]: Reexecuting.2378machine # [ 84.279434] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2379machine # [ 84.406380] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2380machine # [ 84.413124] systemd[527]: Reload requested from client PID 5636 ('switch-to-confi')...2381machine # [ 84.416098] systemd[527]: Reloading...2382machine # [ 84.540184] systemd[527]: Reloading finished in 124 ms.2383machine # [ 84.556171] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2384machine # [ 84.567001] systemd[527]: Stopped Run user-specific NixOS activation.2385machine # [ 84.569463] systemd[527]: Stopping Run user-specific NixOS activation...2386machine # [ 84.571593] systemd[527]: Starting Run user-specific NixOS activation...2387machine # [ 84.605140] systemd[527]: Finished Run user-specific NixOS activation.2388machine # [ 84.608748] systemd[1]: Stopped target Reactivate sysinit units.2389machine # [ 84.609683] systemd[1]: Stopping Reactivate sysinit units...2390machine # [ 84.611374] systemd[1]: Reached target Reactivate sysinit units.2391machine # [ 84.615034] systemd[1]: test.service: Deactivated successfully.2392machine # [ 84.615938] systemd[1]: Stopped test.service.2393machine # [ 84.618142] systemd[1]: Stopping test.service...2394machine # [ 84.618891] systemd[1]: Starting test.service...2395machine # [ 84.645671] systemd[1]: Finished test.service.2396machine # [ 84.651180] systemd[1]: Reached target Local File Systems.2397machine # [ 84.654547] systemd[1]: Reached target Remote File Systems.2398machine # [ 84.656769] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2399machine # [ 84.662434] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2400machine # [ 84.663738] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2401machine # [ 84.667845] systemd[1]: Starting Create SUID/SGID Wrappers...2402machine # [ 84.671908] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2403machine # [ 84.678217] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672404machine # [ 84.682564] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2405machine # [ 84.684357] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2406machine # [ 84.685618] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2407machine # [ 84.864974] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2408machine # [ 84.868849] systemd[1]: Finished Create SUID/SGID Wrappers.2409machine # [ 84.871530] systemd[1]: Starting linger-users.service...2410machine # [ 84.914890] systemd[1]: linger-users.service: Deactivated successfully.2411machine # [ 84.917574] systemd[1]: Finished linger-users.service.2412machine # [ 85.178762] nixos[5567]: finished switching to system configuration /nix/store/y5ncdi7qndi3rx6bimmlnwv0czlmj3ms-nixos-system-machine-test2413machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 2.15 seconds)2414machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&12415machine # [ 85.540504] nixos[5709]: switching to system configuration /nix/store/xb5h34hxd5ai0v558s9bxl114qk64ac0-nixos-system-machine-test2416machine # [ 85.543310] systemd[1]: Stopped target Remote File Systems.2417machine # [ 85.545781] systemd[1]: Stopped target Local File Systems.2418machine # [ 85.891836] systemd[1]: Reload requested from client PID 5709 ('.switch-to-conf') (unit backdoor.service)...2419machine # [ 85.893895] systemd[1]: Reloading...2420machine # [ 86.292081] systemd[1]: Reloading finished in 396 ms.2421machine # [ 86.400618] systemd[527]: Reexecution requested from client PID 5777 ('switch-to-confi')...2422machine # [ 86.402061] systemd[527]: Reexecuting.2423machine # [ 86.464484] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2424machine # [ 86.611585] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2425machine # [ 86.619643] systemd[527]: Reload requested from client PID 5777 ('switch-to-confi')...2426machine # [ 86.622553] systemd[527]: Reloading...2427machine # [ 86.756832] systemd[527]: Reloading finished in 133 ms.2428machine # [ 86.772161] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2429machine # [ 86.784343] systemd[527]: Stopped Run user-specific NixOS activation.2430machine # [ 86.787057] systemd[527]: Stopping Run user-specific NixOS activation...2431machine # [ 86.789404] systemd[527]: Starting Run user-specific NixOS activation...2432machine # [ 86.827800] systemd[527]: Finished Run user-specific NixOS activation.2433machine # [ 86.832104] systemd[1]: Stopped target Reactivate sysinit units.2434machine # [ 86.836673] systemd[1]: Stopping Reactivate sysinit units...2435machine # [ 86.837521] systemd[1]: Reached target Reactivate sysinit units.2436machine # [ 86.839070] systemd[1]: test.service: Deactivated successfully.2437machine # [ 86.839885] systemd[1]: Stopped test.service.2438machine # [ 86.842398] systemd[1]: Stopping test.service...2439machine # [ 86.844264] systemd[1]: Starting test.service...2440machine # [ 86.870773] systemd[1]: Finished test.service.2441machine # [ 86.875445] systemd[1]: Reached target Local File Systems.2442machine # [ 86.879832] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2443machine # [ 86.888881] systemd[1]: Starting Create SUID/SGID Wrappers...2444machine # [ 86.889780] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2445machine # [ 86.890997] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672446machine # [ 86.895996] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2447machine # [ 86.898120] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2448machine # [ 86.899493] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2449machine # [ 86.915516] systemd[1]: Reached target Remote File Systems.2450machine # [ 86.920304] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2451machine # [ 86.921772] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2452machine # [ 87.092358] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2453machine # [ 87.096643] systemd[1]: Finished Create SUID/SGID Wrappers.2454machine # [ 87.100571] systemd[1]: Starting linger-users.service...2455machine # [ 87.146196] systemd[1]: linger-users.service: Deactivated successfully.2456machine # [ 87.148874] systemd[1]: Finished linger-users.service.2457machine # [ 87.408910] nixos[5709]: finished switching to system configuration /nix/store/xb5h34hxd5ai0v558s9bxl114qk64ac0-nixos-system-machine-test2458machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 2.23 seconds)2459machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&12460machine # [ 87.858221] nixos[5851]: switching to system configuration /nix/store/fviw3lsfygisc9x07fakhmnwanxywids-nixos-system-machine-test2461machine # [ 87.863732] systemd[1]: Stopped target Remote File Systems.2462machine # [ 87.869346] systemd[1]: Stopped target Local File Systems.2463machine # [ 88.227839] systemd[1]: Reload requested from client PID 5851 ('.switch-to-conf') (unit backdoor.service)...2464machine # [ 88.230044] systemd[1]: Reloading...2465machine # [ 88.567232] systemd[1]: Reloading finished in 335 ms.2466machine # [ 88.654135] systemd[527]: Reexecution requested from client PID 5920 ('switch-to-confi')...2467machine # [ 88.655512] systemd[527]: Reexecuting.2468machine # [ 88.715331] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2469machine # [ 88.831560] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2470machine # [ 88.837989] systemd[527]: Reload requested from client PID 5920 ('switch-to-confi')...2471machine # [ 88.841603] systemd[527]: Reloading...2472machine # [ 88.948234] systemd[527]: Reloading finished in 107 ms.2473machine # [ 88.964147] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2474machine # [ 88.975180] systemd[527]: Stopped Run user-specific NixOS activation.2475machine # [ 88.977461] systemd[527]: Stopping Run user-specific NixOS activation...2476machine # [ 88.979523] systemd[527]: Starting Run user-specific NixOS activation...2477machine # [ 89.011765] systemd[527]: Finished Run user-specific NixOS activation.2478machine # [ 89.015597] systemd[1]: Stopped target Reactivate sysinit units.2479machine # [ 89.017683] systemd[1]: Stopping Reactivate sysinit units...2480machine # [ 89.018538] systemd[1]: Reached target Reactivate sysinit units.2481machine # [ 89.022044] systemd[1]: test.service: Deactivated successfully.2482machine # [ 89.022964] systemd[1]: Stopped test.service.2483machine # [ 89.023614] systemd[1]: Stopping test.service...2484machine # [ 89.028169] systemd[1]: Starting test.service...2485machine # [ 89.050576] systemd[1]: Finished test.service.2486machine # [ 89.054744] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2487machine # [ 89.058367] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2488machine # [ 89.062207] systemd[1]: Reached target Remote File Systems.2489machine # [ 89.066349] systemd[1]: Starting linger-users.service...2490machine # [ 89.074983] systemd[1]: Reached target Local File Systems.2491machine # [ 89.077845] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2492machine # [ 89.088167] systemd[1]: Starting Create SUID/SGID Wrappers...2493machine # [ 89.089102] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2494machine # [ 89.090295] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672495machine # [ 89.096178] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2496machine # [ 89.097793] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2497machine # [ 89.106787] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2498machine # [ 89.149446] systemd[1]: linger-users.service: Deactivated successfully.2499machine # [ 89.152302] systemd[1]: Finished linger-users.service.2500machine # [ 89.284656] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2501machine # [ 89.287728] systemd[1]: Finished Create SUID/SGID Wrappers.2502machine # [ 89.547225] nixos[5851]: finished switching to system configuration /nix/store/fviw3lsfygisc9x07fakhmnwanxywids-nixos-system-machine-test2503machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 2.13 seconds)2504machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12505machine # [ 89.809724] nixos[5993]: switching to system configuration /nix/store/haj41h0p4x0qrkkaycgivzipfxs0a5m0-nixos-system-machine-test2506machine # [ 89.812512] systemd[1]: Stopped target Remote File Systems.2507machine # [ 89.814121] systemd[1]: Stopped target Local File Systems.2508machine # [ 90.063828] systemd[1]: Reload requested from client PID 5993 ('.switch-to-conf') (unit backdoor.service)...2509machine # [ 90.066075] systemd[1]: Reloading...2510machine # [ 90.372906] systemd[1]: Reloading finished in 305 ms.2511machine # [ 90.456136] systemd[527]: Reexecution requested from client PID 6062 ('switch-to-confi')...2512machine # [ 90.460112] systemd[527]: Reexecuting.2513machine # [ 90.506933] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2514machine # [ 90.618462] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2515machine # [ 90.624681] systemd[527]: Reload requested from client PID 6062 ('switch-to-confi')...2516machine # [ 90.626846] systemd[527]: Reloading...2517machine # [ 90.734623] systemd[527]: Reloading finished in 106 ms.2518machine # [ 90.752153] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2519machine # [ 90.761196] systemd[527]: Stopped Run user-specific NixOS activation.2520machine # [ 90.763423] systemd[527]: Stopping Run user-specific NixOS activation...2521machine # [ 90.765428] systemd[527]: Starting Run user-specific NixOS activation...2522machine # [ 90.794673] systemd[527]: Finished Run user-specific NixOS activation.2523machine # [ 90.798190] systemd[1]: Stopped target Reactivate sysinit units.2524machine # [ 90.802650] systemd[1]: Stopping Reactivate sysinit units...2525machine # [ 90.803526] systemd[1]: Reached target Reactivate sysinit units.2526machine # [ 90.804632] systemd[1]: test.service: Deactivated successfully.2527machine # [ 90.805438] systemd[1]: Stopped test.service.2528machine # [ 90.806042] systemd[1]: Stopping test.service...2529machine # [ 90.807648] systemd[1]: Starting test.service...2530machine # [ 90.832087] systemd[1]: Finished test.service.2531machine # [ 90.835152] systemd[1]: Reached target Local File Systems.2532machine # [ 90.839359] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2533machine # [ 90.848290] systemd[1]: Starting Create SUID/SGID Wrappers...2534machine # [ 90.849131] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2535machine # [ 90.850316] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672536machine # [ 90.860586] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2537machine # [ 90.862141] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2538machine # [ 90.863366] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2539machine # [ 90.864646] systemd[1]: Reached target Remote File Systems.2540machine # [ 90.865401] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2541machine # [ 90.866648] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2542machine # [ 91.019579] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2543machine # [ 91.024446] systemd[1]: Finished Create SUID/SGID Wrappers.2544machine # [ 91.026621] systemd[1]: Starting linger-users.service...2545machine # [ 91.063406] systemd[1]: linger-users.service: Deactivated successfully.2546machine # [ 91.066019] systemd[1]: Finished linger-users.service.2547machine # [ 91.323951] nixos[5993]: finished switching to system configuration /nix/store/haj41h0p4x0qrkkaycgivzipfxs0a5m0-nixos-system-machine-test2548machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.78 seconds)2549machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&12550machine # [ 91.614775] nixos[6135]: switching to system configuration /nix/store/l0z785l7qc4f004h6c0y2i0s1m0ppsng-nixos-system-machine-test2551machine # [ 91.617406] systemd[1]: Stopped target Remote File Systems.2552machine # [ 91.619668] systemd[1]: Stopped target Local File Systems.2553machine # [ 91.888441] systemd[1]: Reload requested from client PID 6135 ('.switch-to-conf') (unit backdoor.service)...2554machine # [ 91.890291] systemd[1]: Reloading...2555machine # [ 92.207110] systemd[1]: Reloading finished in 315 ms.2556machine # [ 92.296382] systemd[527]: Reexecution requested from client PID 6204 ('switch-to-confi')...2557machine # [ 92.299872] systemd[527]: Reexecuting.2558machine # [ 92.355189] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2559machine # [ 92.468734] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2560machine # [ 92.475055] systemd[527]: Reload requested from client PID 6204 ('switch-to-confi')...2561machine # [ 92.477137] systemd[527]: Reloading...2562machine # [ 92.584931] systemd[527]: Reloading finished in 106 ms.2563machine # [ 92.601527] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2564machine # [ 92.608756] systemd[527]: Stopped Run user-specific NixOS activation.2565machine # [ 92.610987] systemd[527]: Stopping Run user-specific NixOS activation...2566machine # [ 92.612991] systemd[527]: Starting Run user-specific NixOS activation...2567machine # [ 92.641869] systemd[527]: Finished Run user-specific NixOS activation.2568machine # [ 92.645727] systemd[1]: Stopped target Reactivate sysinit units.2569machine # [ 92.648283] systemd[1]: Stopping Reactivate sysinit units...2570machine # [ 92.649100] systemd[1]: Reached target Reactivate sysinit units.2571machine # [ 92.652413] systemd[1]: Reloading test.service...2572machine # [ 92.675528] systemd[1]: Reloaded test.service.2573machine # [ 92.680847] systemd[1]: Reached target Remote File Systems.2574machine # [ 92.683764] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2575machine # [ 92.685740] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2576machine # [ 92.691023] systemd[1]: Starting linger-users.service...2577machine # [ 92.696095] systemd[1]: Reached target Local File Systems.2578machine # [ 92.702539] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2579machine # [ 92.707147] systemd[1]: Starting Create SUID/SGID Wrappers...2580machine # [ 92.711393] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2581machine # [ 92.712785] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672582machine # [ 92.714931] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2583machine # [ 92.721650] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2584machine # [ 92.722943] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2585machine # [ 92.765321] systemd[1]: linger-users.service: Deactivated successfully.2586machine # [ 92.768793] systemd[1]: Finished linger-users.service.2587machine # [ 92.897629] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2588machine # [ 92.900839] systemd[1]: Finished Create SUID/SGID Wrappers.2589machine # [ 93.158746] nixos[6135]: finished switching to system configuration /nix/store/l0z785l7qc4f004h6c0y2i0s1m0ppsng-nixos-system-machine-test2590machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.83 seconds)2591machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&12592machine # [ 93.442754] nixos[6277]: switching to system configuration /nix/store/q34zv04917y9f9f5q3761yd2pbm92wpg-nixos-system-machine-test2593machine # [ 93.445185] systemd[1]: Stopped target Local File Systems.2594machine # [ 93.447470] systemd[1]: Stopped target Remote File Systems.2595machine # [ 93.713685] systemd[1]: Reload requested from client PID 6277 ('.switch-to-conf') (unit backdoor.service)...2596machine # [ 93.715523] systemd[1]: Reloading...2597machine # [ 94.031546] systemd[1]: Reloading finished in 314 ms.2598machine # [ 94.123206] systemd[527]: Reexecution requested from client PID 6346 ('switch-to-confi')...2599machine # [ 94.125118] systemd[527]: Reexecuting.2600machine # [ 94.170859] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2601machine # [ 94.281282] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2602machine # [ 94.287940] systemd[527]: Reload requested from client PID 6346 ('switch-to-confi')...2603machine # [ 94.291454] systemd[527]: Reloading...2604machine # [ 94.397523] systemd[527]: Reloading finished in 107 ms.2605machine # [ 94.412132] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2606machine # [ 94.420673] systemd[527]: Stopped Run user-specific NixOS activation.2607machine # [ 94.422859] systemd[527]: Stopping Run user-specific NixOS activation...2608machine # [ 94.424828] systemd[527]: Starting Run user-specific NixOS activation...2609machine # [ 94.454235] systemd[527]: Finished Run user-specific NixOS activation.2610machine # [ 94.457643] systemd[1]: Stopped target Reactivate sysinit units.2611machine # [ 94.461402] systemd[1]: Stopping Reactivate sysinit units...2612machine # [ 94.462232] systemd[1]: Reached target Reactivate sysinit units.2613machine # [ 94.464264] systemd[1]: Reloading test.service...2614machine # [ 94.488240] systemd[1]: Reloaded test.service.2615machine # [ 94.494357] systemd[1]: Reached target Remote File Systems.2616machine # [ 94.498233] systemd[1]: Starting linger-users.service...2617machine # [ 94.506419] systemd[1]: Reached target Local File Systems.2618machine # [ 94.507228] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2619machine # [ 94.516481] systemd[1]: Starting Create SUID/SGID Wrappers...2620machine # [ 94.517299] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2621machine # [ 94.518521] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672622machine # [ 94.523989] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2623machine # [ 94.525582] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2624machine # [ 94.526801] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2625machine # [ 94.527979] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2626machine # [ 94.533633] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2627machine # [ 94.576784] systemd[1]: linger-users.service: Deactivated successfully.2628machine # [ 94.579364] systemd[1]: Finished linger-users.service.2629machine # [ 94.710209] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2630machine # [ 94.713937] systemd[1]: Finished Create SUID/SGID Wrappers.2631machine # [ 94.970437] nixos[6277]: finished switching to system configuration /nix/store/q34zv04917y9f9f5q3761yd2pbm92wpg-nixos-system-machine-test2632machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.81 seconds)2633machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&12634machine # [ 95.259943] nixos[6419]: switching to system configuration /nix/store/5v2ak9rwlf69iv36px97ccqrmai8h376-nixos-system-machine-test2635machine # [ 95.262486] systemd[1]: Stopped target Local File Systems.2636machine # [ 95.265270] systemd[1]: Stopped target Remote File Systems.2637machine # [ 95.531194] systemd[1]: Reload requested from client PID 6419 ('.switch-to-conf') (unit backdoor.service)...2638machine # [ 95.533173] systemd[1]: Reloading...2639machine # [ 95.847356] systemd[1]: Reloading finished in 312 ms.2640machine # [ 95.938467] systemd[527]: Reexecution requested from client PID 6488 ('switch-to-confi')...2641machine # [ 95.939791] systemd[527]: Reexecuting.2642machine # [ 95.999661] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2643machine # [ 96.115396] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2644machine # [ 96.121432] systemd[527]: Reload requested from client PID 6488 ('switch-to-confi')...2645machine # [ 96.124770] systemd[527]: Reloading...2646machine # [ 96.228454] systemd[527]: Reloading finished in 104 ms.2647machine # [ 96.244136] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2648machine # [ 96.254461] systemd[527]: Stopped Run user-specific NixOS activation.2649machine # [ 96.256628] systemd[527]: Stopping Run user-specific NixOS activation...2650machine # [ 96.258541] systemd[527]: Starting Run user-specific NixOS activation...2651machine # [ 96.292519] systemd[527]: Finished Run user-specific NixOS activation.2652machine # [ 96.295730] systemd[1]: Stopped target Reactivate sysinit units.2653machine # [ 96.297600] systemd[1]: Stopping Reactivate sysinit units...2654machine # [ 96.298409] systemd[1]: Reached target Reactivate sysinit units.2655machine # [ 96.301762] systemd[1]: test.service: Deactivated successfully.2656machine # [ 96.302681] systemd[1]: Stopped test.service.2657machine # [ 96.303282] systemd[1]: Stopping test.service...2658machine # [ 96.305868] systemd[1]: Starting test.service...2659machine # [ 96.327881] systemd[1]: Finished test.service.2660machine # [ 96.330976] systemd[1]: Reached target Remote File Systems.2661machine # [ 96.333442] systemd[1]: Reached target Local File Systems.2662machine # [ 96.339372] systemd[1]: Starting linger-users.service...2663machine # [ 96.348976] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2664machine # [ 96.351173] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2665machine # [ 96.354086] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2666machine # [ 96.361892] systemd[1]: Starting Create SUID/SGID Wrappers...2667machine # [ 96.368200] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2668machine # [ 96.369460] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672669machine # [ 96.371541] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2670machine # [ 96.374547] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2671machine # [ 96.375958] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2672machine # [ 96.418135] systemd[1]: linger-users.service: Deactivated successfully.2673machine # [ 96.420851] systemd[1]: Finished linger-users.service.2674machine # [ 96.551912] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2675machine # [ 96.555130] systemd[1]: Finished Create SUID/SGID Wrappers.2676machine # [ 96.813453] nixos[6419]: finished switching to system configuration /nix/store/5v2ak9rwlf69iv36px97ccqrmai8h376-nixos-system-machine-test2677machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.84 seconds)2678machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&12679machine # [ 97.074645] nixos[6561]: switching to system configuration /nix/store/y5ncdi7qndi3rx6bimmlnwv0czlmj3ms-nixos-system-machine-test2680machine # [ 97.077208] systemd[1]: Stopped target Remote File Systems.2681machine # [ 97.079344] systemd[1]: Stopped target Local File Systems.2682machine # [ 97.325355] systemd[1]: Reload requested from client PID 6561 ('.switch-to-conf') (unit backdoor.service)...2683machine # [ 97.327197] systemd[1]: Reloading...2684machine # [ 97.629292] systemd[1]: Reloading finished in 300 ms.2685machine # [ 97.715791] systemd[527]: Reexecution requested from client PID 6630 ('switch-to-confi')...2686machine # [ 97.719460] systemd[527]: Reexecuting.2687machine # [ 97.771062] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2688machine # [ 97.883114] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2689machine # [ 97.889330] systemd[527]: Reload requested from client PID 6630 ('switch-to-confi')...2690machine # [ 97.892081] systemd[527]: Reloading...2691machine # [ 97.996935] systemd[527]: Reloading finished in 105 ms.2692machine # [ 98.012159] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2693machine # [ 98.022673] systemd[527]: Stopped Run user-specific NixOS activation.2694machine # [ 98.024904] systemd[527]: Stopping Run user-specific NixOS activation...2695machine # [ 98.026869] systemd[527]: Starting Run user-specific NixOS activation...2696machine # [ 98.058096] systemd[527]: Finished Run user-specific NixOS activation.2697machine # [ 98.061138] systemd[1]: Stopped target Reactivate sysinit units.2698machine # [ 98.063210] systemd[1]: Stopping Reactivate sysinit units...2699machine # [ 98.065179] systemd[1]: Reached target Reactivate sysinit units.2700machine # [ 98.066965] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2701machine # [ 98.069474] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2702machine # [ 98.071325] systemd[1]: Reached target Remote File Systems.2703machine # [ 98.077538] systemd[1]: Starting linger-users.service...2704machine # [ 98.084387] systemd[1]: Reached target Local File Systems.2705machine # [ 98.087966] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2706machine # [ 98.093647] systemd[1]: Starting Create SUID/SGID Wrappers...2707machine # [ 98.094452] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2708machine # [ 98.095617] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672709machine # [ 98.101954] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2710machine # [ 98.103542] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2711machine # [ 98.108811] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2712machine # [ 98.152359] systemd[1]: linger-users.service: Deactivated successfully.2713machine # [ 98.155960] systemd[1]: Finished linger-users.service.2714machine # [ 98.280863] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2715machine # [ 98.283519] systemd[1]: Finished Create SUID/SGID Wrappers.2716machine # [ 98.542864] nixos[6561]: finished switching to system configuration /nix/store/y5ncdi7qndi3rx6bimmlnwv0czlmj3ms-nixos-system-machine-test2717machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.73 seconds)2718(finished: subtest: unit file parser, in 24.86 seconds)2719subtest: restart and reload by activation script2720machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&12721machine # [ 98.801123] nixos[6701]: switching to system configuration /nix/store/5v7sf5lcjls65m8azcd473j1vn2igdnx-nixos-system-machine-test2722machine # [ 98.803643] systemd[1]: Stopped target Remote File Systems.2723machine # [ 98.805885] systemd[1]: Stopped target Local File Systems.2724machine # [ 99.049615] systemd[1]: Reload requested from client PID 6701 ('.switch-to-conf') (unit backdoor.service)...2725machine # [ 99.051531] systemd[1]: Reloading...2726machine # [ 99.354868] systemd[1]: Reloading finished in 301 ms.2727machine # [ 99.445086] systemd[527]: Reexecution requested from client PID 6770 ('switch-to-confi')...2728machine # [ 99.449343] systemd[527]: Reexecuting.2729machine # [ 99.507279] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2730machine # [ 99.624091] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2731machine # [ 99.630369] systemd[527]: Reload requested from client PID 6770 ('switch-to-confi')...2732machine # [ 99.632599] systemd[527]: Reloading...2733machine # [ 99.739217] systemd[527]: Reloading finished in 105 ms.2734machine # [ 99.756141] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2735machine # [ 99.766089] systemd[527]: Stopped Run user-specific NixOS activation.2736machine # [ 99.768396] systemd[527]: Stopping Run user-specific NixOS activation...2737machine # [ 99.770392] systemd[527]: Starting Run user-specific NixOS activation...2738machine # [ 99.802596] systemd[527]: Finished Run user-specific NixOS activation.2739machine # [ 99.806161] systemd[1]: Stopped target Reactivate sysinit units.2740machine # [ 99.807960] systemd[1]: Stopping Reactivate sysinit units...2741machine # [ 99.810418] systemd[1]: Reached target Reactivate sysinit units.2742machine # [ 99.811256] systemd[1]: Reached target Remote File Systems.2743machine # [ 99.815961] systemd[1]: Reached target Local File Systems.2744machine # [ 99.819887] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2745machine # [ 99.826916] systemd[1]: Starting Create SUID/SGID Wrappers...2746machine # [ 99.827734] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2747machine # [ 99.835016] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672748machine # [ 99.837444] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2749machine # [ 99.839007] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2750machine # [ 99.840259] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2751machine # [ 99.841380] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2752machine # [ 99.842597] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2753machine # [ 99.995075] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2754machine # [ 99.996900] systemd[1]: Finished Create SUID/SGID Wrappers.2755machine # [ 100.001603] systemd[1]: Starting linger-users.service...2756machine # [ 100.038757] systemd[1]: linger-users.service: Deactivated successfully.2757machine # [ 100.041429] systemd[1]: Finished linger-users.service.2758machine # [ 100.298004] nixos[6701]: finished switching to system configuration /nix/store/5v7sf5lcjls65m8azcd473j1vn2igdnx-nixos-system-machine-test2759machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.76 seconds)2760machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12761machine # [ 100.587001] nixos[6841]: switching to system configuration /nix/store/4gb96awhq649id9pjviarlwd3rbyiaaz-nixos-system-machine-test2762machine # [ 100.589693] systemd[1]: Stopped target Remote File Systems.2763machine # [ 100.592969] systemd[1]: test.service: Deactivated successfully.2764machine # [ 100.593934] systemd[1]: Stopped test.service.2765machine # [ 100.594590] systemd[1]: Stopped target Local File Systems.2766machine # [ 100.868329] systemd[1]: Reload requested from client PID 6841 ('.switch-to-conf') (unit backdoor.service)...2767machine # [ 100.870175] systemd[1]: Reloading...2768machine # [ 101.195227] systemd[1]: Reloading finished in 323 ms.2769machine # [ 101.282669] systemd[527]: Reexecution requested from client PID 6912 ('switch-to-confi')...2770machine # [ 101.286139] systemd[527]: Reexecuting.2771machine # [ 101.339044] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2772machine # [ 101.451485] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2773machine # [ 101.457805] systemd[527]: Reload requested from client PID 6912 ('switch-to-confi')...2774machine # [ 101.459968] systemd[527]: Reloading...2775machine # [ 101.566817] systemd[527]: Reloading finished in 105 ms.2776machine # [ 101.584149] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2777machine # [ 101.593857] systemd[527]: Stopped Run user-specific NixOS activation.2778machine # [ 101.594848] systemd[527]: Stopping Run user-specific NixOS activation...2779machine # [ 101.597346] systemd[527]: Starting Run user-specific NixOS activation...2780machine # [ 101.626983] systemd[527]: Finished Run user-specific NixOS activation.2781machine # [ 101.630932] systemd[1]: Stopped target Reactivate sysinit units.2782machine # [ 101.633943] systemd[1]: Stopping Reactivate sysinit units...2783machine # [ 101.634837] systemd[1]: Reached target Reactivate sysinit units.2784machine # [ 101.639652] systemd[1]: Starting no-restart-service.service...2785machine # [ 101.644872] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2786machine # [ 101.646241] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2787machine # [ 101.662262] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as.2788machine # [ 101.667129] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2789machine # [ 101.676289] systemd[1]: Reached target Remote File Systems.2790machine # [ 101.677121] systemd[1]: Reached target Local File Systems.2791machine # [ 101.688447] systemd[1]: Starting simple-reload-service.service...2792machine # [ 101.689380] systemd[1]: Created slice Slice /system/templated-reload-triggers.2793machine # [ 101.690359] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart.2794machine # [ 101.706839] systemd[1]: Starting linger-users.service...2795machine # [ 101.707702] systemd[1]: Starting reload-triggers-and-restart.service...2796machine # [ 101.730116] systemd[1]: Starting reload-triggers.service...2797machine # [ 101.730974] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2798machine # [ 101.756681] systemd[1]: Starting templated-reload-triggers@instance.service...2799machine # [ 101.757727] systemd[1]: Finished no-restart-service.service.2800machine # [ 101.758664] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2801machine # [ 101.759711] systemd[1]: Created slice Slice /system/templated-simple-reload-service.2802machine # [ 101.817467] systemd[1]: Starting templated-simple-reload-service@instance.service...2803machine # [ 101.818729] systemd[1]: Created slice Slice /system/templated-no-restart-service.2804machine # [ 101.819875] systemd[1]: Starting templated-no-restart-service@instance.service...2805machine # [ 101.879406] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2806machine # [ 101.907516] systemd[1]: Starting Create SUID/SGID Wrappers...2807machine # [ 101.918203] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2808machine # [ 101.929545] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672809machine # [ 101.945573] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2810machine # [ 101.947423] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2811machine # [ 101.962450] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2812machine # [ 101.963683] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2813machine # [ 101.967817] systemd[1]: Created slice Slice /system/templated-simple-service.2814machine # [ 101.971589] systemd[1]: Created slice Slice /system/templated-simple-restart-service.2815machine # [ 101.974464] systemd[1]: Finished simple-reload-service.service.2816machine # [ 101.975322] systemd[1]: Finished reload-triggers.service.2817machine # [ 101.979677] systemd[1]: Finished reload-triggers-and-restart.service.2818machine # [ 101.983226] systemd[1]: Finished templated-reload-triggers@instance.service.2819machine # [ 101.987666] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2820machine # [ 101.989085] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2821machine # [ 101.990803] systemd[1]: Finished templated-simple-reload-service@instance.service.2822machine # [ 101.992475] systemd[1]: Finished templated-no-restart-service@instance.service.2823machine # [ 101.993481] systemd[1]: linger-users.service: Deactivated successfully.2824machine # [ 101.994379] systemd[1]: Finished linger-users.service.2825machine # [ 102.121888] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2826machine # [ 102.124152] systemd[1]: Finished Create SUID/SGID Wrappers.2827machine # [ 102.128215] systemd[1]: Starting simple-restart-service.service...2828machine # [ 102.132557] systemd[1]: Starting simple-service.service...2829machine # [ 102.141821] systemd[1]: Starting templated-simple-restart-service@instance.service...2830machine # [ 102.150386] systemd[1]: Starting templated-simple-service@instance.service...2831machine # [ 102.195650] systemd[1]: Finished templated-simple-restart-service@instance.service.2832machine # [ 102.199204] systemd[1]: Finished simple-restart-service.service.2833machine # [ 102.204828] systemd[1]: Finished simple-service.service.2834machine # [ 102.206935] systemd[1]: Finished templated-simple-service@instance.service.2835machine # [ 102.467483] nixos[6841]: finished switching to system configuration /nix/store/4gb96awhq649id9pjviarlwd3rbyiaaz-nixos-system-machine-test2836machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.17 seconds)2837machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12838machine # [ 102.767522] nixos[7012]: switching to system configuration /nix/store/4gb96awhq649id9pjviarlwd3rbyiaaz-nixos-system-machine-test2839machine # [ 102.770177] systemd[1]: Stopped target Remote File Systems.2840machine # [ 102.772315] systemd[1]: Stopped target Local File Systems.2841machine # [ 103.034091] systemd[1]: Reload requested from client PID 7012 ('.switch-to-conf') (unit backdoor.service)...2842machine # [ 103.035618] systemd[1]: Reloading...2843machine # [ 103.360987] systemd[1]: Reloading finished in 324 ms.2844machine # [ 103.453497] systemd[527]: Reexecution requested from client PID 7082 ('switch-to-confi')...2845machine # [ 103.457536] systemd[527]: Reexecuting.2846machine # [ 103.515393] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2847machine # [ 103.631973] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2848machine # [ 103.638075] systemd[527]: Reload requested from client PID 7082 ('switch-to-confi')...2849machine # [ 103.640460] systemd[527]: Reloading...2850machine # [ 103.748687] systemd[527]: Reloading finished in 107 ms.2851machine # [ 103.764150] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2852machine # [ 103.772541] systemd[527]: Stopped Run user-specific NixOS activation.2853machine # [ 103.774771] systemd[527]: Stopping Run user-specific NixOS activation...2854machine # [ 103.776844] systemd[527]: Starting Run user-specific NixOS activation...2855machine # [ 103.806238] systemd[527]: Finished Run user-specific NixOS activation.2856machine # [ 103.810040] systemd[1]: Stopped target Reactivate sysinit units.2857machine # [ 103.813326] systemd[1]: Stopping Reactivate sysinit units...2858machine # [ 103.816526] systemd[1]: Reached target Reactivate sysinit units.2859machine # [ 103.819066] systemd[1]: Reloading reload-triggers-and-restart.service...2860machine # [ 103.826780] systemd[1]: Reloading reload-triggers.service...2861machine # [ 103.832252] systemd[1]: Reloading simple-reload-service.service...2862machine # [ 103.847492] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service...2863machine # [ 103.850362] systemd[1]: Reloading templated-reload-triggers@instance.service...2864machine # [ 103.860419] systemd[1]: Reloading templated-simple-reload-service@instance.service...2865machine # [ 103.914685] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service.2866machine # [ 103.919938] systemd[1]: Reloaded simple-reload-service.service.2867machine # [ 103.924991] systemd[1]: Reloaded reload-triggers-and-restart.service.2868machine # [ 103.925954] systemd[1]: Reloaded reload-triggers.service.2869machine # [ 103.928546] systemd[1]: Reloaded templated-reload-triggers@instance.service.2870machine # [ 103.935380] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2871machine # [ 103.938686] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2872machine # [ 103.942181] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2873machine # [ 103.943206] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2874machine # [ 103.945693] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2875machine # [ 103.957009] systemd[1]: simple-restart-service.service: Deactivated successfully.2876machine # [ 103.958056] systemd[1]: Stopped simple-restart-service.service.2877machine # [ 103.958869] systemd[1]: Stopping simple-restart-service.service...2878machine # [ 103.959714] systemd[1]: Starting simple-restart-service.service...2879machine # [ 103.980340] systemd[1]: simple-service.service: Deactivated successfully.2880machine # [ 103.981273] systemd[1]: Stopped simple-service.service.2881machine # [ 103.981999] systemd[1]: Stopping simple-service.service...2882machine # [ 103.982772] systemd[1]: Starting simple-service.service...2883machine # [ 103.983513] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2884machine # [ 104.006987] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2885machine # [ 104.016357] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2886machine # [ 104.026606] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2887machine # [ 104.037709] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2888machine # [ 104.051828] systemd[1]: Stopped templated-simple-restart-service@instance.service.2889machine # [ 104.061360] systemd[1]: Stopping templated-simple-restart-service@instance.service...2890machine # [ 104.062578] systemd[1]: Starting templated-simple-restart-service@instance.service...2891machine # [ 104.063732] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2892machine # [ 104.072472] systemd[1]: Stopped templated-simple-service@instance.service.2893machine # [ 104.074339] systemd[1]: Stopping templated-simple-service@instance.service...2894machine # [ 104.075307] systemd[1]: Starting templated-simple-service@instance.service...2895machine # [ 104.076672] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2896machine # [ 104.077632] systemd[1]: Finished simple-restart-service.service.2897machine # [ 104.078565] systemd[1]: Finished simple-service.service.2898machine # [ 104.079286] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2899machine # [ 104.081525] systemd[1]: Finished templated-simple-restart-service@instance.service.2900machine # [ 104.086422] systemd[1]: Finished templated-simple-service@instance.service.2901machine # [ 104.090666] systemd[1]: Reached target Remote File Systems.2902machine # [ 104.091496] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2903machine # [ 104.097064] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2904machine # [ 104.098368] systemd[1]: Reached target Local File Systems.2905machine # [ 104.099130] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2906machine # [ 104.103480] systemd[1]: Starting Create SUID/SGID Wrappers...2907machine # [ 104.107154] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2908machine # [ 104.109078] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672909machine # [ 104.111206] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2910machine # [ 104.121008] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2911machine # [ 104.122260] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2912machine # [ 104.275440] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2913machine # [ 104.280154] systemd[1]: Finished Create SUID/SGID Wrappers.2914machine # [ 104.281932] systemd[1]: Starting linger-users.service...2915machine # [ 104.318590] systemd[1]: linger-users.service: Deactivated successfully.2916machine # [ 104.321110] systemd[1]: Finished linger-users.service.2917machine # [ 104.579508] nixos[7012]: finished switching to system configuration /nix/store/4gb96awhq649id9pjviarlwd3rbyiaaz-nixos-system-machine-test2918machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.11 seconds)2919machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&12920machine # [ 104.910448] nixos[7178]: switching to system configuration /nix/store/q084q2vgjp748ms3xgh2d52crgfhnni1-nixos-system-machine-test2921machine # [ 104.913067] systemd[1]: Stopped target Remote File Systems.2922machine # [ 104.915183] systemd[1]: Stopped target Local File Systems.2923machine # [ 105.202515] systemd[1]: Reload requested from client PID 7178 ('.switch-to-conf') (unit backdoor.service)...2924machine # [ 105.204389] systemd[1]: Reloading...2925machine # [ 105.547797] systemd[1]: Reloading finished in 341 ms.2926machine # [ 105.642685] systemd[527]: Reexecution requested from client PID 7249 ('switch-to-confi')...2927machine # [ 105.646739] systemd[527]: Reexecuting.2928machine # [ 105.703361] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2929machine # [ 105.821059] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2930machine # [ 105.827697] systemd[527]: Reload requested from client PID 7249 ('switch-to-confi')...2931machine # [ 105.831111] systemd[527]: Reloading...2932machine # [ 105.939238] systemd[527]: Reloading finished in 109 ms.2933machine # [ 105.956151] systemd[527]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2934machine # [ 105.964720] systemd[527]: Stopped Run user-specific NixOS activation.2935machine # [ 105.967022] systemd[527]: Stopping Run user-specific NixOS activation...2936machine # [ 105.969007] systemd[527]: Starting Run user-specific NixOS activation...2937machine # [ 105.998548] systemd[527]: Finished Run user-specific NixOS activation.2938machine # [ 106.002534] systemd[1]: Stopped target Reactivate sysinit units.2939machine # [ 106.004555] systemd[1]: Stopping Reactivate sysinit units...2940machine # [ 106.005403] systemd[1]: Reached target Reactivate sysinit units.2941machine # [ 106.010056] systemd[1]: Reloading reload-triggers.service...2942machine # [ 106.020360] systemd[1]: Reloading simple-reload-service.service...2943machine # [ 106.024239] systemd[1]: Reloading templated-reload-triggers@instance.service...2944machine # [ 106.035587] systemd[1]: Reloading templated-simple-reload-service@instance.service...2945machine # [ 106.087752] systemd[1]: Reloaded reload-triggers.service.2946machine # [ 106.091190] systemd[1]: Reloaded simple-reload-service.service.2947machine # [ 106.092555] systemd[1]: Reloaded templated-reload-triggers@instance.service.2948machine # [ 106.093505] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2949machine # [ 106.097264] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2950machine # [ 106.098421] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2951machine # [ 106.099345] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2952machine # [ 106.108404] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2953machine # [ 106.109371] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully.2954machine # [ 106.110416] systemd[1]: Stopped reload-triggers-and-restart.service.2955machine # [ 106.111250] systemd[1]: Stopping reload-triggers-and-restart.service...2956machine # [ 106.126570] systemd[1]: Starting reload-triggers-and-restart.service...2957machine # [ 106.127503] systemd[1]: simple-restart-service.service: Deactivated successfully.2958machine # [ 106.146590] systemd[1]: Stopped simple-restart-service.service.2959machine # [ 106.147547] systemd[1]: Stopping simple-restart-service.service...2960machine # [ 106.174519] systemd[1]: Starting simple-restart-service.service...2961machine # [ 106.175385] systemd[1]: simple-service.service: Deactivated successfully.2962machine # [ 106.183185] systemd[1]: Stopped simple-service.service.2963machine # [ 106.183956] systemd[1]: Stopping simple-service.service...2964machine # [ 106.197869] systemd[1]: Starting simple-service.service...2965machine # [ 106.198711] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2966machine # [ 106.224554] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2967machine # [ 106.234251] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2968machine # [ 106.243048] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2969machine # [ 106.251738] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully.2970machine # [ 106.255081] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service.2971machine # [ 106.258164] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service...2972machine # [ 106.259275] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2973machine # [ 106.263778] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2974machine # [ 106.270016] systemd[1]: Stopped templated-simple-restart-service@instance.service.2975machine # [ 106.271039] systemd[1]: Stopping templated-simple-restart-service@instance.service...2976machine # [ 106.272285] systemd[1]: Starting templated-simple-restart-service@instance.service...2977machine # [ 106.273291] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2978machine # [ 106.274400] systemd[1]: Stopped templated-simple-service@instance.service.2979machine # [ 106.275300] systemd[1]: Stopping templated-simple-service@instance.service...2980machine # [ 106.276446] systemd[1]: Starting templated-simple-service@instance.service...2981machine # [ 106.277393] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2982machine # [ 106.278303] systemd[1]: Finished reload-triggers-and-restart.service.2983machine # [ 106.279142] systemd[1]: Finished simple-restart-service.service.2984machine # [ 106.279929] systemd[1]: Finished simple-service.service.2985machine # [ 106.289703] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2986machine # [ 106.290865] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2987machine # [ 106.291895] systemd[1]: Finished templated-simple-restart-service@instance.service.2988machine # [ 106.297049] systemd[1]: Finished templated-simple-service@instance.service.2989machine # [ 106.298024] systemd[1]: Reached target Local File Systems.2990machine # [ 106.298774] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2991machine # [ 106.304348] systemd[1]: Starting Create SUID/SGID Wrappers...2992machine # [ 106.305193] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2993machine # [ 106.306674] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672994machine # [ 106.309610] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2995machine # [ 106.311604] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2996machine # [ 106.314769] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2997machine # [ 106.315951] systemd[1]: Reached target Remote File Systems.2998machine # [ 106.319232] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2999machine # [ 106.320726] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki3000machine # [ 106.462800] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.3001machine # [ 106.466739] systemd[1]: Finished Create SUID/SGID Wrappers.3002machine # [ 106.468869] systemd[1]: Starting linger-users.service...3003machine # [ 106.506695] systemd[1]: linger-users.service: Deactivated successfully.3004machine # [ 106.509510] systemd[1]: Finished linger-users.service.3005machine # [ 106.766450] nixos[7178]: finished switching to system configuration /nix/store/q084q2vgjp748ms3xgh2d52crgfhnni1-nixos-system-machine-test3006machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.19 seconds)3007machine: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&13008machine: (finished: must succeed: /nix/store/sj3vf02v32xsp79q4mdxnz8r8zaqmqw7-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.39 seconds)3009(finished: subtest: restart and reload by activation script, in 8.62 seconds)3010(finished: run the VM test script, in 108.06 seconds)3011test script finished in 108.10s3012cleanup3013kill QemuMachine (pid 45)3014machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14)3015machine # [2026-09-22T03:00:31Z INFO virtiofsd] Client disconnected, shutting down3016machine # [2026-09-22T03:00:31Z INFO virtiofsd] Client disconnected, shutting down3017machine # [2026-09-22T03:00:31Z INFO virtiofsd] Client disconnected, shutting down3018(finished: cleanup, in 0.19 seconds)3019additionally exposed symbols:3020 machine, other,3021 vlan1,3022 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