vm-test-run-switch-test-services
checks.aarch64-linux.switchTest
· build #44
· raw
1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7machine: waiting for unit multi-user.target8machine: waiting for the VM to finish booting9machine: starting vm10machine: QEMU running (pid 45)11machine # Disk image does not exist, creating the virtualisation disk image...12machine # Formatting '/build/vm-state-machine/tmp.P8I0HaTdtP', 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: 14b8fb82-e745-4320-b3ba-f5c20581132717machine # 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-25T03:04:20Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)28machine # [2026-09-25T03:04:20Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether29machine # [2026-09-25T03:04:20Z INFO virtiofsd] Waiting for vhost-user socket connection...30machine # [2026-09-25T03:04:20Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)31machine # [2026-09-25T03:04:20Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether32machine # [2026-09-25T03:04:20Z INFO virtiofsd] Waiting for vhost-user socket connection...33machine # [2026-09-25T03:04:20Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)34machine # [2026-09-25T03:04:20Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether35machine # [2026-09-25T03:04:20Z INFO virtiofsd] Waiting for vhost-user socket connection...36machine # [2026-09-25T03:04:20Z INFO virtiofsd] Client connected, servicing requests37machine # [2026-09-25T03:04:20Z INFO virtiofsd] Client connected, servicing requests38machine # [2026-09-25T03:04:20Z INFO virtiofsd] Client connected, servicing requests39machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]40machine # [ 0.000000] Linux version 6.18.53 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 21 13:06:06 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 0x7fdee700-0x7fdf1e7f]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 s186776 r8192 d116328 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/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/init regInfo=/nix/.ro-store/jq34bbcah7wvk6ld925llnhxlj80pgix-closure-info/registration console=ttyAMA0,115200n8 console=tty074machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/jq34bbcah7wvk6ld925llnhxlj80pgix-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 74963 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 @44ce0000 (indirect, esz 8, psz 64K, shr 1)109machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)110machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000111machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000112machine # [ 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.000032] arm-pv: using stolen time PV118machine # [ 0.000402] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)119machine # [ 0.000567] Console: colour dummy device 80x25120machine # [ 0.000574] printk: legacy console [tty0] enabled121machine # [ 0.000779] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)122machine # [ 0.000786] pid_max: default: 32768 minimum: 301123machine # [ 0.000870] LSM: initializing lsm=capability,landlock,yama,bpf,ima124machine # [ 0.000999] landlock: Up and running.125machine # [ 0.001002] Yama: becoming mindful.126machine # [ 0.001462] LSM support for eBPF active127machine # [ 0.001584] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)128machine # [ 0.001603] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)129machine # [ 0.003462] rcu: Hierarchical SRCU implementation.130machine # [ 0.003468] rcu: Max phase no-delay instances is 1000.131machine # [ 0.004709] fsl-mc MSI: its@8080000 domain created132machine # [ 0.004832] EFI services will not be available.133machine # [ 0.004899] smp: Bringing up secondary CPUs ...134machine # [ 0.004907] smp: Brought up 1 node, 1 CPU135machine # [ 0.004910] SMP: Total of 1 processors activated.136machine # [ 0.004913] CPU: All CPU(s) started at EL1137machine # [ 0.004926] CPU features: detected: Branch Target Identification138machine # [ 0.004930] CPU features: detected: ARMv8.4 Translation Table Level139machine # [ 0.004933] CPU features: detected: Instruction cache invalidation not required for I/D coherence140machine # [ 0.004936] CPU features: detected: Data cache clean to the PoU not required for I/D coherence141machine # [ 0.004940] CPU features: detected: Common not Private translations142machine # [ 0.004943] CPU features: detected: CRC32 instructions143machine # [ 0.004946] CPU features: detected: Data cache clean to Point of Deep Persistence144machine # [ 0.004950] CPU features: detected: Data cache clean to Point of Persistence145machine # [ 0.004952] CPU features: detected: Data independent timing control (DIT)146machine # [ 0.004956] CPU features: detected: E0PD147machine # [ 0.004958] CPU features: detected: Enhanced Counter Virtualization148machine # [ 0.004964] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)149machine # [ 0.004967] CPU features: detected: Enhanced Virtualization Traps150machine # [ 0.004971] CPU features: detected: Fine Grained Traps151machine # [ 0.004974] CPU features: detected: Generic authentication (architected QARMA5 algorithm)152machine # [ 0.004979] CPU features: detected: RCpc load-acquire (LDAPR)153machine # [ 0.004982] CPU features: detected: LSE atomic instructions154machine # [ 0.004985] CPU features: detected: Privileged Access Never155machine # [ 0.004988] CPU features: detected: PMUv3156machine # [ 0.004991] CPU features: detected: RAS Extension Support157machine # [ 0.004994] CPU features: detected: RASv1p1 Extension Support158machine # [ 0.004996] CPU features: detected: Random Number Generator159machine # [ 0.004999] CPU features: detected: Speculation barrier (SB)160machine # [ 0.005002] CPU features: detected: Stage-2 Force Write-Back161machine # [ 0.005004] CPU features: detected: TLB range maintenance instructions162machine # [ 0.005009] CPU features: detected: Speculative Store Bypassing Safe (SSBS)163machine # [ 0.005045] alternatives: applying system-wide alternatives164machine # [ 0.008047] CPU features: detected: BBM Level 2 without TLB conflict abort165machine # [ 0.008280] Memory: 893760K/1048576K available (24448K kernel code, 7094K rwdata, 26592K rodata, 4736K init, 1107K bss, 113556K reserved, 32768K cma-reserved)166machine # [ 0.008638] devtmpfs: initialized167machine # [ 0.010443] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)168machine # [ 0.010466] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).169machine # [ 0.010652] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL170machine # [ 0.010657] 0 pages in range for non-PLT usage171machine # [ 0.010658] 508224 pages in range for PLT usage172machine # [ 0.010774] pinctrl core: initialized pinctrl subsystem173machine # [ 0.011598] DMI not present or invalid.174machine # [ 0.014654] NET: Registered PF_NETLINK/PF_ROUTE protocol family175machine # [ 0.016873] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations176machine # [ 0.017022] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations177machine # [ 0.017184] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations178machine # [ 0.017220] audit: initializing netlink subsys (disabled)179machine # [ 0.017813] thermal_sys: Registered thermal governor 'fair_share'180machine # [ 0.017815] thermal_sys: Registered thermal governor 'bang_bang'181machine # [ 0.017819] thermal_sys: Registered thermal governor 'step_wise'182machine # [ 0.017822] thermal_sys: Registered thermal governor 'user_space'183machine # [ 0.017825] thermal_sys: Registered thermal governor 'power_allocator'184machine # [ 0.017853] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1185machine # [ 0.017861] cpuidle: using governor ladder186machine # [ 0.017867] cpuidle: using governor menu187machine # [ 0.018079] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.188machine # [ 0.018095] ASID allocator initialised with 65536 entries189machine # [ 0.019315] Serial: AMBA PL011 UART driver190machine # [ 0.025147] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1191machine # [ 0.025281] printk: console [ttyAMA0] enabled192machine # [ 0.149958] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages193machine # [ 0.149968] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page194machine # [ 0.149972] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages195machine # [ 0.149974] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page196machine # [ 0.149977] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages197machine # [ 0.149980] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page198machine # [ 0.149983] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages199machine # [ 0.149986] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page200machine # [ 0.151242] fbcon: Taking over console201machine # [ 0.151251] ACPI: Interpreter disabled.202machine # [ 0.152219] iommu: Default domain type: Translated203machine # [ 0.152223] iommu: DMA domain TLB invalidation policy: strict mode204machine # [ 0.152576] SCSI subsystem initialized205machine # [ 0.152767] usbcore: registered new interface driver usbfs206machine # [ 0.152795] usbcore: registered new interface driver hub207machine # [ 0.152811] usbcore: registered new device driver usb208machine # [ 0.170001] pps_core: LinuxPPS API ver. 1 registered209machine # [ 0.170007] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>210machine # [ 0.170016] PTP clock support registered211machine # [ 0.170055] EDAC MC: Ver: 3.0.0212machine # [ 0.170252] scmi_core: SCMI protocol bus registered213machine # [ 0.170633] FPGA manager framework214machine # [ 0.171187] vgaarb: loaded215machine # [ 0.171464] clocksource: Switched to clocksource arch_sys_counter216machine # [ 0.173635] VFS: Disk quotas dquot_6.6.0217machine # [ 0.173659] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)218machine # [ 0.182298] netfs: FS-Cache loaded219machine # [ 0.182425] pnp: PnP ACPI: disabled220machine # [ 0.186569] NET: Registered PF_INET protocol family221machine # [ 0.186716] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)222machine # [ 0.216080] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)223machine # [ 0.216117] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)224machine # [ 0.216138] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)225machine # [ 0.216181] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)226machine # [ 0.216254] TCP: Hash tables configured (established 8192 bind 8192)227machine # [ 0.216341] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)228machine # [ 0.216409] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)229machine # [ 0.216457] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)230machine # [ 0.216558] NET: Registered PF_UNIX/PF_LOCAL protocol family231machine # [ 0.216603] NET: Registered PF_XDP protocol family232machine # [ 0.216620] PCI: CLS 0 bytes, default 64233machine # [ 0.216995] Trying to unpack rootfs image as initramfs...234machine # [ 0.229754] kvm [1]: HYP mode not available235machine # [ 0.336100] Initialise system trusted keyrings236machine # [ 0.336269] workingset: timestamp_bits=42 max_order=18 bucket_order=0237machine # [ 0.336665] squashfs: version 4.0 (2009/01/31) Phillip Lougher238machine # [ 0.336714] 9p: Installing v9fs 9p2000 file system support239machine # [ 0.364751] Key type asymmetric registered240machine # [ 0.364768] Asymmetric key parser 'x509' registered241machine # [ 0.364844] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)242machine # [ 0.364997] io scheduler mq-deadline registered243machine # [ 0.365001] io scheduler kyber registered244machine # [ 0.377369] pl061_gpio 9030000.pl061: PL061 GPIO chip registered245machine # [ 0.377958] ledtrig-cpu: registered to indicate activity on CPUs246machine # [ 0.378320] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:247machine # [ 0.378333] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000248machine # [ 0.378343] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000249machine # [ 0.378348] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000250machine # [ 0.378385] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits251machine # [ 0.378405] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]252machine # [ 0.378482] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00253machine # [ 0.378489] pci_bus 0000:00: root bus resource [bus 00-ff]254machine # [ 0.378493] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]255machine # [ 0.378496] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]256machine # [ 0.378499] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]257machine # [ 0.378566] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint258machine # [ 0.379002] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint259machine # [ 0.379184] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]260machine # [ 0.379195] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]261machine # [ 0.379220] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]262machine # [ 0.379232] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]263machine # [ 0.403824] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint264machine # [ 0.404020] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]265machine # [ 0.404033] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]266machine # [ 0.404058] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]267machine # [ 0.404521] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint268machine # [ 0.404700] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]269machine # [ 0.404711] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]270machine # [ 0.404736] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]271machine # [ 0.405182] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint272machine # [ 0.405382] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]273machine # [ 0.405393] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]274machine # [ 0.405417] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]275machine # [ 0.405429] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]276machine # [ 0.405884] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint277machine # [ 0.406062] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]278machine # [ 0.406087] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]279machine # [ 0.406568] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint280machine # [ 0.406749] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]281machine # [ 0.406773] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]282machine # [ 0.407156] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint283machine # [ 0.407333] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]284machine # [ 0.424728] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint285machine # [ 0.424910] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]286machine # [ 0.424936] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]287machine # [ 0.425408] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint288machine # [ 0.425585] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]289machine # [ 0.425610] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]290machine # [ 0.426057] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint291machine # [ 0.426234] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]292machine # [ 0.426259] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]293machine # [ 0.426711] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint294machine # [ 0.426998] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]295machine # [ 0.427009] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]296machine # [ 0.427034] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]297machine # [ 0.443558] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint298machine # [ 0.443752] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]299machine # [ 0.443765] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]300machine # [ 0.443789] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]301machine # [ 0.444470] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned302machine # [ 0.444476] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned303machine # [ 0.444480] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned304machine # [ 0.444526] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned305machine # [ 0.444572] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned306machine # [ 0.444616] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned307machine # [ 0.444662] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned308machine # [ 0.444711] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned309machine # [ 0.444758] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned310machine # [ 0.444801] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned311machine # [ 0.444843] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned312machine # [ 0.444887] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned313machine # [ 0.444972] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned314machine # [ 0.445072] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned315machine # [ 0.445089] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned316machine # [ 0.445108] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned317machine # [ 0.445124] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned318machine # [ 0.445141] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned319machine # [ 0.445159] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned320machine # [ 0.445176] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned321machine # [ 0.445213] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned322machine # [ 0.445237] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned323machine # [ 0.445255] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned324machine # [ 0.445272] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned325machine # [ 0.445290] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned326machine # [ 0.445307] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned327machine # [ 0.445323] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned328machine # [ 0.445340] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned329machine # [ 0.445356] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned330machine # [ 0.445376] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned331machine # [ 0.445392] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned332machine # [ 0.445417] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]333machine # [ 0.445422] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]334machine # [ 0.445425] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]335machine # [ 0.446247] pci 0000:00:07.0: enabling device (0000 -> 0002)336machine # [ 0.500283] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)337machine # [ 0.502845] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)338machine # [ 0.520985] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)339machine # [ 0.522924] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)340machine # [ 0.526738] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)341machine # [ 0.530153] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)342machine # [ 0.540566] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)343machine # [ 0.542697] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)344machine # [ 0.546226] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)345machine # [ 0.556068] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)346machine # [ 0.558629] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)347machine # [ 0.572806] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled348machine # [ 0.574777] msm_serial: driver initialized349machine # [ 0.574924] SuperH (H)SCI(F) driver initialized350machine # [ 0.574981] STM32 USART driver initialized351machine # [ 0.613076] loop: module loaded352machine # [ 0.613314] virtio_blk virtio2: 1/0/0 default/read/poll queues353machine # [ 0.614188] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)354machine # [ 0.624256] megasas: 07.734.00.00-rc1355machine # [ 0.625024] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]356machine # [ 0.630077] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000357machine # [ 0.630098] Intel/Sharp Extended Query Table at 0x0031358machine # [ 0.633860] Using buffer write method359machine # [ 0.633904] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]360machine # [ 0.643530] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000361machine # [ 0.643558] Intel/Sharp Extended Query Table at 0x0031362machine # [ 0.645893] Using buffer write method363machine # [ 0.645918] Concatenating MTD devices:364machine # [ 0.645921] (0): "0.flash"365machine # [ 0.645924] (1): "0.flash"366machine # [ 0.645926] into device "0.flash"367machine # [ 0.934888] Freeing initrd memory: 26444K368machine # [ 0.941409] tun: Universal TUN/TAP device driver, 1.6369machine # [ 0.945543] thunder_xcv, ver 1.0370machine # [ 0.945576] thunder_bgx, ver 1.0371machine # [ 0.945594] nicpf, ver 1.0372machine # [ 0.946166] e1000: Intel(R) PRO/1000 Network Driver373machine # [ 0.946171] e1000: Copyright (c) 1999-2006 Intel Corporation.374machine # [ 0.946197] e1000e: Intel(R) PRO/1000 Network Driver375machine # [ 0.946206] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.376machine # [ 0.946236] igb: Intel(R) Gigabit Ethernet Network Driver377machine # [ 0.946239] igb: Copyright (c) 2007-2014 Intel Corporation.378machine # [ 0.946259] igbvf: Intel(R) Gigabit Virtual Function Network Driver379machine # [ 0.946262] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.380machine # [ 0.946396] sky2: driver version 1.30381machine # [ 0.956259] ehci-pci 0000:00:07.0: EHCI Host Controller382machine # [ 0.956284] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1383machine # [ 0.956503] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000384machine # [ 0.956584] usbcore: registered new interface driver usb-storage385machine # [ 0.956644] usbcore: registered new interface driver usbserial_generic386machine # [ 0.956657] usbserial: USB Serial support registered for generic387machine # [ 0.957523] hv_vmbus: registering driver hyperv_keyboard388machine # [ 0.958452] rtc-pl031 9010000.pl031: registered as rtc0389machine # [ 0.958475] rtc-pl031 9010000.pl031: setting system clock to 2026-09-25T03:04:22 UTC (1790305462)390machine # [ 0.958790] i2c_dev: i2c /dev entries driver391machine # [ 0.969727] sdhci: Secure Digital Host Controller Interface driver392machine # [ 0.969736] sdhci: Copyright(c) Pierre Ossman393machine # [ 0.970019] Synopsys Designware Multimedia Card Interface Driver394machine # [ 0.970405] sdhci-pltfm: SDHCI platform and OF driver helper395machine # [ 0.971633] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00396machine # [ 0.971997] hub 1-0:1.0: USB hub found397machine # [ 0.972014] hub 1-0:1.0: 6 ports detected398machine # [ 0.977810] hid: raw HID events driver (C) Jiri Kosina399machine # [ 0.978082] usbcore: registered new interface driver usbhid400machine # [ 0.978094] usbhid: USB HID core driver401machine # [ 0.979292] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available402machine # [ 0.980966] drop_monitor: Initializing network drop monitor service403machine # [ 0.981118] NET: Registered PF_INET6 protocol family404machine # [ 0.986214] Segment Routing with IPv6405machine # [ 0.986232] In-situ OAM (IOAM) with IPv6406machine # [ 0.986269] NET: Registered PF_PACKET protocol family407machine # [ 0.986329] 9pnet: Installing 9P2000 support408machine # [ 0.986371] Key type dns_resolver registered409machine # [ 0.995264] registered taskstats version 1410machine # [ 0.995439] Loading compiled-in X.509 certificates411machine # [ 1.004439] Demotion targets for Node 0: null412machine # [ 1.004558] Key type .fscrypt registered413machine # [ 1.004568] Key type fscrypt-provisioning registered414machine # [ 1.004665] ima: No TPM chip found, activating TPM-bypass!415machine # [ 1.004683] ima: Allocated hash algorithm: sha1416machine # [ 1.004706] ima: No architecture policies found417machine # [ 1.005482] input: gpio-keys as /devices/platform/gpio-keys/input/input0418machine # [ 1.028027] clk: Disabling unused clocks419machine # [ 1.028047] PM: genpd: Disabling unused power domains420machine # [ 1.031146] Freeing unused kernel memory: 4736K421machine # [ 1.031352] Run /init as init process422machine # [ 1.050031] systemd[1]: Successfully made /usr/ read-only.423machine # [ 1.219610] usb 1-1: new high-speed USB device number 2 using ehci-pci424machine # [ 1.372131] 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.383965] systemd[1]: systemd 263-f8dae4b 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.384010] systemd[1]: Detected virtualization qemu.427machine # [ 1.384152] systemd[1]: Detected architecture arm64.428machine # [ 1.384168] systemd[1]: Running in initrd.429machine # [ 1.385215] systemd[1]: Initializing machine ID from random generator.430machine # [ 1.385607] systemd[1]: Hostname set to <machine>.431machine # [ 1.467710] 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.518842] systemd[1]: bpf-restrict-fs: LSM BPF program attached433machine # [ 1.573746] systemd[1]: Queued start job for default target Initrd Default Target.434machine # [ 1.578585] systemd[1]: Created slice Slice /system/modprobe.435machine # [ 1.578766] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.436machine # [ 1.578791] systemd[1]: Expecting device /dev/disk/by-label/nixos...437machine # [ 1.578810] systemd[1]: Reached target Path Units.438machine # [ 1.578822] systemd[1]: Reached target Slice Units.439machine # [ 1.578835] systemd[1]: Reached target Swaps.440machine # [ 1.578847] systemd[1]: Reached target Timer Units.441machine # [ 1.578974] systemd[1]: Listening on D-Bus System Message Bus Socket.442machine # [ 1.579117] systemd[1]: Listening on Journal Socket (/dev/log).443machine # [ 1.579254] systemd[1]: Listening on Journal Sockets.444machine # [ 1.579325] systemd[1]: Listening on udev Kernel Socket.445machine # [ 1.579338] systemd[1]: Reached target Socket Units.446machine # [ 1.587696] usb 1-2: new high-speed USB device number 3 using ehci-pci447machine # [ 1.589379] systemd[1]: Starting Create List of Static Device Nodes...448machine # [ 1.589448] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs449machine # [ 1.595670] systemd[1]: Mounting Kernel Configuration File System...450machine # [ 1.607636] systemd[1]: Starting Journal Service...451machine # [ 1.627619] systemd[1]: Starting Load Kernel Modules...452machine # [ 1.627734] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os453machine # [ 1.650768] systemd[1]: Starting Coldplug All udev Devices...454machine # [ 1.653421] systemd-journald[71]: Collecting audit messages is disabled.455machine # [ 1.659750] systemd[1]: Finished Create List of Static Device Nodes.456machine # [ 1.660487] systemd[1]: Mounted Kernel Configuration File System.457machine # [ 1.675926] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...458machine # [ 1.733468] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.459machine # [ 1.736547] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.460machine # [ 1.743990] systemd[1]: Starting Create Static Device Nodes in /dev...461machine # [ 1.753988] 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/input2462machine # [ 1.754126] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0463machine # [ 1.759526] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev464machine # [ 1.778187] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0465machine # [ 1.778425] [drm] features: -virgl +edid -resource_blob -host_visible466machine # [ 1.778429] [drm] features: -context_init467machine # [ 1.779183] [drm] number of scanouts: 1468machine # [ 1.779194] [drm] number of cap sets: 0469machine # [ 1.795896] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic470machine # [ 1.795923] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0471machine # [ 1.811640] systemd[1]: Finished Create Static Device Nodes in /dev.472machine # [ 1.812064] systemd[1]: Reached target Preparation for Local File Systems.473machine # [ 1.812088] systemd[1]: Reached target Local File Systems.474machine # [ 1.821152] systemd[1]: Starting Rule-based Manager for Device Events and Files...475machine # [ 1.831818] Console: switching to colour frame buffer device 160x50476machine # [ 1.839163] systemd-modules-load[73]: Inserted module 'dm_mod'477machine # [ 1.851791] systemd[1]: Started Journal Service.478machine # [ 1.840999] systemd-modules-load[73]: Module 'virtio_balloon' is built in479machine # [ 1.842183] systemd-modules-load[73]: Module 'virtio_console' is built in480machine # [ 1.864365] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device481machine # [ 1.861633] systemd-modules-load[73]: Inserted module 'virtio_gpu'482machine # [ 1.862744] systemd-modules-load[73]: Module 'virtio_rng' is built in483machine # [ 1.864069] systemd[1]: Starting Create System Files and Directories...484machine # [ 1.871033] systemd[1]: Finished Load Kernel Modules.485machine # [ 1.908944] systemd[1]: Starting Apply Kernel Variables...486machine # [ 1.929285] systemd[1]: Finished Create System Files and Directories.487machine # [ 1.937176] systemd-udevd[78]: Using default interface naming scheme 'v261'.488machine # [ 1.947745] systemd[1]: Finished Apply Kernel Variables.489machine # [ 1.972937] systemd[1]: Started Rule-based Manager for Device Events and Files.490machine # [ 2.060141] systemd[1]: Starting Virtual Console Setup...491machine # [ 2.132612] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones.492machine # [ 2.136375] systemd[1]: Finished Virtual Console Setup.493machine # [ 2.748464] systemd[1]: Finished Coldplug All udev Devices.494machine # [ 2.752163] systemd[1]: Reached target System Initialization.495machine # [ 2.753066] systemd[1]: Reached target Basic System.496machine # [ 2.935204] (udev-worker)[91]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.497machine # [ 2.942601] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line.498machine # [ 3.016608] systemd[1]: Found device /dev/disk/by-label/nixos.499machine # [ 3.023121] systemd[1]: Reached target Initrd Root Device.500machine # [ 3.028474] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...501machine # [ 3.082732] systemd-fsck[109]: nixos: clean, 12/65536 files, 13019/262144 blocks502machine # [ 3.099587] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.503machine # [ 3.104194] systemd[1]: Mounting /sysroot...504machine # [ 3.179014] EXT4-fs (vda): mounted filesystem 14b8fb82-e745-4320-b3ba-f5c205811327 r/w with ordered data mode. Quota mode: none.505machine # [ 3.171431] systemd[1]: Mounted /sysroot.506machine # [ 3.172657] systemd[1]: Reached target Initrd Root File System.507machine # [ 3.176485] systemd[1]: Starting Mountpoints Configured in the Real Root...508machine # [ 3.209012] systemd-sysroot-fstab-check[117]: /sysroot should be mounted in the initrd, will request daemon-reload.509machine # [ 3.213146] systemd[1]: Reload requested from client PID 117 ('systemd-sysroot') (unit initrd-parse-etc.service)...510machine # [ 3.217292] systemd[1]: Reloading...511machine # [ 3.417857] systemd[1]: Reloading finished in 202 ms.512machine # [ 3.453091] systemd-sysroot-fstab-check[117]: Requesting initrd-fs.target/start/replace...513machine # [ 3.457697] systemd-sysroot-fstab-check[117]: Requesting swap.target/start/replace...514machine # [ 3.462476] systemd[1]: initrd-parse-etc.service: Deactivated successfully.515machine # [ 3.466088] systemd[1]: Finished Mountpoints Configured in the Real Root.516machine # [ 3.468499] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.517machine # [ 3.642481] systemd[1]: Mounting /sysroot/nix/.ro-store...518machine # [ 3.659995] systemd[1]: Mounting /sysroot/nix/.rw-store...519machine # [ 3.669364] systemd[1]: Mounting /sysroot/run...520machine # [ 3.699502] systemd[1]: Mounting /sysroot/tmp/shared...521machine # [ 3.728842] systemd[1]: Mounting /sysroot/tmp/xchg...522machine # [ 3.751359] systemd[1]: Mounted /sysroot/nix/.rw-store.523machine # [ 3.792158] fuse: init (API version 7.45)524machine # [ 3.803633] virtiofs virtio6: discovered new tag: nix-store525machine # [ 3.804469] virtiofs virtio6: virtio_fs_setup_dax: No cache capability526machine # [ 3.797059] systemd[1]: Starting rw-sysroot-nix-store.service...527machine # [ 3.801365] systemd[1]: Mounted /sysroot/run.528machine # [ 3.821342] virtiofs virtio7: discovered new tag: shared529machine # [ 3.822141] virtiofs virtio7: virtio_fs_setup_dax: No cache capability530machine # [ 3.833213] virtiofs virtio8: discovered new tag: xchg531machine # [ 3.834002] virtiofs virtio8: virtio_fs_setup_dax: No cache capability532machine # [ 3.846208] systemd[1]: Mounted /sysroot/nix/.ro-store.533machine # [ 3.852117] systemd[1]: Mounted /sysroot/tmp/shared.534machine # [ 3.855929] systemd[1]: Mounted /sysroot/tmp/xchg.535machine # [ 3.875889] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.536machine # [ 3.877620] systemd[1]: Finished rw-sysroot-nix-store.service.537machine # [ 4.405105] (udev-worker)[96]: mtd0ro: Failed to find and pin callout binary "/nix/store/in96z2h242rj6x8kvabxm4x1jfd5ivfx-systemd-263-f8dae4b/lib/udev/mtd_probe": No such file or directory538machine # [ 4.413027] (udev-worker)[96]: mtd0ro: /etc/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory539machine # [ 4.450326] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.540machine # [ 4.451945] systemd[1]: Stopped Virtual Console Setup.541machine # [ 4.456330] systemd[1]: Stopping Virtual Console Setup...542machine # [ 4.457193] systemd[1]: Starting Virtual Console Setup...543machine # [ 4.472855] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.544machine # [ 4.475595] systemd[1]: Stopped Virtual Console Setup.545machine # [ 4.476975] systemd[1]: Starting Virtual Console Setup...546machine # [ 4.500795] systemd-vconsole-setup[152]: Configuration of first virtual console was skipped, ignoring remaining ones.547machine # [ 4.503988] systemd[1]: Finished Virtual Console Setup.548machine # [ 4.640949] systemd[1]: Mounting /sysroot/nix/store...549machine # [ 4.694345] systemd[1]: Mounted /sysroot/nix/store.550machine # [ 4.695751] systemd[1]: Reached target Initrd File Systems.551machine # [ 4.700213] systemd[1]: Starting Find NixOS closure...552machine # [ 4.704948] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...553machine # [ 4.744138] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.554machine # [ 4.747227] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.555machine # [ 4.759467] systemd[1]: Finished Find NixOS closure.556machine # [ 4.760642] systemd[1]: Reached target Initrd Default Target.557machine # [ 4.764254] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...558machine # [ 4.790401] systemd[1]: Stopped target Initrd Default Target.559machine # [ 4.792564] systemd[1]: Stopped target Basic System.560machine # [ 4.794420] systemd[1]: Stopped target Initrd Root Device.561machine # [ 4.796745] systemd[1]: Stopped target Path Units.562machine # [ 4.799408] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.563machine # [ 4.801775] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.564machine # [ 4.808181] systemd[1]: Stopped target Slice Units.565machine # [ 4.809155] systemd[1]: Stopped target Socket Units.566machine # [ 4.810011] systemd[1]: Stopped target System Initialization.567machine # [ 4.810953] systemd[1]: Stopped target Swaps.568machine # [ 4.811698] systemd[1]: Stopped target Timer Units.569machine # [ 4.814974] systemd[1]: dbus.socket: Deactivated successfully.570machine # [ 4.819879] systemd[1]: Closed D-Bus System Message Bus Socket.571machine # [ 4.823869] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.572machine # [ 4.827361] systemd[1]: Stopped Find NixOS closure.573machine # [ 4.831894] systemd[1]: Starting rw-sysroot-nix-store.service...574machine # [ 4.833252] systemd[1]: systemd-sysctl.service: Deactivated successfully.575machine # [ 4.834229] systemd[1]: Stopped Apply Kernel Variables.576machine # [ 4.834978] systemd[1]: systemd-modules-load.service: Deactivated successfully.577machine # [ 4.836002] systemd[1]: Stopped Load Kernel Modules.578machine # [ 4.844795] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.579machine # [ 4.848889] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.580machine # [ 4.853792] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.581machine # [ 4.855555] systemd[1]: Stopped Create System Files and Directories.582machine # [ 4.858504] systemd[1]: Stopped target Local File Systems.583machine # [ 4.860300] systemd[1]: Stopped target Preparation for Local File Systems.584machine # [ 4.864220] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.585machine # [ 4.865344] systemd[1]: Stopped Coldplug All udev Devices.586machine # [ 4.866165] systemd[1]: Stopping Rule-based Manager for Device Events and Files...587machine # [ 4.867917] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.588machine # [ 4.870602] systemd[1]: Stopped Virtual Console Setup.589machine # [ 4.871391] systemd[1]: initrd-cleanup.service: Deactivated successfully.590machine # [ 4.872392] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.591machine # [ 4.873310] systemd[1]: systemd-udevd.service: Deactivated successfully.592machine # [ 4.874286] systemd[1]: Stopped Rule-based Manager for Device Events and Files.593machine # [ 4.875277] systemd[1]: systemd-udevd.service: Consumed 1.568s CPU time over 3.041s wall clock time, 22.2M memory peak.594machine # [ 4.880305] systemd[1]: Starting Cleanup udev Database...595machine # [ 4.882457] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.596machine # [ 4.884838] systemd[1]: Stopped Create Static Device Nodes in /dev.597machine # [ 4.888229] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.598machine # [ 4.889463] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.599machine # [ 4.892201] systemd[1]: kmod-static-nodes.service: Deactivated successfully.600machine # [ 4.896122] systemd[1]: Stopped Create List of Static Device Nodes.601machine # [ 4.897050] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.602machine # [ 4.898358] systemd[1]: Finished rw-sysroot-nix-store.service.603machine # [ 4.926749] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.604machine # [ 4.930147] systemd[1]: Finished Cleanup udev Database.605machine # [ 4.930980] systemd[1]: Reached target Switch Root.606machine # [ 4.932217] systemd[1]: Starting NixOS Activation...607machine # [ 5.020798] initrd-nixos-activation-start[175]: booting system configuration /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test608machine # [ 5.055473] initrd-nixos-activation-start[175]: running activation script...609machine # [ 5.290354] initrd-nixos-activation-start[198]: setting up /etc...610machine # [ 5.411022] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.611machine # [ 5.413977] systemd[1]: Finished NixOS Activation.612machine # [ 5.415176] systemd[1]: Starting Switch Root...613machine # [ 5.439766] systemd[1]: Switching root.614machine # [ 5.626166] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).615machine # [ 6.124026] systemd[1]: systemd 263-f8dae4b 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)616machine # [ 6.124166] systemd[1]: Detected virtualization qemu.617machine # [ 6.124279] systemd[1]: Detected architecture arm64.618machine # [ 6.124489] systemd[1]: Detected first boot.619machine # [ 6.145368] systemd[1]: Initializing machine ID from random generator.620machine # [ 6.316856] systemd[1]: bpf-restrict-fs: LSM BPF program attached621machine # [ 6.471763] systemd[1]: Applying preset policy.622machine # [ 6.693810] systemd[1]: Populated /etc with preset unit settings.623machine # [ 6.910197] systemd[1]: initrd-switch-root.service: Deactivated successfully.624machine # [ 6.910622] systemd[1]: Stopped initrd-switch-root.service.625machine # [ 6.915146] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.626machine # [ 6.918562] systemd[1]: Created slice Slice /system/getty.627machine # [ 6.921056] systemd[1]: Created slice User and Session Slice.628machine # [ 6.921673] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.629machine # [ 6.922532] systemd[1]: Started Forward Password Requests to Wall Directory Watch.630machine # [ 6.923279] systemd[1]: Expecting device /dev/hvc0...631machine # [ 6.928278] systemd[1]: Expecting device /dev/ttyAMA0...632machine # [ 6.928753] systemd[1]: Reached target Local Encrypted Volumes.633machine # [ 6.929655] systemd[1]: Stopped target initrd-fs.target.634machine # [ 6.930457] systemd[1]: Stopped target initrd-root-fs.target.635machine # [ 6.931284] systemd[1]: Stopped target initrd-switch-root.target.636machine # [ 6.936642] systemd[1]: Reached target Virtual Machines and Containers.637machine # [ 6.937000] systemd[1]: Reached target Path Units.638machine # [ 6.937279] systemd[1]: Reached target Remote File Systems.639machine # [ 6.937539] systemd[1]: Reached target Slice Units.640machine # [ 6.937792] systemd[1]: Reached target Swaps.641machine # [ 6.943008] systemd[1]: Listening on Query the User Interactively for a Password.642machine # [ 6.946355] systemd[1]: Listening on Process Core Dump Socket.643machine # [ 6.948998] systemd[1]: Listening on Credential Encryption/Decryption.644machine # [ 6.950515] systemd[1]: Listening on Factory Reset Management.645machine # [ 6.951130] systemd[1]: Listening on Hostname Service Socket.646machine # [ 6.957918] systemd[1]: Starting Journal Log Access Socket...647machine # [ 6.960438] systemd[1]: Listening on Journal Audit Socket.648machine # [ 6.962668] systemd[1]: Listening on Console Output Muting Service Socket.649machine # [ 6.965959] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.650machine # [ 6.967349] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os651machine # [ 6.971367] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki652machine # [ 6.977872] systemd[1]: Listening on Disk Repartitioning Service Socket.653machine # [ 6.978616] systemd[1]: Listening on udev Varlink Socket.654machine # [ 6.984112] systemd[1]: Mounting Huge Pages File System...655machine # [ 6.987055] systemd[1]: Mounting POSIX Message Queue File System...656machine # [ 6.999888] systemd[1]: Mounting Kernel Debug File System...657machine # [ 7.016145] systemd[1]: Mounting Kernel Trace File System...658machine # [ 7.028389] systemd[1]: Starting Create List of Static Device Nodes...659machine # [ 7.035822] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs660machine # [ 7.051756] systemd[1]: Mounting Kernel Configuration File System...661machine # [ 7.052436] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm662machine # [ 7.060229] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore663machine # [ 7.068191] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse664machine # [ 7.100294] systemd[1]: Mounting FUSE Control File System...665machine # [ 7.100775] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67666machine # [ 7.132465] systemd[1]: Starting Journal Service...667machine # [ 7.151290] systemd[1]: Starting Load Kernel Modules...668machine # [ 7.180424] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...669machine # [ 7.201600] systemd[1]: Starting Remount Root and Kernel File Systems...670machine # [ 7.202058] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os671machine # [ 7.214371] systemd[1]: Starting Coldplug All udev Devices...672machine # [ 7.218571] systemd[1]: Listening on Journal Log Access Socket.673machine # [ 7.219037] systemd[1]: Mounted Huge Pages File System.674machine # [ 7.219444] systemd[1]: Mounted POSIX Message Queue File System.675machine # [ 7.231240] systemd[1]: Mounted Kernel Debug File System.676machine # [ 7.242457] systemd[1]: Mounted Kernel Trace File System.677machine # [ 7.247763] systemd[1]: Finished Create List of Static Device Nodes.678machine # [ 7.248409] systemd[1]: Mounted Kernel Configuration File System.679machine # [ 7.255831] systemd-journald[269]: Collecting audit messages is enabled.680machine # [ 7.262870] systemd[1]: Queued start job for default target Multi-User System.681machine # [ 7.264344] systemd[1]: systemd-journald.service: Deactivated successfully.682machine # [ 7.283974] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...683machine # [ 7.285365] systemd[1]: Started Journal Service.684machine # [ 7.277219] systemd-modules-load[270]: Module 'atkbd' is built in685machine # [ 7.278248] systemd-modules-load[270]: Module 'loop' is built in686machine # [ 7.301648] systemd[1]: Mounted FUSE Control File System.687machine # [ 7.303667] systemd[1]: Finished Load Kernel Modules.688machine # [ 7.343408] systemd[1]: Starting Firewall...[ 7.355751] EXT4-fs (vda): re-mounted 14b8fb82-e745-4320-b3ba-f5c205811327.689machine # 690machine # [ 7.349331] systemd-oomd[271]: No swap; memory pressure usage will be degraded691machine # [ 7.357906] systemd[1]: Starting Apply Kernel Variables...692machine # [ 7.362245] systemd[1]: Finished Remount Root and Kernel File Systems.693machine # [ 7.363272] systemd[1]: Listening on Disk Image Download Service Socket.694machine # [ 7.373485] systemd[1]: Starting Flush Journal to Persistent Storage...695machine # [ 7.374710] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore696machine # [ 7.397235] systemd[1]: Starting Load/Save OS Random Seed...697machine # [ 7.398207] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os698machine # [ 7.399415] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.699machine # [ 7.519168] systemd-journald[269]: Received client request to flush runtime journal.700machine # [ 7.576666] systemd[1]: Finished Load/Save OS Random Seed.701machine # [ 7.577623] systemd[1]: Reached target First Boot Complete.702machine # [ 7.578462] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.703machine # [ 7.579453] systemd[1]: Starting Create Static Device Nodes in /dev...704machine # [ 7.586266] systemd[1]: Finished Apply Kernel Variables.705machine # [ 7.593337] systemd[1]: Finished Flush Journal to Persistent Storage.706machine # [ 7.834554] systemd[1]: Finished Create Static Device Nodes in /dev.707machine # [ 7.835638] systemd[1]: Reached target Preparation for Local File Systems.708machine # [ 7.841478] systemd[1]: Starting Rule-based Manager for Device Events and Files...709machine # [ 7.904916] systemd[1]: Mounting /run/wrappers...710machine # [ 7.984818] systemd[1]: Mounted /run/wrappers.711machine # [ 7.985727] systemd[1]: Reached target Local File Systems.712machine # [ 7.991210] systemd[1]: Listening on Boot Loader Control Service Socket.713machine # [ 8.002485] systemd[1]: Starting Create SUID/SGID Wrappers...714machine # [ 8.003438] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.715machine # [ 8.007584] systemd[1]: Starting Save Transient machine-id to Disk...716machine # [ 8.012630] systemd[1]: Starting Create System Files and Directories...717machine # [ 8.032052] systemd-udevd[304]: Using default interface naming scheme 'v261'.718machine # [ 8.208301] systemd[1]: Started Rule-based Manager for Device Events and Files.719machine # [ 8.249159] systemd[1]: Finished Create System Files and Directories.720machine # [ 8.267835] systemd[1]: Starting Rebuild Journal Catalog...721machine # [ 8.272776] systemd[1]: Starting Record System Boot/Shutdown in UTMP...722machine # [ 8.273816] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.723machine # [ 8.282440] systemd[1]: Finished Save Transient machine-id to Disk.724machine # [ 8.418631] systemd[1]: Finished Record System Boot/Shutdown in UTMP.725machine # [ 8.455494] systemd[1]: Finished Rebuild Journal Catalog.726machine # [ 8.468873] systemd[1]: Starting Update is Completed...727machine # [ 8.585508] systemd[1]: Finished Update is Completed.728machine # [ 8.817695] systemd[1]: Finished Coldplug All udev Devices.729machine # [ 8.887856] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs730machine # [ 8.920154] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse731machine # [ 9.025888] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.732machine # [ 9.029628] systemd[1]: Finished Create SUID/SGID Wrappers.733machine # [ 9.035041] systemd[1]: Reached target System Initialization.734machine # [ 9.037288] systemd[1]: Started Discard unused filesystem blocks once a week.735machine # [ 9.041492] systemd[1]: Started Daily Cleanup of Temporary Directories.736machine # [ 9.042591] systemd[1]: Reached target Timer Units.737machine # [ 9.043327] systemd[1]: Listening on D-Bus System Message Bus Socket.738machine # [ 9.052323] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.739machine # [ 9.057170] systemd[1]: Reached target Socket Units.740machine # [ 9.057992] systemd[1]: Reached target Basic System.741machine # [ 9.058727] systemd[1]: Starting Import lastlog data into lastlog2 database...742machine # [ 9.059731] systemd[1]: Starting Name Service Cache Daemon (nsncd)...743machine # [ 9.070482] systemd[1]: Starting Post-Boot Actions...744machine # [ 9.077630] systemd[1]: Started Reset console on configuration changes.745machine # [ 9.115524] systemd[1]: Starting resolvconf update...746machine # [ 9.165043] systemd[1]: Starting D-Bus System Message Bus...747machine # [ 9.244151] systemd[1]: Started Name Service Cache Daemon (nsncd).748machine # [ 9.245706] nsncd[423]: Sep 25 03:04:30.800 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"749machine # [ 9.265406] systemd[1]: Finished Post-Boot Actions.750machine # [ 9.296600] systemd[1]: Reached target Host and Network Name Lookups.751machine # [ 9.305790] systemd[1]: Reached target User and Group Name Lookups.752machine # [ 9.328289] systemd[1]: Starting User Login Management...753machine # [ 9.329239] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.754machine # [ 9.355630] systemd[1]: Finished Import lastlog data into lastlog2 database.755machine # [ 9.397570] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.756machine # [ 9.410922] systemd[1]: Started backdoor.service.757machine # [ 9.421730] dbus-broker-launch[430]: Looking up NSS user entry for 'systemd-timesync'...758machine # [ 9.439454] dbus-broker-launch[430]: NSS returned no entry for 'systemd-timesync'759machine # [ 9.448344] dbus-broker-launch[430]: Invalid user-name in /nix/store/8srfshgrm5f1phyn1d9c41jm2d9gcbp8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"760machine # [ 9.503090] systemd[1]: Started D-Bus System Message Bus.761machine # [ 9.566684] dbus-broker-launch[430]: Ready762machine # connecting to host...763machine # [ 9.608258] systemd-logind[452]: New seat seat0.764machine # [ 9.617449] systemd[1]: Started User Login Management.765machine # [ 9.630738] systemd[1]: Starting linger-users.service...766machine: Guest shell says: b'Spawning backdoor root shell...\n'767machine: connected to guest root shell768machine: (connecting took 9.97 seconds)769machine: (finished: waiting for the VM to finish booting, in 10.50 seconds)770machine # [ 9.677164] systemd[1]: Stopped target Host and Network Name Lookups.771machine # [ 9.678287] systemd[1]: Stopping Host and Network Name Lookups...772machine # [ 9.679171] systemd[1]: Stopped target User and Group Name Lookups.773machine # [ 9.694359] systemd[1]: Stopping User and Group Name Lookups...774machine # [ 9.695298] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...775machine # [ 9.705388] systemd[1]: nscd.service: Deactivated successfully.776machine # [ 9.706387] systemd[1]: Stopped Name Service Cache Daemon (nsncd).777machine # [ 9.736168] systemd[1]: Starting Name Service Cache Daemon (nsncd)...778machine # [ 9.767642] (udev-worker)[339]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.779machine # [ 9.785382] (udev-worker)[339]: Network interface NamePolicy= disabled on kernel command line.780machine # [ 9.859569] nsncd[520]: Sep 25 03:04:31.415 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"781machine # [ 9.908713] systemd[1]: Started Name Service Cache Daemon (nsncd).782machine # [ 9.939536] systemd[1]: linger-users.service: Deactivated successfully.783machine # [ 9.944667] systemd[1]: Finished linger-users.service.784machine # [ 9.984198] systemd[1]: Created slice Slice /user/1001.785machine # [ 9.985150] systemd[1]: Reached target Host and Network Name Lookups.786machine # [ 9.986086] systemd[1]: Reached target User and Group Name Lookups.787machine # [ 9.986935] systemd[1]: Starting User Runtime Directory /run/user/1001...788machine # [ 10.065788] systemd[1]: Finished resolvconf update.789machine # [ 10.066768] systemd[1]: Starting DHCP Client...790machine # [ 10.107609] systemd[1]: Condition check resulted in Virtio network device being skipped.791machine # [ 10.196780] systemd-logind[452]: Watching system buttons on /dev/input/event0 (gpio-keys)792machine # [ 10.237616] systemd[1]: Finished User Runtime Directory /run/user/1001.793machine # [ 10.238747] systemd[1]: Starting User Manager for UID 1001...794machine # [ 10.333407] (systemd)[573]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0)795machine # [ 10.367981] systemd-logind[452]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'.796machine # [ 10.411444] mousedev: PS/2 mouse device common for all mice797machine # [ 10.427252] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy798machine # [ 10.703920] systemd-logind[452]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)799machine # [ 10.740633] systemd[573]: Queued start job for default target Main User Target.800machine # [ 10.780160] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy801machine # [ 10.781845] systemd[573]: Created slice User Application Slice.802machine # [ 10.782680] systemd[573]: Started Daily Cleanup of User's Temporary Directories.803machine # [ 10.783724] systemd[573]: Reached target Paths.804machine # [ 10.874617] systemd[573]: Reached target Timers.805machine # [ 10.875435] systemd[573]: Starting D-Bus User Message Bus Socket...806machine # [ 10.919836] systemd[573]: Starting Create User Files and Directories...807machine # [ 10.942502] systemd[573]: Finished Create User Files and Directories.808machine # [ 10.962582] systemd[573]: Listening on D-Bus User Message Bus Socket.809machine # [ 10.963694] systemd[573]: Reached target Sockets.810machine # [ 10.989068] systemd[573]: Reached target Basic System.811machine # [ 10.990179] systemd[1]: Started User Manager for UID 1001.812machine # [ 10.991033] systemd[573]: Starting Run user-specific NixOS activation...813machine # [ 10.991980] systemd[573]: Finished Run user-specific NixOS activation.814machine # [ 11.011355] systemd[573]: Reached target Main User Target.815machine # [ 11.018467] systemd[573]: Startup finished in 512ms.816machine # [ 11.081879] dhcpcd[587]: dhcpcd-10.3.2 starting817machine # [ 11.092514] systemd[1]: Finished Firewall.818machine # [ 11.093277] systemd[1]: Reached target Preparation for Network.819machine # [ 11.096488] systemd[1]: Starting Address configuration of eth1...820machine # [ 11.099724] systemd[1]: Starting Extra networking commands....821machine # [ 11.106531] dhcpcd[609]: dev: loaded udev822machine # [ 11.189852] 8021q: 802.1Q VLAN Support v1.8823machine # [ 11.297708] cfg80211: Loading compiled-in X.509 certificates for regulatory database824machine # [ 11.402120] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'825machine # [ 11.402639] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'826machine # [ 11.406010] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2827machine # [ 11.406330] cfg80211: failed to load regulatory.db828machine # [ 11.669665] 8021q: adding VLAN 0 to HW filter on device eth1829machine # [ 11.765693] dhcpcd[638]: /nix/store/1ki7bgdr0niilkg9jbkpcdaggbv0kb8a-openresolv-3.17.4/sbin/.resolvconf-wrapped: line 1250: kill: (635) - Operation not permitted830machine # [ 11.767686] dhcpcd[638]: .resolvconf-wrapped: clearing stale lock pid 635831machine # [ 11.792548] network-addresses-eth1-start[611]: adding address 192.168.1.1/24... done832machine # [ 11.864157] network-addresses-eth1-start[611]: adding address 2001:db8:1::1/64... done833machine # [ 11.937403] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3834machine # [ 12.010818] systemd[1]: Finished Address configuration of eth1.835machine # [ 12.129862] 8021q: adding VLAN 0 to HW filter on device eth0836machine # [ 12.125091] dhcpcd[609]: eth0: waiting for carrier837machine # [ 12.125945] dhcpcd[609]: eth0: carrier acquired838machine # [ 12.197936] dhcpcd[609]: DUID 00:01:00:01:32:48:a1:41:52:54:00:12:34:56839machine # [ 12.198994] dhcpcd[609]: eth0: IAID 00:12:34:56840machine # [ 12.199676] dhcpcd[609]: eth0: adding address fe80::5054:ff:fe12:3456841machine # [ 12.334126] systemd[1]: Starting Virtual Console Setup...842machine # [ 12.335079] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.843machine # [ 12.392758] systemd-logind[452]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)844machine # [ 12.421426] systemd[1]: Finished Extra networking commands..845machine # [ 12.423756] systemd[1]: Reached target Network.846machine # [ 12.427879] systemd[1]: Starting Permit User Sessions...847machine # [ 12.466509] systemd[1]: Finished Permit User Sessions.848machine # [ 12.477588] systemd[1]: Started Getty on tty1.849machine # [ 12.478460] systemd[1]: Reached target Login Prompts.850machine # [ 12.538395] systemd-vconsole-setup[693]: Configuration of first virtual console was skipped, ignoring remaining ones.851machine # [ 12.542101] systemd[1]: Finished Virtual Console Setup.852machine # [ 13.793920] dhcpcd[609]: eth0: soliciting a DHCP lease853machine # [ 13.796801] dhcpcd[609]: eth0: offered 10.0.2.15 from 10.0.2.2854machine # [ 13.804366] dhcpcd[609]: eth0: probing address 10.0.2.15/24855machine # [ 14.457684] dhcpcd[609]: eth0: soliciting an IPv6 router856machine # [ 14.461418] dhcpcd[609]: eth0: Router Advertisement from fe80::2857machine # [ 14.464308] dhcpcd[609]: eth0: adding address fec0::5054:ff:fe12:3456/64858machine # [ 14.467165] dhcpcd[609]: eth0: adding route to fec0::/64859machine # [ 14.469969] dhcpcd[609]: eth0: adding default route via fe80::2860machine # [ 18.704928] dhcpcd[609]: eth0: leased 10.0.2.15 for 86400 seconds861machine # [ 18.706447] dhcpcd[609]: eth0: adding route to 10.0.2.0/24862machine # [ 18.707267] dhcpcd[609]: eth0: adding default route via 10.0.2.2863machine # [ 18.804631] systemd[1]: Started DHCP Client.864machine # [ 18.806821] systemd[1]: Reached target Multi-User System.865machine # [ 18.807998] systemd[1]: Startup finished in 1.022s (kernel) + 4.661s (initrd) + 13.124s (userspace) = 18.807s.866machine: (finished: waiting for unit multi-user.target, in 20.62 seconds)867machine: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/bin/switch-to-configuration test868machine # Checking switch inhibitors... done869machine # [ 20.041770] nixos[838]: switching to system configuration /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test870machine # activating the configuration...871machine # [ 20.047690] systemd[1]: Stopped target Remote File Systems.872machine # [ 20.050005] systemd[1]: Stopped target Local File Systems.873machine # setting up /etc...874machine # [ 20.383863] systemd[1]: Reload requested from client PID 838 ('.switch-to-conf') (unit backdoor.service)...875machine # [ 20.386514] systemd[1]: Reloading...876machine # [ 20.773355] systemd[1]: Reloading finished in 384 ms.877machine # reloading user units for usertest...878machine # [ 20.824887] systemd[573]: Created slice User Core Session Slice.879machine # [ 20.828287] systemd[573]: Starting D-Bus User Message Bus...880machine # [ 20.862058] dbus-broker-launch[908]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/8srfshgrm5f1phyn1d9c41jm2d9gcbp8-system-path/share/dbus-1/services/org.freedesktop.import1.service'881machine # [ 20.865170] dbus-broker-launch[908]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/8srfshgrm5f1phyn1d9c41jm2d9gcbp8-system-path/share/dbus-1/services/org.freedesktop.machine1.service'882machine # [ 20.868127] dbus-broker-launch[908]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/8srfshgrm5f1phyn1d9c41jm2d9gcbp8-system-path/share/dbus-1/services/org.freedesktop.portable1.service'883machine # [ 20.871051] dbus-broker-launch[908]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/8srfshgrm5f1phyn1d9c41jm2d9gcbp8-system-path/share/dbus-1/services/org.freedesktop.systemd1.service'884machine # [ 20.875592] dbus-broker-launch[908]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored885machine # [ 20.878624] dbus-broker-launch[908]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored886machine # [ 20.880711] systemd[573]: Started D-Bus User Message Bus.887machine # [ 20.883673] dbus-broker-launch[908]: Ready888machine # [ 20.934417] systemd[573]: Reexecution requested from client PID 907 ('switch-to-confi')...889machine # [ 20.935854] systemd[573]: Reexecuting.890machine # [ 20.996317] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy891machine # [ 21.129804] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy892machine # [ 21.136974] systemd[573]: Reload requested from client PID 907 ('switch-to-confi')...893machine # [ 21.138315] systemd[573]: Reloading...894machine # [ 21.300146] systemd[573]: Reloading finished in 160 ms.895machine # [ 21.316185] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy896machine # restarting the following user units: nixos-activation.service897machine # [ 21.326930] systemd[573]: Stopped Run user-specific NixOS activation.898machine # [ 21.329337] systemd[573]: Stopping Run user-specific NixOS activation...899machine # [ 21.331588] systemd[573]: Starting Run user-specific NixOS activation...900machine # [ 21.366059] systemd[573]: Finished Run user-specific NixOS activation.901machine # restarting sysinit-reactivation.target902machine # [ 21.378617] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....903machine # [ 21.476216] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..904machine # [ 21.477505] systemd[1]: Reached target Reactivate sysinit units.905machine # [ 21.482857] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os906machine # [ 21.488714] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki907machine # [ 21.490130] systemd[1]: Reached target Remote File Systems.908machine # [ 21.492235] systemd[1]: Starting linger-users.service...909machine # [ 21.503535] systemd[1]: Reached target Local File Systems.910machine # [ 21.510585] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore911machine # [ 21.517761] systemd[1]: Starting Create SUID/SGID Wrappers...912machine # [ 21.518712] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.913machine # [ 21.519922] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67914machine # [ 21.524231] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore915machine # [ 21.525854] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os916machine # [ 21.527144] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os917machine # [ 21.586010] systemd[1]: linger-users.service: Deactivated successfully.918machine # [ 21.589289] systemd[1]: Finished linger-users.service.919machine # [ 21.742243] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.920machine # [ 21.745244] systemd[1]: Finished Create SUID/SGID Wrappers.921machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service922machine # [ 22.008993] nixos[838]: finished switching to system configuration /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test923machine: (finished: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/bin/switch-to-configuration test, in 2.24 seconds)924machine: must succeed: rm /etc/NIXOS925machine: (finished: must succeed: rm /etc/NIXOS, in 0.05 seconds)926machine: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/66z3l03dj9nblw3xxb6y691bb0g1gpvl-nixos-system-other-test/bin/switch-to-configuration test927machine # this should succeed (config: /nix/store/66z3l03dj9nblw3xxb6y691bb0g1gpvl-nixos-system-other-test, action: test)928machine # Checking switch inhibitors... done929machine # [ 22.390247] nixos[986]: switching to system configuration /nix/store/66z3l03dj9nblw3xxb6y691bb0g1gpvl-nixos-system-other-test930machine # [ 22.393277] systemd[1]: Stopped target Remote File Systems.931machine # [ 22.395095] systemd[1]: Stopped target Local File Systems.932machine # activating the configuration...933machine # removing user ‘usertest’934machine # setting up /etc...935machine # [ 22.708662] systemd[1]: Reload requested from client PID 986 ('.switch-to-conf') (unit backdoor.service)...936machine # [ 22.710817] systemd[1]: Reloading...937machine # [ 23.088676] systemd[1]: Reloading finished in 375 ms.938machine # reloading user units for usertest...939machine # [ 23.192464] systemd[573]: Reexecution requested from client PID 1057 ('switch-to-confi')...940machine # [ 23.196327] systemd[573]: Reexecuting.941machine # [ 23.265036] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy942machine # [ 23.407034] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy943machine # [ 23.413881] systemd[573]: Reload requested from client PID 1057 ('switch-to-confi')...944machine # [ 23.416515] systemd[573]: Reloading...945machine # [ 23.541702] systemd[573]: Reloading finished in 124 ms.946machine # [ 23.556255] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy947machine # restarting the following user units: nixos-activation.service948machine # [ 23.567946] systemd[573]: Stopped Run user-specific NixOS activation.949machine # [ 23.570476] systemd[573]: Stopping Run user-specific NixOS activation...950machine # [ 23.572371] systemd[573]: Starting Run user-specific NixOS activation...951machine # [ 23.606578] systemd[573]: Finished Run user-specific NixOS activation.952machine # restarting sysinit-reactivation.target953machine # [ 23.611805] systemd[1]: Stopped target Reactivate sysinit units.954machine # reloading the following units: dbus-broker.service955machine # [ 23.617065] systemd[1]: Stopping Reactivate sysinit units...956machine # [ 23.617949] systemd[1]: Reached target Reactivate sysinit units.957machine # [ 23.619154] dbus-broker-launch[430]: Caught SIGHUP, trigger reload.958machine # [ 23.621120] systemd[1]: Reloading D-Bus System Message Bus...959machine # [ 23.627857] dbus-broker-launch[430]: Looking up NSS user entry for 'systemd-timesync'...960machine # [ 23.630248] dbus-broker-launch[430]: NSS returned no entry for 'systemd-timesync'961machine # [ 23.631511] dbus-broker-launch[430]: Invalid user-name in /nix/store/nyllvbg8912wqqjjli60yzwiwj24fyw7-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"962machine # [ 23.647362] systemd[1]: Reloaded D-Bus System Message Bus.963machine # restarting the following units: network-addresses-eth1.service964machine # [ 23.655624] systemd[1]: Stopping Address configuration of eth1...965machine # [ 23.689499] network-addresses-eth1-pre-stop[1069]: deleting address 192.168.1.1/24... done966machine # [ 23.696567] network-addresses-eth1-pre-stop[1069]: deleting address 2001:db8:1::1/64... done967machine # [ 23.704152] systemd[1]: network-addresses-eth1.service: Deactivated successfully.968machine # [ 23.706233] systemd[1]: Stopped Address configuration of eth1.969machine # [ 23.710864] systemd[1]: Starting Address configuration of eth1...970machine # [ 23.760529] network-addresses-eth1-start[1074]: adding address 192.168.1.2/24... done971machine # [ 23.768594] network-addresses-eth1-start[1074]: adding address 2001:db8:1::2/64... done972machine # [ 23.780390] systemd[1]: Finished Address configuration of eth1.973machine # [ 23.789780] systemd[1]: Reached target Local File Systems.974machine # [ 23.790748] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore975machine # [ 23.804363] systemd[1]: Starting Create SUID/SGID Wrappers...976machine # [ 23.805325] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.977machine # [ 23.806606] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67978machine # [ 23.814671] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore979machine # [ 23.819481] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os980machine # [ 23.821629] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os981machine # [ 23.824382] systemd[1]: Reached target Remote File Systems.982machine # [ 23.825215] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os983machine # [ 23.826578] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki984machine # [ 24.034976] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.985machine # [ 24.039812] systemd[1]: Finished Create SUID/SGID Wrappers.986machine # [ 24.044331] systemd[1]: Starting linger-users.service...987machine # [ 24.077789] linger-users-start[1146]: id: ‘usertest’: no such user988machine # [ 24.079925] linger-users-start[1144]: Removing linger for missing user usertest989machine # [ 24.087468] systemd[1]: linger-users.service: Deactivated successfully.990machine # [ 24.089625] systemd[1]: Finished linger-users.service.991machine # [ 24.350316] nixos[986]: finished switching to system configuration /nix/store/66z3l03dj9nblw3xxb6y691bb0g1gpvl-nixos-system-other-test992machine: (finished: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/66z3l03dj9nblw3xxb6y691bb0g1gpvl-nixos-system-other-test/bin/switch-to-configuration test, in 2.29 seconds)993subtest: services994machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1995machine # [ 24.712714] nixos[1152]: switching to system configuration /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test996machine # [ 24.715773] systemd[1]: Stopped target Local File Systems.997machine # [ 24.717712] systemd[1]: Stopped target Remote File Systems.998machine # [ 25.011715] systemd[1]: Reload requested from client PID 1152 ('.switch-to-conf') (unit backdoor.service)...999machine # [ 25.013984] systemd[1]: Reloading...1000machine # [ 25.376732] systemd[1]: Reloading finished in 361 ms.1001machine # [ 25.472339] systemd[573]: Reexecution requested from client PID 1222 ('switch-to-confi')...1002machine # [ 25.473805] systemd[573]: Reexecuting.1003machine # [ 25.531650] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1004machine # [ 25.661601] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1005machine # [ 25.668673] systemd[573]: Reload requested from client PID 1222 ('switch-to-confi')...1006machine # [ 25.670080] systemd[573]: Reloading...1007machine # [ 25.787141] systemd[573]: Reloading finished in 115 ms.1008machine # [ 25.800191] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1009machine # [ 25.809758] systemd[573]: Stopped Run user-specific NixOS activation.1010machine # [ 25.812125] systemd[573]: Stopping Run user-specific NixOS activation...1011machine # [ 25.814359] systemd[573]: Starting Run user-specific NixOS activation...1012machine # [ 25.844223] systemd[573]: Finished Run user-specific NixOS activation.1013machine # [ 25.850247] systemd[1]: Stopped target Reactivate sysinit units.1014machine # [ 25.851221] systemd[1]: Stopping Reactivate sysinit units...1015machine # [ 25.852573] systemd[1]: Reached target Reactivate sysinit units.1016machine # [ 25.855269] systemd[1]: Reloading D-Bus System Message Bus...1017machine # [ 25.857939] dbus-broker-launch[430]: Caught SIGHUP, trigger reload.1018machine # [ 25.862422] dbus-broker-launch[430]: Looking up NSS user entry for 'systemd-timesync'...1019machine # [ 25.864602] dbus-broker-launch[430]: NSS returned no entry for 'systemd-timesync'1020machine # [ 25.865704] dbus-broker-launch[430]: Invalid user-name in /nix/store/8srfshgrm5f1phyn1d9c41jm2d9gcbp8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1021machine # [ 25.884457] systemd[1]: Reloaded D-Bus System Message Bus.1022machine # [ 25.889790] systemd[1]: Stopping Address configuration of eth1...1023machine # [ 25.923365] network-addresses-eth1-pre-stop[1234]: deleting address 192.168.1.2/24... done1024machine # [ 25.930121] network-addresses-eth1-pre-stop[1234]: deleting address 2001:db8:1::2/64... done1025machine # [ 25.936941] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1026machine # [ 25.939860] systemd[1]: Stopped Address configuration of eth1.1027machine # [ 25.943571] systemd[1]: Starting Address configuration of eth1...1028machine # [ 25.987630] network-addresses-eth1-start[1239]: adding address 192.168.1.1/24... done1029machine # [ 25.995176] network-addresses-eth1-start[1239]: adding address 2001:db8:1::1/64... done1030machine # [ 26.004666] systemd[1]: Finished Address configuration of eth1.1031machine # [ 26.010251] systemd[1]: Reached target Remote File Systems.1032machine # [ 26.014834] systemd[1]: Starting linger-users.service...1033machine # [ 26.025374] systemd[1]: Reached target Local File Systems.1034machine # [ 26.030110] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1035machine # [ 26.031575] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1036machine # [ 26.033073] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1037machine # [ 26.039699] systemd[1]: Starting Create SUID/SGID Wrappers...1038machine # [ 26.046049] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1039machine # [ 26.047356] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671040machine # [ 26.057189] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1041machine # [ 26.058880] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1042machine # [ 26.063484] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1043machine # [ 26.087667] systemd[1]: linger-users.service: Deactivated successfully.1044machine # [ 26.090386] systemd[1]: Finished linger-users.service.1045machine # [ 26.242023] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1046machine # [ 26.244822] systemd[1]: Finished Create SUID/SGID Wrappers.1047machine # [ 26.502057] nixos[1152]: finished switching to system configuration /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test1048machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.15 seconds)1049machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/bin/switch-to-configuration test 2>&11050machine # [ 26.749689] nixos[1308]: switching to system configuration /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test1051machine # [ 26.752508] systemd[1]: Stopped target Local File Systems.1052machine # [ 26.755369] systemd[1]: Stopped target Remote File Systems.1053machine # [ 27.037446] systemd[1]: Reload requested from client PID 1308 ('.switch-to-conf') (unit backdoor.service)...1054machine # [ 27.039437] systemd[1]: Reloading...1055machine # [ 27.378351] systemd[1]: Reloading finished in 337 ms.1056machine # [ 27.474192] systemd[573]: Reexecution requested from client PID 1377 ('switch-to-confi')...1057machine # [ 27.475618] systemd[573]: Reexecuting.1058machine # [ 27.535652] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1059machine # [ 27.656302] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1060machine # [ 27.665193] systemd[573]: Reload requested from client PID 1377 ('switch-to-confi')...1061machine # [ 27.666646] systemd[573]: Reloading...1062machine # [ 27.788636] systemd[573]: Reloading finished in 120 ms.1063machine # [ 27.804276] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1064machine # [ 27.815597] systemd[573]: Stopped Run user-specific NixOS activation.1065machine # [ 27.818365] systemd[573]: Stopping Run user-specific NixOS activation...1066machine # [ 27.820898] systemd[573]: Starting Run user-specific NixOS activation...1067machine # [ 27.855460] systemd[573]: Finished Run user-specific NixOS activation.1068machine # [ 27.860235] systemd[1]: Stopped target Reactivate sysinit units.1069machine # [ 27.862754] systemd[1]: Stopping Reactivate sysinit units...1070machine # [ 27.863709] systemd[1]: Reached target Reactivate sysinit units.1071machine # [ 27.869420] systemd[1]: Reached target Remote File Systems.1072machine # [ 27.877790] systemd[1]: Starting linger-users.service...1073machine # [ 27.895485] systemd[1]: Reached target Local File Systems.1074machine # [ 27.902957] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1075machine # [ 27.913872] systemd[1]: Starting Create SUID/SGID Wrappers...1076machine # [ 27.914780] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1077machine # [ 27.919497] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671078machine # [ 27.929447] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1079machine # [ 27.931151] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1080machine # [ 27.943177] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1081machine # [ 27.950115] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1082machine # [ 27.951627] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1083machine # [ 28.019080] systemd[1]: linger-users.service: Deactivated successfully.1084machine # [ 28.025404] systemd[1]: Finished linger-users.service.1085machine # [ 28.202638] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1086machine # [ 28.206677] systemd[1]: Finished Create SUID/SGID Wrappers.1087machine # [ 28.462262] nixos[1308]: finished switching to system configuration /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test1088machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.96 seconds)1089machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11090machine # [ 28.704797] nixos[1449]: switching to system configuration /nix/store/66dbaf8drh2qv8s77s8mh18j9kra7av5-nixos-system-machine-test1091machine # [ 28.709398] systemd[1]: Stopped target Remote File Systems.1092machine # [ 28.712133] systemd[1]: Stopped target Local File Systems.1093machine # [ 29.025265] systemd[1]: Reload requested from client PID 1449 ('.switch-to-conf') (unit backdoor.service)...1094machine # [ 29.027309] systemd[1]: Reloading...1095machine # [ 29.382757] systemd[1]: Reloading finished in 353 ms.1096machine # [ 29.475526] systemd[573]: Reexecution requested from client PID 1518 ('switch-to-confi')...1097machine # [ 29.478530] systemd[573]: Reexecuting.1098machine # [ 29.535625] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1099machine # [ 29.657867] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1100machine # [ 29.664890] systemd[573]: Reload requested from client PID 1518 ('switch-to-confi')...1101machine # [ 29.668900] systemd[573]: Reloading...1102machine # [ 29.782641] systemd[573]: Reloading finished in 114 ms.1103machine # [ 29.800190] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1104machine # [ 29.809249] systemd[573]: Stopped Run user-specific NixOS activation.1105machine # [ 29.811651] systemd[573]: Stopping Run user-specific NixOS activation...1106machine # [ 29.813999] systemd[573]: Starting Run user-specific NixOS activation...1107machine # [ 29.849449] systemd[573]: Finished Run user-specific NixOS activation.1108machine # [ 29.853553] systemd[1]: Stopped target Reactivate sysinit units.1109machine # [ 29.856518] systemd[1]: Stopping Reactivate sysinit units...1110machine # [ 29.857407] systemd[1]: Reached target Reactivate sysinit units.1111machine # [ 29.860460] systemd[1]: Reached target Remote File Systems.1112machine # [ 29.864195] systemd[1]: Starting linger-users.service...1113machine # [ 29.869070] systemd[1]: Starting test.service...1114machine # [ 29.886777] systemd[1]: Reached target Local File Systems.1115machine # [ 29.887764] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1116machine # [ 29.900690] systemd[1]: Starting Create SUID/SGID Wrappers...1117machine # [ 29.901650] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1118machine # [ 29.909943] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671119machine # [ 29.920527] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1120machine # [ 29.927967] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1121machine # [ 29.935066] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1122machine # [ 29.942365] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1123machine # [ 29.943880] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1124machine # [ 29.952503] systemd[1]: Finished test.service.1125machine # [ 29.979221] systemd[1]: linger-users.service: Deactivated successfully.1126machine # [ 29.983854] systemd[1]: Finished linger-users.service.1127machine # [ 30.125757] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1128machine # [ 30.129022] systemd[1]: Finished Create SUID/SGID Wrappers.1129machine # [ 30.389599] nixos[1449]: finished switching to system configuration /nix/store/66dbaf8drh2qv8s77s8mh18j9kra7av5-nixos-system-machine-test1130machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.93 seconds)1131machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11132machine # [ 30.667188] nixos[1591]: switching to system configuration /nix/store/66dbaf8drh2qv8s77s8mh18j9kra7av5-nixos-system-machine-test1133machine # [ 30.672734] systemd[1]: Stopped target Remote File Systems.1134machine # [ 30.673722] systemd[1]: Stopped target Local File Systems.1135machine # [ 30.956127] systemd[1]: Reload requested from client PID 1591 ('.switch-to-conf') (unit backdoor.service)...1136machine # [ 30.957871] systemd[1]: Reloading...1137machine # [ 31.311334] systemd[1]: Reloading finished in 351 ms.1138machine # [ 31.436508] systemd[573]: Reexecution requested from client PID 1660 ('switch-to-confi')...1139machine # [ 31.437985] systemd[573]: Reexecuting.1140machine # [ 31.499881] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1141machine # [ 31.617347] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1142machine # [ 31.624243] systemd[573]: Reload requested from client PID 1660 ('switch-to-confi')...1143machine # [ 31.626913] systemd[573]: Reloading...1144machine # [ 31.740848] systemd[573]: Reloading finished in 112 ms.1145machine # [ 31.756394] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1146machine # [ 31.767474] systemd[573]: Stopped Run user-specific NixOS activation.1147machine # [ 31.770351] systemd[573]: Stopping Run user-specific NixOS activation...1148machine # [ 31.773011] systemd[573]: Starting Run user-specific NixOS activation...1149machine # [ 31.809669] systemd[573]: Finished Run user-specific NixOS activation.1150machine # [ 31.814658] systemd[1]: Stopped target Reactivate sysinit units.1151machine # [ 31.817060] systemd[1]: Stopping Reactivate sysinit units...1152machine # [ 31.818043] systemd[1]: Reached target Reactivate sysinit units.1153machine # [ 31.825136] systemd[1]: Reached target Local File Systems.1154machine # [ 31.827965] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1155machine # [ 31.830206] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1156machine # [ 31.833118] systemd[1]: Reached target Remote File Systems.1157machine # [ 31.838322] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1158machine # [ 31.847325] systemd[1]: Starting Create SUID/SGID Wrappers...1159machine # [ 31.852447] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1160machine # [ 31.853907] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671161machine # [ 31.857495] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1162machine # [ 31.859138] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1163machine # [ 31.860701] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1164machine # [ 32.036295] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1165machine # [ 32.040260] systemd[1]: Finished Create SUID/SGID Wrappers.1166machine # [ 32.043501] systemd[1]: Starting linger-users.service...1167machine # [ 32.085825] systemd[1]: linger-users.service: Deactivated successfully.1168machine # [ 32.088447] systemd[1]: Finished linger-users.service.1169machine # [ 32.347092] nixos[1591]: finished switching to system configuration /nix/store/66dbaf8drh2qv8s77s8mh18j9kra7av5-nixos-system-machine-test1170machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.96 seconds)1171machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&11172machine # [ 32.653072] nixos[1732]: switching to system configuration /nix/store/2fm46b0hjnbm592qv9ibcwifx4xmj0wg-nixos-system-machine-test1173machine # [ 32.656178] systemd[1]: Stopped target Local File Systems.1174machine # [ 32.658919] systemd[1]: Stopped target Remote File Systems.1175machine # [ 32.962078] systemd[1]: Reload requested from client PID 1732 ('.switch-to-conf') (unit backdoor.service)...1176machine # [ 32.964225] systemd[1]: Reloading...1177machine # [ 33.378051] systemd[1]: Reloading finished in 412 ms.1178machine # [ 33.471312] systemd[573]: Reexecution requested from client PID 1801 ('switch-to-confi')...1179machine # [ 33.475989] systemd[573]: Reexecuting.1180machine # [ 33.531212] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1181machine # [ 33.647939] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1182machine # [ 33.654438] systemd[573]: Reload requested from client PID 1801 ('switch-to-confi')...1183machine # [ 33.658610] systemd[573]: Reloading...1184machine # [ 33.771821] systemd[573]: Reloading finished in 114 ms.1185machine # [ 33.788206] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1186machine # [ 33.798176] systemd[573]: Stopped Run user-specific NixOS activation.1187machine # [ 33.800609] systemd[573]: Stopping Run user-specific NixOS activation...1188machine # [ 33.803046] systemd[573]: Starting Run user-specific NixOS activation...1189machine # [ 33.838604] systemd[573]: Finished Run user-specific NixOS activation.1190machine # [ 33.842843] systemd[1]: Stopped target Reactivate sysinit units.1191machine # [ 33.845811] systemd[1]: Stopping Reactivate sysinit units...1192machine # [ 33.846756] systemd[1]: Reached target Reactivate sysinit units.1193machine # [ 33.849350] systemd[1]: Reached target Local File Systems.1194machine # [ 33.852962] systemd[1]: Reached target Remote File Systems.1195machine # [ 33.856398] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1196machine # [ 33.859865] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1197machine # [ 33.866244] systemd[1]: Starting linger-users.service...1198machine # [ 33.879223] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1199machine # [ 33.884245] systemd[1]: Starting Create SUID/SGID Wrappers...1200machine # [ 33.885162] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1201machine # [ 33.886483] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671202machine # [ 33.896437] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1203machine # [ 33.900973] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1204machine # [ 33.908190] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1205machine # [ 33.957085] systemd[1]: linger-users.service: Deactivated successfully.1206machine # [ 33.958942] systemd[1]: Finished linger-users.service.1207machine # [ 34.114738] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1208machine # [ 34.118517] systemd[1]: Finished Create SUID/SGID Wrappers.1209machine # [ 34.375740] nixos[1732]: finished switching to system configuration /nix/store/2fm46b0hjnbm592qv9ibcwifx4xmj0wg-nixos-system-machine-test1210machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 2.03 seconds)1211machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11212machine # [ 34.732258] nixos[1872]: switching to system configuration /nix/store/fbyc39dqamh37xihiajdl2q8sxb8bicn-nixos-system-machine-test1213machine # [ 34.735062] systemd[1]: test.service: Deactivated successfully.1214machine # [ 34.735987] systemd[1]: Stopped Test unit.1215machine # [ 34.738718] systemd[1]: Stopped target Local File Systems.1216machine # [ 34.739496] systemd[1]: Stopped target Remote File Systems.1217machine # [ 35.032846] systemd[1]: Reload requested from client PID 1872 ('.switch-to-conf') (unit backdoor.service)...1218machine # [ 35.034810] systemd[1]: Reloading...1219machine # [ 35.379838] systemd[1]: Reloading finished in 343 ms.1220machine # [ 35.475252] systemd[573]: Reexecution requested from client PID 1942 ('switch-to-confi')...1221machine # [ 35.479138] systemd[573]: Reexecuting.1222machine # [ 35.527913] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1223machine # [ 35.649025] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1224machine # [ 35.657320] systemd[573]: Reload requested from client PID 1942 ('switch-to-confi')...1225machine # [ 35.658897] systemd[573]: Reloading...1226machine # [ 35.781906] systemd[573]: Reloading finished in 120 ms.1227machine # [ 35.796306] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1228machine # [ 35.807705] systemd[573]: Stopped Run user-specific NixOS activation.1229machine # [ 35.809074] systemd[573]: Stopping Run user-specific NixOS activation...1230machine # [ 35.811598] systemd[573]: Starting Run user-specific NixOS activation...1231machine # [ 35.847594] systemd[573]: Finished Run user-specific NixOS activation.1232machine # [ 35.852495] systemd[1]: Stopped target Reactivate sysinit units.1233machine # [ 35.855827] systemd[1]: Stopping Reactivate sysinit units...1234machine # [ 35.857887] systemd[1]: Reached target Reactivate sysinit units.1235machine # [ 35.864122] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1236machine # [ 35.871173] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1237machine # [ 35.885787] systemd[1]: Starting test.service...1238machine # [ 35.886665] systemd[1]: Reached target Local File Systems.1239machine # [ 35.887483] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1240machine # [ 35.901047] systemd[1]: Starting Create SUID/SGID Wrappers...1241machine # [ 35.902061] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1242machine # [ 35.903365] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671243machine # [ 35.906755] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1244machine # [ 35.915440] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1245machine # [ 35.921751] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1246machine # [ 35.926702] systemd[1]: Reached target Remote File Systems.1247machine # [ 35.939819] systemd[1]: Finished test.service.1248machine # [ 36.111579] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1249machine # [ 36.116378] systemd[1]: Finished Create SUID/SGID Wrappers.1250machine # [ 36.120909] systemd[1]: Starting linger-users.service...1251machine # [ 36.166654] systemd[1]: linger-users.service: Deactivated successfully.1252machine # [ 36.169667] systemd[1]: Finished linger-users.service.1253machine # [ 36.428640] nixos[1872]: finished switching to system configuration /nix/store/fbyc39dqamh37xihiajdl2q8sxb8bicn-nixos-system-machine-test1254machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 2.05 seconds)1255machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&11256machine # [ 36.750107] nixos[2015]: switching to system configuration /nix/store/hb6224q4069xw5wng9rddmckhna98vcz-nixos-system-machine-test1257machine # [ 36.752980] systemd[1]: Stopped target Local File Systems.1258machine # [ 36.755668] systemd[1]: Stopped target Remote File Systems.1259machine # [ 37.057819] systemd[1]: Reload requested from client PID 2015 ('.switch-to-conf') (unit backdoor.service)...1260machine # [ 37.059848] systemd[1]: Reloading...1261machine # [ 37.448950] systemd[1]: Reloading finished in 387 ms.1262machine # [ 37.537757] systemd[573]: Reexecution requested from client PID 2084 ('switch-to-confi')...1263machine # [ 37.542187] systemd[573]: Reexecuting.1264machine # [ 37.587687] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1265machine # [ 37.708623] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1266machine # [ 37.716549] systemd[573]: Reload requested from client PID 2084 ('switch-to-confi')...1267machine # [ 37.719351] systemd[573]: Reloading...1268machine # [ 37.836282] systemd[573]: Reloading finished in 115 ms.1269machine # [ 37.848263] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1270machine # [ 37.863475] systemd[573]: Stopped Run user-specific NixOS activation.1271machine # [ 37.870313] systemd[573]: Stopping Run user-specific NixOS activation...1272machine # [ 37.871457] systemd[573]: Starting Run user-specific NixOS activation...1273machine # [ 37.936315] systemd[573]: Finished Run user-specific NixOS activation.1274machine # [ 37.945494] systemd[1]: Stopped target Reactivate sysinit units.1275machine # [ 37.951278] systemd[1]: Stopping Reactivate sysinit units...1276machine # [ 37.954585] systemd[1]: Reached target Reactivate sysinit units.1277machine # [ 37.955582] systemd[1]: test.service: Deactivated successfully.1278machine # [ 37.961096] systemd[1]: Stopped test.service.1279machine # [ 37.963042] systemd[1]: Stopping test.service...1280machine # [ 37.967206] systemd[1]: Starting test.service...1281machine # [ 37.994501] systemd[1]: Finished test.service.1282machine # [ 38.000193] systemd[1]: Reached target Remote File Systems.1283machine # [ 38.006773] systemd[1]: Starting linger-users.service...1284machine # [ 38.007824] systemd[1]: Reached target Local File Systems.1285machine # [ 38.019448] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1286machine # [ 38.028605] systemd[1]: Starting Create SUID/SGID Wrappers...1287machine # [ 38.029607] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1288machine # [ 38.030856] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671289machine # [ 38.042705] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1290machine # [ 38.047608] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1291machine # [ 38.052297] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1292machine # [ 38.058775] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1293machine # [ 38.063659] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1294machine # [ 38.111349] systemd[1]: linger-users.service: Deactivated successfully.1295machine # [ 38.115382] systemd[1]: Finished linger-users.service.1296machine # [ 38.256099] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1297machine # [ 38.259897] systemd[1]: Finished Create SUID/SGID Wrappers.1298machine # [ 38.517180] nixos[2015]: finished switching to system configuration /nix/store/hb6224q4069xw5wng9rddmckhna98vcz-nixos-system-machine-test1299machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.09 seconds)1300machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&11301machine # [ 38.814257] nixos[2158]: switching to system configuration /nix/store/vchdmyfrc15bic9b8q86lbv34b3yqczn-nixos-system-machine-test1302machine # [ 38.816783] systemd[1]: Stopped target Local File Systems.1303machine # [ 38.819177] systemd[1]: Stopped target Remote File Systems.1304machine # [ 39.109228] systemd[1]: Reload requested from client PID 2158 ('.switch-to-conf') (unit backdoor.service)...1305machine # [ 39.111239] systemd[1]: Reloading...1306machine # [ 39.455427] systemd[1]: Reloading finished in 342 ms.1307machine # [ 39.543808] systemd[573]: Reexecution requested from client PID 2227 ('switch-to-confi')...1308machine # [ 39.546635] systemd[573]: Reexecuting.1309machine # [ 39.599414] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1310machine # [ 39.715623] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1311machine # [ 39.722783] systemd[573]: Reload requested from client PID 2227 ('switch-to-confi')...1312machine # [ 39.725910] systemd[573]: Reloading...1313machine # [ 39.837088] systemd[573]: Reloading finished in 111 ms.1314machine # [ 39.852181] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1315machine # [ 39.862718] systemd[573]: Stopped Run user-specific NixOS activation.1316machine # [ 39.863852] systemd[573]: Stopping Run user-specific NixOS activation...1317machine # [ 39.866607] systemd[573]: Starting Run user-specific NixOS activation...1318machine # [ 39.902321] systemd[573]: Finished Run user-specific NixOS activation.1319machine # [ 39.906613] systemd[1]: Stopped target Reactivate sysinit units.1320machine # [ 39.908639] systemd[1]: Stopping Reactivate sysinit units...1321machine # [ 39.909636] systemd[1]: Reached target Reactivate sysinit units.1322machine # [ 39.915468] systemd[1]: Reloading test.service...1323machine # [ 39.945687] systemd[1]: Reloaded test.service.1324machine # [ 39.950803] systemd[1]: Reached target Local File Systems.1325machine # [ 39.953236] systemd[1]: Reached target Remote File Systems.1326machine # [ 39.958924] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1327machine # [ 39.966279] systemd[1]: Starting Create SUID/SGID Wrappers...1328machine # [ 39.967230] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1329machine # [ 39.976842] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671330machine # [ 39.979192] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1331machine # [ 39.984947] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1332machine # [ 39.986420] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1333machine # [ 39.987630] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1334machine # [ 39.989040] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1335machine # [ 40.162798] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1336machine # [ 40.167092] systemd[1]: Finished Create SUID/SGID Wrappers.1337machine # [ 40.169428] systemd[1]: Starting linger-users.service...1338machine # [ 40.209420] systemd[1]: linger-users.service: Deactivated successfully.1339machine # [ 40.212665] systemd[1]: Finished linger-users.service.1340machine # [ 40.471542] nixos[2158]: finished switching to system configuration /nix/store/vchdmyfrc15bic9b8q86lbv34b3yqczn-nixos-system-machine-test1341machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 1.95 seconds)1342machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&11343machine # [ 40.777312] nixos[2300]: switching to system configuration /nix/store/k2l67iyjs5ln3zw4j84fhsvslw86awx2-nixos-system-machine-test1344machine # [ 40.780092] systemd[1]: Stopped target Local File Systems.1345machine # [ 40.783080] systemd[1]: Stopped target Remote File Systems.1346machine # [ 41.099277] systemd[1]: Reload requested from client PID 2300 ('.switch-to-conf') (unit backdoor.service)...1347machine # [ 41.101600] systemd[1]: Reloading...1348machine # [ 41.462389] systemd[1]: Reloading finished in 358 ms.1349machine # [ 41.588434] systemd[573]: Reexecution requested from client PID 2369 ('switch-to-confi')...1350machine # [ 41.591928] systemd[573]: Reexecuting.1351machine # [ 41.647490] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1352machine # [ 41.765166] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1353machine # [ 41.771406] systemd[573]: Reload requested from client PID 2369 ('switch-to-confi')...1354machine # [ 41.773793] systemd[573]: Reloading...1355machine # [ 41.882890] systemd[573]: Reloading finished in 108 ms.1356machine # [ 41.896169] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1357machine # [ 41.905293] systemd[573]: Stopped Run user-specific NixOS activation.1358machine # [ 41.907621] systemd[573]: Stopping Run user-specific NixOS activation...1359machine # [ 41.909733] systemd[573]: Starting Run user-specific NixOS activation...1360machine # [ 41.939643] systemd[573]: Finished Run user-specific NixOS activation.1361machine # [ 41.943535] systemd[1]: Stopped target Reactivate sysinit units.1362machine # [ 41.946070] systemd[1]: Stopping Reactivate sysinit units...1363machine # [ 41.946945] systemd[1]: Reached target Reactivate sysinit units.1364machine # [ 41.948601] systemd[1]: Reached target Local File Systems.1365machine # [ 41.952697] systemd[1]: Reached target Remote File Systems.1366machine # [ 41.956816] systemd[1]: Starting linger-users.service...1367machine # [ 41.961553] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1368machine # [ 41.965307] systemd[1]: Starting Create SUID/SGID Wrappers...1369machine # [ 41.966241] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1370machine # [ 41.967457] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671371machine # [ 41.984560] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1372machine # [ 41.986237] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1373machine # [ 41.987498] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1374machine # [ 41.989070] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1375machine # [ 41.990395] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1376machine # [ 42.048678] systemd[1]: linger-users.service: Deactivated successfully.1377machine # [ 42.050360] systemd[1]: Finished linger-users.service.1378machine # [ 42.190730] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1379machine # [ 42.194156] systemd[1]: Finished Create SUID/SGID Wrappers.1380machine # [ 42.452904] nixos[2300]: finished switching to system configuration /nix/store/k2l67iyjs5ln3zw4j84fhsvslw86awx2-nixos-system-machine-test1381machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.98 seconds)1382machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&11383machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.33 seconds)1384machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/bin/switch-to-configuration test 2>&11385machine # [ 42.995213] nixos[2451]: switching to system configuration /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test1386machine # [ 42.998128] systemd[1]: Stopped target Remote File Systems.1387machine # [ 43.001567] systemd[1]: test.service: Deactivated successfully.1388machine # [ 43.003051] systemd[1]: Stopped test.service.1389machine # [ 43.003696] systemd[1]: Stopped target Local File Systems.1390machine # [ 43.259372] systemd[1]: Reload requested from client PID 2451 ('.switch-to-conf') (unit backdoor.service)...1391machine # [ 43.261417] systemd[1]: Reloading...1392machine # [ 43.583935] systemd[1]: Reloading finished in 321 ms.1393machine # [ 43.672224] systemd[573]: Reexecution requested from client PID 2520 ('switch-to-confi')...1394machine # [ 43.673630] systemd[573]: Reexecuting.1395machine # [ 43.727353] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1396machine # [ 43.843804] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1397machine # [ 43.851497] systemd[573]: Reload requested from client PID 2520 ('switch-to-confi')...1398machine # [ 43.854488] systemd[573]: Reloading...1399machine # [ 43.964089] systemd[573]: Reloading finished in 110 ms.1400machine # [ 43.976165] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1401machine # [ 43.987212] systemd[573]: Stopped Run user-specific NixOS activation.1402machine # [ 43.988306] systemd[573]: Stopping Run user-specific NixOS activation...1403machine # [ 43.990488] systemd[573]: Starting Run user-specific NixOS activation...1404machine # [ 44.023845] systemd[573]: Finished Run user-specific NixOS activation.1405machine # [ 44.028532] systemd[1]: Stopped target Reactivate sysinit units.1406machine # [ 44.029567] systemd[1]: Stopping Reactivate sysinit units...1407machine # [ 44.030375] systemd[1]: Reached target Reactivate sysinit units.1408machine # [ 44.034438] systemd[1]: Reached target Local File Systems.1409machine # [ 44.038081] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1410machine # [ 44.042917] systemd[1]: Starting Create SUID/SGID Wrappers...1411machine # [ 44.043871] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1412machine # [ 44.052998] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671413machine # [ 44.055260] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1414machine # [ 44.063464] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1415machine # [ 44.064954] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1416machine # [ 44.066227] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1417machine # [ 44.067535] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1418machine # [ 44.069578] systemd[1]: Reached target Remote File Systems.1419machine # [ 44.229115] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1420machine # [ 44.231389] systemd[1]: Finished Create SUID/SGID Wrappers.1421machine # [ 44.236357] systemd[1]: Starting linger-users.service...1422machine # [ 44.278717] systemd[1]: linger-users.service: Deactivated successfully.1423machine # [ 44.281493] systemd[1]: Finished linger-users.service.1424machine # [ 44.540000] nixos[2451]: finished switching to system configuration /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test1425machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.76 seconds)1426machine: must succeed: /nix/store/vsm5222hf84gsamvgxhqv957gwq8qrmf-separate-activation-script/bin/switch-to-configuration test 2>&11427machine # [ 44.835768] nixos[2591]: switching to system configuration /nix/store/pkn25jh8avq4423rgi6gw91anclzg2qq-nixos-system-machine-test1428machine # [ 44.838443] systemd[1]: Stopped target Remote File Systems.1429machine # [ 44.840786] systemd[1]: Stopped target Local File Systems.1430machine # [ 45.163822] systemd[1]: Reload requested from client PID 2591 ('.switch-to-conf') (unit backdoor.service)...1431machine # [ 45.165972] systemd[1]: Reloading...1432machine # [ 45.510895] systemd[1]: Reloading finished in 343 ms.1433machine # [ 45.610360] systemd[573]: Stopped Run user-specific NixOS activation.1434machine # [ 45.614698] systemd[573]: Reexecution requested from client PID 2661 ('switch-to-confi')...1435machine # [ 45.617157] systemd[573]: Reexecuting.1436machine # [ 45.672715] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1437machine # [ 45.801246] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1438machine # [ 45.808582] systemd[573]: Reload requested from client PID 2661 ('switch-to-confi')...1439machine # [ 45.810031] systemd[573]: Reloading...1440machine # [ 45.930933] systemd[573]: Reloading finished in 119 ms.1441machine # [ 45.948210] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1442machine # [ 45.959324] systemd[1]: Stopped target Reactivate sysinit units.1443machine # [ 45.962572] systemd[1]: Stopping Reactivate sysinit units...1444machine # [ 45.963482] systemd[1]: Reached target Reactivate sysinit units.1445machine # [ 45.966013] systemd[1]: Reached target Local File Systems.1446machine # [ 45.966963] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1447machine # [ 45.970135] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1448machine # [ 45.974712] systemd[1]: Reached target Remote File Systems.1449machine # [ 45.981093] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1450machine # [ 45.987428] systemd[1]: Starting Create SUID/SGID Wrappers...1451machine # [ 45.989183] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1452machine # [ 45.990496] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671453machine # [ 45.992886] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1454machine # [ 45.994514] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1455machine # [ 45.995776] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1456machine # [ 46.181680] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1457machine # [ 46.186808] systemd[1]: Finished Create SUID/SGID Wrappers.1458machine # [ 46.190451] systemd[1]: Starting linger-users.service...1459machine # [ 46.193392] systemd[1]: Starting test.service...1460machine # [ 46.235822] systemd[1]: Finished test.service.1461machine # [ 46.259890] systemd[1]: linger-users.service: Deactivated successfully.1462machine # [ 46.262049] systemd[1]: Finished linger-users.service.1463machine # [ 46.523492] nixos[2591]: finished switching to system configuration /nix/store/pkn25jh8avq4423rgi6gw91anclzg2qq-nixos-system-machine-test1464machine: (finished: must succeed: /nix/store/vsm5222hf84gsamvgxhqv957gwq8qrmf-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.98 seconds)1465machine: must succeed: ! test -e /run/current-system/activate1466machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.04 seconds)1467machine: must succeed: ! test -e /run/current-system/dry-activate1468machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.03 seconds)1469machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration1470machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.03 seconds)1471machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&11472machine # [ 46.875717] nixos[2740]: switching to system configuration /nix/store/ixd7vkpscb2qn3a0mfn3wjgv6hc9mivq-nixos-system-machine-test1473machine # [ 46.878402] systemd[1]: Stopped target Remote File Systems.1474machine # [ 46.881002] systemd[1]: test.service: Deactivated successfully.1475machine # [ 46.881938] systemd[1]: Stopped test.service.1476machine # [ 46.883176] systemd[1]: Stopped target Local File Systems.1477machine # [ 47.181910] systemd[1]: Reload requested from client PID 2740 ('.switch-to-conf') (unit backdoor.service)...1478machine # [ 47.183894] systemd[1]: Reloading...1479machine # [ 47.519099] systemd[1]: Reloading finished in 333 ms.1480machine # [ 47.606946] systemd[573]: Reexecution requested from client PID 2809 ('switch-to-confi')...1481machine # [ 47.609744] systemd[573]: Reexecuting.1482machine # [ 47.667635] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1483machine # [ 47.791554] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1484machine # [ 47.798024] systemd[573]: Reload requested from client PID 2809 ('switch-to-confi')...1485machine # [ 47.800295] systemd[573]: Reloading...1486machine # [ 47.911261] systemd[573]: Reloading finished in 110 ms.1487machine # [ 47.928201] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1488machine # [ 47.938169] systemd[573]: Starting Run user-specific NixOS activation...1489machine # [ 47.972164] systemd[573]: Finished Run user-specific NixOS activation.1490machine # [ 47.976168] systemd[573]: Stopped Run user-specific NixOS activation.1491machine # [ 47.977188] systemd[573]: Stopping Run user-specific NixOS activation...1492machine # [ 47.979738] systemd[573]: Starting Run user-specific NixOS activation...1493machine # [ 47.985342] systemd[1]: Stopped target Reactivate sysinit units.1494machine # [ 47.986338] systemd[1]: Stopping Reactivate sysinit units...1495machine # [ 47.987124] systemd[1]: Reached target Reactivate sysinit units.1496machine # [ 47.999228] systemd[1]: Started test.service.1497machine # [ 48.004169] systemd[1]: Reached target Local File Systems.1498machine # [ 48.008277] systemd[1]: Reached target Remote File Systems.1499machine # [ 48.025496] systemd[1]: Starting linger-users.service...1500machine # [ 48.046212] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1501machine # [ 48.057267] systemd[573]: Finished Run user-specific NixOS activation.1502machine # [ 48.058370] systemd[1]: Starting Create SUID/SGID Wrappers...1503machine # [ 48.059193] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1504machine # [ 48.066819] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671505machine # [ 48.081178] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1506machine # [ 48.082830] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1507machine # [ 48.089975] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1508machine # [ 48.091252] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1509machine # [ 48.100158] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1510machine # [ 48.101608] systemd[1]: test.service: Deactivated successfully.1511machine # [ 48.136956] systemd[1]: linger-users.service: Deactivated successfully.1512machine # [ 48.140005] systemd[1]: Finished linger-users.service.1513machine # [ 48.283815] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1514machine # [ 48.287100] systemd[1]: Finished Create SUID/SGID Wrappers.1515machine # [ 48.543769] nixos[2740]: finished switching to system configuration /nix/store/ixd7vkpscb2qn3a0mfn3wjgv6hc9mivq-nixos-system-machine-test1516machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.93 seconds)1517machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&11518machine # [ 48.845431] nixos[2885]: switching to system configuration /nix/store/ayl8qk2992flsw39izmpzm1wh92kn8sd-nixos-system-machine-test1519machine # [ 48.849080] systemd[1]: Stopped target Remote File Systems.1520machine # [ 48.851451] systemd[1]: Stopped target Local File Systems.1521machine # [ 49.142170] systemd[1]: Reload requested from client PID 2885 ('.switch-to-conf') (unit backdoor.service)...1522machine # [ 49.144246] systemd[1]: Reloading...1523machine # [ 49.487727] systemd[1]: Reloading finished in 341 ms.1524machine # [ 49.577147] systemd[573]: Reexecution requested from client PID 2954 ('switch-to-confi')...1525machine # [ 49.581091] systemd[573]: Reexecuting.1526machine # [ 49.639983] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1527machine # [ 49.759310] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1528machine # [ 49.766344] systemd[573]: Reload requested from client PID 2954 ('switch-to-confi')...1529machine # [ 49.770475] systemd[573]: Reloading...1530machine # [ 49.883950] systemd[573]: Reloading finished in 115 ms.1531machine # [ 49.900188] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1532machine # [ 49.910553] systemd[573]: Stopped Run user-specific NixOS activation.1533machine # [ 49.913053] systemd[573]: Stopping Run user-specific NixOS activation...1534machine # [ 49.915418] systemd[573]: Starting Run user-specific NixOS activation...1535machine # [ 49.949900] systemd[573]: Finished Run user-specific NixOS activation.1536machine # [ 49.953589] systemd[1]: Stopped target Reactivate sysinit units.1537machine # [ 49.956004] systemd[1]: Stopping Reactivate sysinit units...1538machine # [ 49.957409] systemd[1]: Reached target Reactivate sysinit units.1539machine # [ 49.960817] systemd[1]: Reached target Local File Systems.1540machine # [ 49.964788] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1541machine # [ 49.970179] systemd[1]: Starting Create SUID/SGID Wrappers...1542machine # [ 49.971125] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1543machine # [ 49.981171] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671544machine # [ 49.983493] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1545machine # [ 49.989503] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1546machine # [ 49.990855] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1547machine # [ 49.992338] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1548machine # [ 49.994312] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1549machine # [ 49.995636] systemd[1]: Reached target Remote File Systems.1550machine # [ 50.159445] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1551machine # [ 50.164973] systemd[1]: Finished Create SUID/SGID Wrappers.1552machine # [ 50.168190] systemd[1]: Starting escaped\x2ddash.service...1553machine # [ 50.171426] systemd[1]: Starting linger-users.service...1554machine # [ 50.212920] systemd[1]: Finished escaped\x2ddash.service.1555machine # [ 50.232320] systemd[1]: linger-users.service: Deactivated successfully.1556machine # [ 50.234830] systemd[1]: Finished linger-users.service.1557machine # [ 50.495578] nixos[2885]: finished switching to system configuration /nix/store/ayl8qk2992flsw39izmpzm1wh92kn8sd-nixos-system-machine-test1558machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 1.95 seconds)1559machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&11560machine # [ 50.805501] nixos[3027]: switching to system configuration /nix/store/cqcc5nlr00vgv13yf6l8in2qykbj3yba-nixos-system-machine-test1561machine # [ 50.808400] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1562machine # [ 50.812091] systemd[1]: Stopped escaped\x2ddash.service.1563machine # [ 50.813895] systemd[1]: Stopped target Remote File Systems.1564machine # [ 50.815004] systemd[1]: Stopped target Local File Systems.1565machine # [ 51.113131] systemd[1]: Reload requested from client PID 3027 ('.switch-to-conf') (unit backdoor.service)...1566machine # [ 51.115138] systemd[1]: Reloading...1567machine # [ 51.469250] systemd[1]: Reloading finished in 351 ms.1568machine # [ 51.555585] systemd[573]: Reexecution requested from client PID 3096 ('switch-to-confi')...1569machine # [ 51.559318] systemd[573]: Reexecuting.1570machine # [ 51.607158] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1571machine # [ 51.733082] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1572machine # [ 51.739793] systemd[573]: Reload requested from client PID 3096 ('switch-to-confi')...1573machine # [ 51.743344] systemd[573]: Reloading...1574machine # [ 51.855698] systemd[573]: Reloading finished in 113 ms.1575machine # [ 51.872170] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1576machine # [ 51.882423] systemd[573]: Stopped Run user-specific NixOS activation.1577machine # [ 51.883480] systemd[573]: Stopping Run user-specific NixOS activation...1578machine # [ 51.885995] systemd[573]: Starting Run user-specific NixOS activation...1579machine # [ 51.916872] systemd[573]: Finished Run user-specific NixOS activation.1580machine # [ 51.921167] systemd[1]: Stopped target Reactivate sysinit units.1581machine # [ 51.923882] systemd[1]: Stopping Reactivate sysinit units...1582machine # [ 51.927502] systemd[1]: Reached target Reactivate sysinit units.1583machine # [ 51.928777] systemd[1]: Reached target Local File Systems.1584machine # [ 51.930800] systemd[1]: Starting escaped\x2ddash.service...1585machine # [ 51.942015] systemd[1]: Reached target Remote File Systems.1586machine # [ 51.945574] systemd[1]: Starting linger-users.service...1587machine # [ 51.952532] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1588machine # [ 51.953919] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1589machine # [ 51.966066] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1590machine # [ 51.980555] systemd[1]: Starting Create SUID/SGID Wrappers...1591machine # [ 51.983052] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1592machine # [ 51.987525] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671593machine # [ 51.996576] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1594machine # [ 51.998249] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1595machine # [ 51.999465] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1596machine # [ 52.013595] systemd[1]: Finished escaped\x2ddash.service.1597machine # [ 52.044939] systemd[1]: linger-users.service: Deactivated successfully.1598machine # [ 52.048120] systemd[1]: Finished linger-users.service.1599machine # [ 52.194042] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1600machine # [ 52.197167] systemd[1]: Finished Create SUID/SGID Wrappers.1601machine # [ 52.456499] nixos[3027]: finished switching to system configuration /nix/store/cqcc5nlr00vgv13yf6l8in2qykbj3yba-nixos-system-machine-test1602machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 1.96 seconds)1603machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&11604machine # [ 52.811527] nixos[3169]: switching to system configuration /nix/store/dcgf9h247w0f4fp9ciqbz5f9j6bxybzk-nixos-system-machine-test1605machine # [ 52.815056] systemd[1]: Stopped target Local File Systems.1606machine # [ 52.817105] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1607machine # [ 52.820502] systemd[1]: Stopped escaped\x2ddash.service.1608machine # [ 52.822302] systemd[1]: Stopped target Remote File Systems.1609machine # [ 53.119622] systemd[1]: Reload requested from client PID 3169 ('.switch-to-conf') (unit backdoor.service)...1610machine # [ 53.121771] systemd[1]: Reloading...1611machine # [ 53.462232] systemd[1]: Reloading finished in 339 ms.1612machine # [ 53.552106] systemd[573]: Reexecution requested from client PID 3238 ('switch-to-confi')...1613machine # [ 53.553529] systemd[573]: Reexecuting.1614machine # [ 53.615542] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1615machine # [ 53.735162] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1616machine # [ 53.741547] systemd[573]: Reload requested from client PID 3238 ('switch-to-confi')...1617machine # [ 53.745089] systemd[573]: Reloading...1618machine # [ 53.854387] systemd[573]: Reloading finished in 110 ms.1619machine # [ 53.868162] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1620machine # [ 53.877036] systemd[573]: Stopped Run user-specific NixOS activation.1621machine # [ 53.879305] systemd[573]: Stopping Run user-specific NixOS activation...1622machine # [ 53.881443] systemd[573]: Starting Run user-specific NixOS activation...1623machine # [ 53.912090] systemd[573]: Finished Run user-specific NixOS activation.1624machine # [ 53.915506] systemd[1]: Stopped target Reactivate sysinit units.1625machine # [ 53.917969] systemd[1]: Stopping Reactivate sysinit units...1626machine # [ 53.918845] systemd[1]: Reached target Reactivate sysinit units.1627machine # [ 53.921601] systemd[1]: Reached target Local File Systems.1628machine # [ 53.926345] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1629machine # [ 53.929882] systemd[1]: Starting Create SUID/SGID Wrappers...1630machine # [ 53.930796] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1631machine # [ 53.937861] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671632machine # [ 53.949965] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1633machine # [ 53.951591] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1634machine # [ 53.953135] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1635machine # [ 53.954413] systemd[1]: Reached target Remote File Systems.1636machine # [ 53.955198] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1637machine # [ 53.956510] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1638machine # [ 54.144882] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1639machine # [ 54.150376] systemd[1]: Finished Create SUID/SGID Wrappers.1640machine # [ 54.154526] systemd[1]: Starting -.service...1641machine # [ 54.158167] systemd[1]: Starting linger-users.service...1642machine # [ 54.204190] systemd[1]: Finished -.service.1643machine # [ 54.226713] systemd[1]: linger-users.service: Deactivated successfully.1644machine # [ 54.229847] systemd[1]: Finished linger-users.service.1645machine # [ 54.490416] nixos[3169]: finished switching to system configuration /nix/store/dcgf9h247w0f4fp9ciqbz5f9j6bxybzk-nixos-system-machine-test1646machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 2.03 seconds)1647machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&11648machine # [ 54.797809] nixos[3311]: switching to system configuration /nix/store/bl6bj35qmbnnvym6gm3495fifd2aq6yd-nixos-system-machine-test1649machine # [ 54.800790] systemd[1]: Stopped target Remote File Systems.1650machine # [ 54.802697] systemd[1]: Stopped target Local File Systems.1651machine # [ 55.098297] systemd[1]: Reload requested from client PID 3311 ('.switch-to-conf') (unit backdoor.service)...1652machine # [ 55.100359] systemd[1]: Reloading...1653machine # [ 55.446876] systemd[1]: Reloading finished in 344 ms.1654machine # [ 55.537650] systemd[573]: Reexecution requested from client PID 3380 ('switch-to-confi')...1655machine # [ 55.542034] systemd[573]: Reexecuting.1656machine # [ 55.587244] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1657machine # [ 55.706701] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1658machine # [ 55.713677] systemd[573]: Reload requested from client PID 3380 ('switch-to-confi')...1659machine # [ 55.717653] systemd[573]: Reloading...1660machine # [ 55.832140] systemd[573]: Reloading finished in 115 ms.1661machine # [ 55.848285] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1662machine # [ 55.858701] systemd[573]: Stopped Run user-specific NixOS activation.1663machine # [ 55.861384] systemd[573]: Stopping Run user-specific NixOS activation...1664machine # [ 55.863829] systemd[573]: Starting Run user-specific NixOS activation...1665machine # [ 55.899056] systemd[573]: Finished Run user-specific NixOS activation.1666machine # [ 55.903556] systemd[1]: Stopped target Reactivate sysinit units.1667machine # [ 55.906132] systemd[1]: Stopping Reactivate sysinit units...1668machine # [ 55.907058] systemd[1]: Reached target Reactivate sysinit units.1669machine # [ 55.911971] systemd[1]: Reloading -.service...1670machine # [ 55.940381] systemd[1]: Reloaded -.service.1671machine # [ 55.944675] systemd[1]: Reached target Remote File Systems.1672machine # [ 55.950095] systemd[1]: Starting linger-users.service...1673machine # [ 55.962747] systemd[1]: Reached target Local File Systems.1674machine # [ 55.963791] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1675machine # [ 55.972759] systemd[1]: Starting Create SUID/SGID Wrappers...1676machine # [ 55.973750] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1677machine # [ 55.975047] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671678machine # [ 55.992821] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1679machine # [ 55.994644] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1680machine # [ 56.004244] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1681machine # [ 56.008674] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1682machine # [ 56.010204] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1683machine # [ 56.056675] systemd[1]: linger-users.service: Deactivated successfully.1684machine # [ 56.061212] systemd[1]: Finished linger-users.service.1685machine # [ 56.216878] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1686machine # [ 56.218861] systemd[1]: Finished Create SUID/SGID Wrappers.1687machine # [ 56.479311] nixos[3311]: finished switching to system configuration /nix/store/bl6bj35qmbnnvym6gm3495fifd2aq6yd-nixos-system-machine-test1688machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.99 seconds)1689machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&11690machine # [ 56.799162] nixos[3453]: switching to system configuration /nix/store/s884r6mlyc0vy9swb9k8dm5049xndy4y-nixos-system-machine-test1691machine # [ 56.802221] systemd[1]: Stopped target Local File Systems.1692machine # [ 56.804655] systemd[1]: -.service: Deactivated successfully.1693machine # [ 56.805578] systemd[1]: Stopped -.service.1694machine # [ 56.807307] systemd[1]: Stopped target Remote File Systems.1695machine # [ 57.096678] systemd[1]: Reload requested from client PID 3453 ('.switch-to-conf') (unit backdoor.service)...1696machine # [ 57.098616] systemd[1]: Reloading...1697machine # [ 57.447767] systemd[1]: Reloading finished in 347 ms.1698machine # [ 57.536110] systemd[573]: Reexecution requested from client PID 3522 ('switch-to-confi')...1699machine # [ 57.540328] systemd[573]: Reexecuting.1700machine # [ 57.595567] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1701machine # [ 57.715278] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1702machine # [ 57.723219] systemd[573]: Reload requested from client PID 3522 ('switch-to-confi')...1703machine # [ 57.726464] systemd[573]: Reloading...1704machine # [ 57.837640] systemd[573]: Reloading finished in 112 ms.1705machine # [ 57.852189] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1706machine # [ 57.861833] systemd[573]: Stopped Run user-specific NixOS activation.1707machine # [ 57.864098] systemd[573]: Stopping Run user-specific NixOS activation...1708machine # [ 57.866493] systemd[573]: Starting Run user-specific NixOS activation...1709machine # [ 57.900949] systemd[573]: Finished Run user-specific NixOS activation.1710machine # [ 57.905447] systemd[1]: Stopped target Reactivate sysinit units.1711machine # [ 57.907460] systemd[1]: Stopping Reactivate sysinit units...1712machine # [ 57.912773] systemd[1]: Reached target Reactivate sysinit units.1713machine # [ 57.913675] systemd[1]: Reached target Local File Systems.1714machine # [ 57.914447] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1715machine # [ 57.918035] systemd[1]: Starting Create SUID/SGID Wrappers...1716machine # [ 57.918972] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1717machine # [ 57.926623] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671718machine # [ 57.935928] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1719machine # [ 57.941259] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1720machine # [ 57.942518] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1721machine # [ 57.943725] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1722machine # [ 57.946734] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1723machine # [ 57.948112] systemd[1]: Reached target Remote File Systems.1724machine # [ 58.103606] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1725machine # [ 58.108211] systemd[1]: Finished Create SUID/SGID Wrappers.1726machine # [ 58.111172] systemd[1]: Starting linger-users.service...1727machine # [ 58.114942] systemd[1]: Starting required-service.service...1728machine # [ 58.117874] systemd[1]: Starting test-service.service...1729machine # [ 58.167892] systemd[1]: Finished required-service.service.1730machine # [ 58.170533] systemd[1]: Finished test-service.service.1731machine # [ 58.188755] systemd[1]: linger-users.service: Deactivated successfully.1732machine # [ 58.191528] systemd[1]: Finished linger-users.service.1733machine # [ 58.450959] nixos[3453]: finished switching to system configuration /nix/store/s884r6mlyc0vy9swb9k8dm5049xndy4y-nixos-system-machine-test1734machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.97 seconds)1735machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&11736machine # [ 58.746473] nixos[3597]: switching to system configuration /nix/store/b74p785c4xci5k45wrjf0kfbq2a6hi7i-nixos-system-machine-test1737machine # [ 58.748949] systemd[1]: Stopped target Remote File Systems.1738machine # [ 58.752742] systemd[1]: required-service.service: Deactivated successfully.1739machine # [ 58.754497] systemd[1]: Stopped required-service.service.1740machine # [ 58.755274] systemd[1]: test-service.service: Deactivated successfully.1741machine # [ 58.757008] systemd[1]: Stopped test-service.service.1742machine # [ 58.758159] systemd[1]: Stopped target Local File Systems.1743machine # [ 59.039195] systemd[1]: Reload requested from client PID 3597 ('.switch-to-conf') (unit backdoor.service)...1744machine # [ 59.041248] systemd[1]: Reloading...1745machine # [ 59.382918] systemd[1]: Reloading finished in 340 ms.1746machine # [ 59.472395] systemd[573]: Reexecution requested from client PID 3666 ('switch-to-confi')...1747machine # [ 59.476754] systemd[573]: Reexecuting.1748machine # [ 59.532231] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1749machine # [ 59.653435] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1750machine # [ 59.659965] systemd[573]: Reload requested from client PID 3666 ('switch-to-confi')...1751machine # [ 59.662440] systemd[573]: Reloading...1752machine # [ 59.777246] systemd[573]: Reloading finished in 113 ms.1753machine # [ 59.792186] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1754machine # [ 59.801187] systemd[573]: Stopped Run user-specific NixOS activation.1755machine # [ 59.803552] systemd[573]: Stopping Run user-specific NixOS activation...1756machine # [ 59.805827] systemd[573]: Starting Run user-specific NixOS activation...1757machine # [ 59.836649] systemd[573]: Finished Run user-specific NixOS activation.1758machine # [ 59.840138] systemd[1]: Stopped target Reactivate sysinit units.1759machine # [ 59.842015] systemd[1]: Stopping Reactivate sysinit units...1760machine # [ 59.843310] systemd[1]: Reached target Reactivate sysinit units.1761machine # [ 59.845846] systemd[1]: Reached target Remote File Systems.1762machine # [ 59.851542] systemd[1]: Starting linger-users.service...1763machine # [ 59.856181] systemd[1]: Starting required-service.service...1764machine # [ 59.864940] systemd[1]: Starting test-service.service...1765machine # [ 59.880120] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1766machine # [ 59.881585] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1767machine # [ 59.884729] systemd[1]: Reached target Local File Systems.1768machine # [ 59.895545] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1769machine # [ 59.906624] systemd[1]: Starting Create SUID/SGID Wrappers...1770machine # [ 59.912608] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1771machine # [ 59.920164] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671772machine # [ 59.931603] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1773machine # [ 59.944435] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1774machine # [ 59.950276] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1775machine # [ 59.951594] systemd[1]: Finished test-service.service.1776machine # [ 59.956642] systemd[1]: Finished required-service.service.1777machine # [ 59.985280] systemd[1]: linger-users.service: Deactivated successfully.1778machine # [ 59.986946] systemd[1]: Finished linger-users.service.1779machine # [ 60.128275] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1780machine # [ 60.131610] systemd[1]: Finished Create SUID/SGID Wrappers.1781machine # [ 60.389079] nixos[3597]: finished switching to system configuration /nix/store/b74p785c4xci5k45wrjf0kfbq2a6hi7i-nixos-system-machine-test1782machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.94 seconds)1783machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&11784machine # [ 60.702513] nixos[3741]: switching to system configuration /nix/store/a1dz9cpg95yb493hmrdwlf2v6pns567v-nixos-system-machine-test1785machine # [ 60.705316] systemd[1]: required-service.service: Deactivated successfully.1786machine # [ 60.709169] systemd[1]: Stopped required-service.service.1787machine # [ 60.710053] systemd[1]: test-service.service: Deactivated successfully.1788machine # [ 60.710994] systemd[1]: Stopped test-service.service.1789machine # [ 60.711738] systemd[1]: Stopped target Local File Systems.1790machine # [ 60.712820] systemd[1]: Stopped target Remote File Systems.1791machine # [ 61.015819] systemd[1]: Reload requested from client PID 3741 ('.switch-to-conf') (unit backdoor.service)...1792machine # [ 61.018252] systemd[1]: Reloading...1793machine # [ 61.394533] systemd[1]: Reloading finished in 374 ms.1794machine # [ 61.488484] systemd[573]: Reexecution requested from client PID 3810 ('switch-to-confi')...1795machine # [ 61.490012] systemd[573]: Reexecuting.1796machine # [ 61.547562] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1797machine # [ 61.669152] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1798machine # [ 61.675941] systemd[573]: Reload requested from client PID 3810 ('switch-to-confi')...1799machine # [ 61.678346] systemd[573]: Reloading...1800machine # [ 61.799351] systemd[573]: Reloading finished in 118 ms.1801machine # [ 61.814335] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1802machine # [ 61.821875] systemd[573]: Stopped Run user-specific NixOS activation.1803machine # [ 61.824076] systemd[573]: Stopping Run user-specific NixOS activation...1804machine # [ 61.826520] systemd[573]: Starting Run user-specific NixOS activation...1805machine # [ 61.862102] systemd[573]: Finished Run user-specific NixOS activation.1806machine # [ 61.866248] systemd[1]: Stopped target Reactivate sysinit units.1807machine # [ 61.869937] systemd[1]: Stopping Reactivate sysinit units...1808machine # [ 61.870873] systemd[1]: Reached target Reactivate sysinit units.1809machine # [ 61.873593] systemd[1]: Reached target Local File Systems.1810machine # [ 61.878593] systemd[1]: Starting required-service.service...1811machine # [ 61.887738] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1812machine # [ 61.896479] systemd[1]: Starting Create SUID/SGID Wrappers...1813machine # [ 61.897443] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1814machine # [ 61.898688] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671815machine # [ 61.916114] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1816machine # [ 61.917941] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1817machine # [ 61.924146] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1818machine # [ 61.925553] systemd[1]: Reached target Remote File Systems.1819machine # [ 61.928652] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1820machine # [ 61.935587] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1821machine # [ 61.938087] systemd[1]: Finished required-service.service.1822machine # [ 62.103417] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1823machine # [ 62.105682] systemd[1]: Finished Create SUID/SGID Wrappers.1824machine # [ 62.112165] systemd[1]: Starting linger-users.service...1825machine # [ 62.114901] systemd[1]: Starting test-service.service...1826machine # [ 62.156760] systemd[1]: Finished test-service.service.1827machine # [ 62.176755] systemd[1]: linger-users.service: Deactivated successfully.1828machine # [ 62.179470] systemd[1]: Finished linger-users.service.1829machine # [ 62.439207] nixos[3741]: finished switching to system configuration /nix/store/a1dz9cpg95yb493hmrdwlf2v6pns567v-nixos-system-machine-test1830machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 2.05 seconds)1831machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&11832machine # [ 62.753120] nixos[3885]: switching to system configuration /nix/store/lwqp7m90f076qn8a4m2nlbymvyh3ml1l-nixos-system-machine-test1833machine # [ 62.756145] systemd[1]: Stopped target Local File Systems.1834machine # [ 62.759911] systemd[1]: Stopped target Remote File Systems.1835machine # [ 62.761927] systemd[1]: required-service.service: Deactivated successfully.1836machine # [ 62.762974] systemd[1]: Stopped required-service.service.1837machine # [ 62.763758] systemd[1]: test-service.service: Deactivated successfully.1838machine # [ 62.764988] systemd[1]: Stopped test-service.service.1839machine # [ 63.070779] systemd[1]: Reload requested from client PID 3885 ('.switch-to-conf') (unit backdoor.service)...1840machine # [ 63.073028] systemd[1]: Reloading...1841machine # [ 63.431542] systemd[1]: Reloading finished in 357 ms.1842machine # [ 63.524732] systemd[573]: Reexecution requested from client PID 3954 ('switch-to-confi')...1843machine # [ 63.529142] systemd[573]: Reexecuting.1844machine # [ 63.588159] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1845machine # [ 63.709914] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1846machine # [ 63.716857] systemd[573]: Reload requested from client PID 3954 ('switch-to-confi')...1847machine # [ 63.720105] systemd[573]: Reloading...1848machine # [ 63.838298] systemd[573]: Reloading finished in 118 ms.1849machine # [ 63.852213] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1850machine # [ 63.863109] systemd[573]: Stopped Run user-specific NixOS activation.1851machine # [ 63.865708] systemd[573]: Stopping Run user-specific NixOS activation...1852machine # [ 63.868134] systemd[573]: Starting Run user-specific NixOS activation...1853machine # [ 63.904513] systemd[573]: Finished Run user-specific NixOS activation.1854machine # [ 63.908792] systemd[1]: Stopped target Reactivate sysinit units.1855machine # [ 63.911218] systemd[1]: Stopping Reactivate sysinit units...1856machine # [ 63.913074] systemd[1]: Reached target Reactivate sysinit units.1857machine # [ 63.915990] systemd[1]: Created slice Slice /system/instantiated.1858machine # [ 63.919605] systemd[1]: Reached target Remote File Systems.1859machine # [ 63.922949] systemd[1]: Starting instantiated@one.service...1860machine # [ 63.926496] systemd[1]: Starting instantiated@two.service...1861machine # [ 63.932961] systemd[1]: Starting linger-users.service...1862machine # [ 63.951164] systemd[1]: Reached target Local File Systems.1863machine # [ 63.956874] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1864machine # [ 63.958471] systemd[1]: Starting Create SUID/SGID Wrappers...1865machine # [ 63.959288] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1866machine # [ 63.977968] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671867machine # [ 63.988437] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1868machine # [ 64.000095] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1869machine # [ 64.008415] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1870machine # [ 64.020634] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1871machine # [ 64.022536] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1872machine # [ 64.027197] systemd[1]: Finished instantiated@two.service.1873machine # [ 64.029835] systemd[1]: Finished instantiated@one.service.1874machine # [ 64.055387] systemd[1]: linger-users.service: Deactivated successfully.1875machine # [ 64.059751] systemd[1]: Finished linger-users.service.1876machine # [ 64.201977] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1877machine # [ 64.205163] systemd[1]: Finished Create SUID/SGID Wrappers.1878machine # [ 64.466072] nixos[3885]: finished switching to system configuration /nix/store/lwqp7m90f076qn8a4m2nlbymvyh3ml1l-nixos-system-machine-test1879machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 2.02 seconds)1880machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&11881machine # [ 64.793741] nixos[4029]: switching to system configuration /nix/store/kysq67ha7ckh5dd7swpyg2k8cwq3zgm7-nixos-system-machine-test1882machine # [ 64.796356] systemd[1]: instantiated@two.service: Deactivated successfully.1883machine # [ 64.800158] systemd[1]: Stopped instantiated@two.service.1884machine # [ 64.801063] systemd[1]: instantiated@one.service: Deactivated successfully.1885machine # [ 64.802012] systemd[1]: Stopped instantiated@one.service.1886machine # [ 64.802772] systemd[1]: Stopped target Remote File Systems.1887machine # [ 64.804110] systemd[1]: Stopped target Local File Systems.1888machine # [ 65.106480] systemd[1]: Reload requested from client PID 4029 ('.switch-to-conf') (unit backdoor.service)...1889machine # [ 65.108553] systemd[1]: Reloading...1890machine # [ 65.471051] systemd[1]: Reloading finished in 359 ms.1891machine # [ 65.560450] systemd[573]: Reexecution requested from client PID 4098 ('switch-to-confi')...1892machine # [ 65.563724] systemd[573]: Reexecuting.1893machine # [ 65.619731] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1894machine # [ 65.741141] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1895machine # [ 65.747720] systemd[573]: Reload requested from client PID 4098 ('switch-to-confi')...1896machine # [ 65.751554] systemd[573]: Reloading...1897machine # [ 65.867492] systemd[573]: Reloading finished in 116 ms.1898machine # [ 65.884183] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1899machine # [ 65.893523] systemd[573]: Stopped Run user-specific NixOS activation.1900machine # [ 65.896048] systemd[573]: Stopping Run user-specific NixOS activation...1901machine # [ 65.898268] systemd[573]: Starting Run user-specific NixOS activation...1902machine # [ 65.934673] systemd[573]: Finished Run user-specific NixOS activation.1903machine # [ 65.939122] systemd[1]: Stopped target Reactivate sysinit units.1904machine # [ 65.940465] systemd[1]: Stopping Reactivate sysinit units...1905machine # [ 65.941348] systemd[1]: Reached target Reactivate sysinit units.1906machine # [ 65.947177] systemd[1]: Starting instantiated@one.service...1907machine # [ 65.956463] systemd[1]: Reached target Remote File Systems.1908machine # [ 65.960460] systemd[1]: Starting instantiated@two.service...1909machine # [ 65.965722] systemd[1]: Starting linger-users.service...1910machine # [ 65.981724] systemd[1]: Reached target Local File Systems.1911machine # [ 65.983876] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1912machine # [ 65.995542] systemd[1]: Starting Create SUID/SGID Wrappers...1913machine # [ 66.006119] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1914machine # [ 66.007410] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671915machine # [ 66.024268] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1916machine # [ 66.025976] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1917machine # [ 66.027234] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1918machine # [ 66.043964] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1919machine # [ 66.051249] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1920machine # [ 66.057638] systemd[1]: Finished instantiated@two.service.1921machine # [ 66.058509] systemd[1]: Finished instantiated@one.service.1922machine # [ 66.091813] systemd[1]: linger-users.service: Deactivated successfully.1923machine # [ 66.095988] systemd[1]: Finished linger-users.service.1924machine # [ 66.243366] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1925machine # [ 66.246797] systemd[1]: Finished Create SUID/SGID Wrappers.1926machine # [ 66.503634] nixos[4029]: finished switching to system configuration /nix/store/kysq67ha7ckh5dd7swpyg2k8cwq3zgm7-nixos-system-machine-test1927machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 2.04 seconds)1928(finished: subtest: services, in 42.15 seconds)1929subtest: failing units1930machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11931machine # [ 66.789449] nixos[4173]: switching to system configuration /nix/store/fbyc39dqamh37xihiajdl2q8sxb8bicn-nixos-system-machine-test1932machine # [ 66.792093] systemd[1]: instantiated@one.service: Deactivated successfully.1933machine # [ 66.795375] systemd[1]: Stopped instantiated@one.service.1934machine # [ 66.798290] systemd[1]: instantiated@two.service: Deactivated successfully.1935machine # [ 66.799342] systemd[1]: Stopped instantiated@two.service.1936machine # [ 66.800742] systemd[1]: Stopped target Remote File Systems.1937machine # [ 66.801603] systemd[1]: Stopped target Local File Systems.1938machine # [ 67.090228] systemd[1]: Reload requested from client PID 4173 ('.switch-to-conf') (unit backdoor.service)...1939machine # [ 67.092256] systemd[1]: Reloading...1940machine # [ 67.423512] systemd[1]: Reloading finished in 329 ms.1941machine # [ 67.514480] systemd[573]: Reexecution requested from client PID 4242 ('switch-to-confi')...1942machine # [ 67.518473] systemd[573]: Reexecuting.1943machine # [ 67.571403] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1944machine # [ 67.692156] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1945machine # [ 67.699334] systemd[573]: Reload requested from client PID 4242 ('switch-to-confi')...1946machine # [ 67.701960] systemd[573]: Reloading...1947machine # [ 67.821243] systemd[573]: Reloading finished in 118 ms.1948machine # [ 67.836191] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1949machine # [ 67.845674] systemd[573]: Stopped Run user-specific NixOS activation.1950machine # [ 67.848156] systemd[573]: Stopping Run user-specific NixOS activation...1951machine # [ 67.850498] systemd[573]: Starting Run user-specific NixOS activation...1952machine # [ 67.881822] systemd[573]: Finished Run user-specific NixOS activation.1953machine # [ 67.885613] systemd[1]: Stopped target Reactivate sysinit units.1954machine # [ 67.888694] systemd[1]: Stopping Reactivate sysinit units...1955machine # [ 67.889630] systemd[1]: Reached target Reactivate sysinit units.1956machine # [ 67.890522] systemd[1]: Reached target Remote File Systems.1957machine # [ 67.892653] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1958machine # [ 67.894041] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1959machine # [ 67.897800] systemd[1]: Reached target Local File Systems.1960machine # [ 67.903189] systemd[1]: Starting linger-users.service...1961machine # [ 67.907756] systemd[1]: Starting test.service...1962machine # [ 67.925053] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1963machine # [ 67.936994] systemd[1]: Starting Create SUID/SGID Wrappers...1964machine # [ 67.938031] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1965machine # [ 67.939299] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671966machine # [ 67.948810] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1967machine # [ 67.950535] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1968machine # [ 67.962501] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1969machine # [ 67.983316] systemd[1]: Finished test.service.1970machine # [ 68.017678] systemd[1]: linger-users.service: Deactivated successfully.1971machine # [ 68.022115] systemd[1]: Finished linger-users.service.1972machine # [ 68.164395] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1973machine # [ 68.167881] systemd[1]: Finished Create SUID/SGID Wrappers.1974machine # [ 68.430118] nixos[4173]: finished switching to system configuration /nix/store/fbyc39dqamh37xihiajdl2q8sxb8bicn-nixos-system-machine-test1975machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.92 seconds)1976machine: must fail: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&11977machine # [ 68.739477] nixos[4315]: switching to system configuration /nix/store/5z903alfz8whjpxvjjgy0v4g14cnv0xi-nixos-system-machine-test1978machine # [ 68.742675] systemd[1]: test.service: Deactivated successfully.1979machine # [ 68.746596] systemd[1]: Stopped test.service.1980machine # [ 68.748205] systemd[1]: Stopped target Remote File Systems.1981machine # [ 68.749066] systemd[1]: Stopped target Local File Systems.1982machine # [ 69.050088] systemd[1]: Reload requested from client PID 4315 ('.switch-to-conf') (unit backdoor.service)...1983machine # [ 69.052191] systemd[1]: Reloading...1984machine # [ 69.403787] systemd[1]: Reloading finished in 350 ms.1985machine # [ 69.492092] systemd[573]: Reexecution requested from client PID 4384 ('switch-to-confi')...1986machine # [ 69.496538] systemd[573]: Reexecuting.1987machine # [ 69.543470] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1988machine # [ 69.662030] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1989machine # [ 69.668563] systemd[573]: Reload requested from client PID 4384 ('switch-to-confi')...1990machine # [ 69.671136] systemd[573]: Reloading...1991machine # [ 69.782954] systemd[573]: Reloading finished in 110 ms.1992machine # [ 69.800189] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1993machine # [ 69.810524] systemd[573]: Stopped Run user-specific NixOS activation.1994machine # [ 69.812853] systemd[573]: Stopping Run user-specific NixOS activation...1995machine # [ 69.815060] systemd[573]: Starting Run user-specific NixOS activation...1996machine # [ 69.851470] systemd[573]: Finished Run user-specific NixOS activation.1997machine # [ 69.856776] systemd[1]: Stopped target Reactivate sysinit units.1998machine # [ 69.858019] systemd[1]: Stopping Reactivate sysinit units...1999machine # [ 69.858908] systemd[1]: Reached target Reactivate sysinit units.2000machine # [ 69.867060] systemd[1]: Starting test.service...2001machine # [ 69.877329] systemd[1]: Reached target Local File Systems.2002machine # [ 69.882423] systemd[1]: Reached target Remote File Systems.2003machine # [ 69.885080] systemd[1]: Starting linger-users.service...2004machine # [ 69.902420] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2005machine # [ 69.912597] systemd[1]: Starting Create SUID/SGID Wrappers...2006machine # [ 69.913634] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2007machine # [ 69.914870] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672008machine # [ 69.932184] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2009machine # [ 69.934022] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2010machine # [ 69.943449] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2011machine # [ 69.951457] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2012machine # [ 69.958145] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2013machine # [ 69.959531] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE2014machine # [ 69.967235] systemd[1]: test.service: Failed with result 'exit-code'.2015machine # [ 69.972642] systemd[1]: Failed to start test.service.2016machine # [ 70.009801] systemd[1]: linger-users.service: Deactivated successfully.2017machine # [ 70.014844] systemd[1]: Finished linger-users.service.2018machine # [ 70.163563] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2019machine # [ 70.166686] systemd[1]: Finished Create SUID/SGID Wrappers.2020machine # [ 70.467465] nixos[4315]: switching to system configuration /nix/store/5z903alfz8whjpxvjjgy0v4g14cnv0xi-nixos-system-machine-test failed (status 4)2021machine: (finished: must fail: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 2.04 seconds)2022machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12023machine # [ 70.760003] nixos[4458]: switching to system configuration /nix/store/sv89b4pay1wkwwyl0vvlc8fxn8zl2vsn-nixos-system-machine-test2024machine # [ 70.762812] systemd[1]: Stopped target Remote File Systems.2025machine # [ 70.764906] systemd[1]: Stopped target Local File Systems.2026machine # [ 71.065532] systemd[1]: Reload requested from client PID 4458 ('.switch-to-conf') (unit backdoor.service)...2027machine # [ 71.067443] systemd[1]: Reloading...2028machine # [ 71.417644] systemd[1]: Reloading finished in 348 ms.2029machine # [ 71.500748] systemd[573]: Reexecution requested from client PID 4527 ('switch-to-confi')...2030machine # [ 71.504304] systemd[573]: Reexecuting.2031machine # [ 71.559684] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2032machine # [ 71.681041] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2033machine # [ 71.687754] systemd[573]: Reload requested from client PID 4527 ('switch-to-confi')...2034machine # [ 71.691713] systemd[573]: Reloading...2035machine # [ 71.804990] systemd[573]: Reloading finished in 113 ms.2036machine # [ 71.816225] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2037machine # [ 71.825946] systemd[573]: Stopped Run user-specific NixOS activation.2038machine # [ 71.828544] systemd[573]: Stopping Run user-specific NixOS activation...2039machine # [ 71.830943] systemd[573]: Starting Run user-specific NixOS activation...2040machine # [ 71.866857] systemd[573]: Finished Run user-specific NixOS activation.2041machine # [ 71.871208] systemd[1]: Stopped target Reactivate sysinit units.2042machine # [ 71.874045] systemd[1]: Stopping Reactivate sysinit units...2043machine # [ 71.874983] systemd[1]: Reached target Reactivate sysinit units.2044machine # [ 71.878463] systemd[1]: Reached target Local File Systems.2045machine # [ 71.882895] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2046machine # [ 71.886706] systemd[1]: Starting Create SUID/SGID Wrappers...2047machine # [ 71.887744] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2048machine # [ 71.896526] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672049machine # [ 71.898989] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2050machine # [ 71.911900] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2051machine # [ 71.913502] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2052machine # [ 71.914783] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2053machine # [ 71.916543] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2054machine # [ 71.917994] systemd[1]: Reached target Remote File Systems.2055machine # [ 72.082280] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2056machine # [ 72.087470] systemd[1]: Finished Create SUID/SGID Wrappers.2057machine # [ 72.091631] systemd[1]: Started autorestart.service.2058machine # [ 72.095366] systemd[1]: Starting linger-users.service...2059machine # [ 72.137976] systemd[1]: autorestart.service: Deactivated successfully.2060machine # [ 72.163729] systemd[1]: linger-users.service: Deactivated successfully.2061machine # [ 72.165870] systemd[1]: Finished linger-users.service.2062machine # [ 72.423481] nixos[4458]: finished switching to system configuration /nix/store/sv89b4pay1wkwwyl0vvlc8fxn8zl2vsn-nixos-system-machine-test2063machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.95 seconds)2064machine # [ 72.469195] systemd[1]: Stopped autorestart.service.2065machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12066machine # [ 72.695728] nixos[4605]: switching to system configuration /nix/store/sv89b4pay1wkwwyl0vvlc8fxn8zl2vsn-nixos-system-machine-test2067machine # [ 72.698514] systemd[1]: Stopped target Remote File Systems.2068machine # [ 72.701221] systemd[1]: Stopped target Local File Systems.2069machine # [ 72.991395] systemd[1]: Reload requested from client PID 4605 ('.switch-to-conf') (unit backdoor.service)...2070machine # [ 72.993757] systemd[1]: Reloading...2071machine # [ 73.330940] systemd[1]: Reloading finished in 335 ms.2072machine # [ 73.422467] systemd[573]: Reexecution requested from client PID 4674 ('switch-to-confi')...2073machine # [ 73.427208] systemd[573]: Reexecuting.2074machine # [ 73.471661] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2075machine # [ 73.591828] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2076machine # [ 73.599198] systemd[573]: Reload requested from client PID 4674 ('switch-to-confi')...2077machine # [ 73.602849] systemd[573]: Reloading...2078machine # [ 73.720622] systemd[573]: Reloading finished in 118 ms.2079machine # [ 73.736225] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2080machine # [ 73.745894] systemd[573]: Stopped Run user-specific NixOS activation.2081machine # [ 73.748510] systemd[573]: Stopping Run user-specific NixOS activation...2082machine # [ 73.750874] systemd[573]: Starting Run user-specific NixOS activation...2083machine # [ 73.787266] systemd[573]: Finished Run user-specific NixOS activation.2084machine # [ 73.791482] systemd[1]: Stopped target Reactivate sysinit units.2085machine # [ 73.794981] systemd[1]: Stopping Reactivate sysinit units...2086machine # [ 73.795918] systemd[1]: Reached target Reactivate sysinit units.2087machine # [ 73.797843] systemd[1]: Reached target Local File Systems.2088machine # [ 73.801077] systemd[1]: Reached target Remote File Systems.2089machine # [ 73.808442] systemd[1]: Started autorestart.service.2090machine # [ 73.812582] systemd[1]: Starting linger-users.service...2091machine # [ 73.822019] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2092machine # [ 73.823685] systemd[1]: Starting Create SUID/SGID Wrappers...2093machine # [ 73.840075] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2094machine # [ 73.841527] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672095machine # [ 73.843712] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2096machine # [ 73.851235] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2097machine # [ 73.852683] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2098machine # [ 73.853928] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2099machine # [ 73.855254] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2100machine # [ 73.893311] systemd[1]: autorestart.service: Deactivated successfully.2101machine # [ 73.930091] systemd[1]: linger-users.service: Deactivated successfully.2102machine # [ 73.932427] systemd[1]: Finished linger-users.service.2103machine # [ 74.081556] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2104machine # [ 74.083505] systemd[1]: Finished Create SUID/SGID Wrappers.2105machine # [ 74.345223] nixos[4605]: finished switching to system configuration /nix/store/sv89b4pay1wkwwyl0vvlc8fxn8zl2vsn-nixos-system-machine-test2106machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.88 seconds)2107machine # [ 74.417027] systemd[1]: Stopped autorestart.service.2108machine: must fail: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&12109machine # [ 74.693996] nixos[4752]: switching to system configuration /nix/store/25filfwx0pc8278ccxkncciqz80v3j2k-nixos-system-machine-test2110machine # [ 74.696597] systemd[1]: Stopped target Local File Systems.2111machine # [ 74.698911] systemd[1]: Stopped target Remote File Systems.2112machine # [ 75.003588] systemd[1]: Reload requested from client PID 4752 ('.switch-to-conf') (unit backdoor.service)...2113machine # [ 75.005812] systemd[1]: Reloading...2114machine # [ 75.357818] systemd[1]: Reloading finished in 350 ms.2115machine # [ 75.447857] systemd[573]: Reexecution requested from client PID 4821 ('switch-to-confi')...2116machine # [ 75.450140] systemd[573]: Reexecuting.2117machine # [ 75.499854] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2118machine # [ 75.619644] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2119machine # [ 75.626619] systemd[573]: Reload requested from client PID 4821 ('switch-to-confi')...2120machine # [ 75.629190] systemd[573]: Reloading...2121machine # [ 75.747186] systemd[573]: Reloading finished in 117 ms.2122machine # [ 75.764187] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2123machine # [ 75.775588] systemd[573]: Stopped Run user-specific NixOS activation.2124machine # [ 75.778266] systemd[573]: Stopping Run user-specific NixOS activation...2125machine # [ 75.780816] systemd[573]: Starting Run user-specific NixOS activation...2126machine # [ 75.813621] systemd[573]: Finished Run user-specific NixOS activation.2127machine # [ 75.818129] systemd[1]: Stopped target Reactivate sysinit units.2128machine # [ 75.820934] systemd[1]: Stopping Reactivate sysinit units...2129machine # [ 75.821887] systemd[1]: Reached target Reactivate sysinit units.2130machine # [ 75.825119] systemd[1]: Reached target Remote File Systems.2131machine # [ 75.831730] systemd[1]: Started autorestart.service.2132machine # [ 75.837251] systemd[1]: Starting linger-users.service...2133machine # [ 75.856868] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2134machine # [ 75.858447] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2135machine # [ 75.859747] systemd[1]: Reached target Local File Systems.2136machine # [ 75.873901] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2137machine # [ 75.879261] systemd[1]: Starting Create SUID/SGID Wrappers...2138machine # [ 75.884488] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2139machine # [ 75.885974] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672140machine # [ 75.895858] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2141machine # [ 75.905633] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2142machine # [ 75.907225] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2143machine # [ 75.914872] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE2144machine # [ 75.921327] systemd[1]: autorestart.service: Failed with result 'exit-code'.2145machine # [ 75.947946] systemd[1]: linger-users.service: Deactivated successfully.2146machine # [ 75.951450] systemd[1]: Finished linger-users.service.2147machine # [ 76.107698] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2148machine # [ 76.110716] systemd[1]: Finished Create SUID/SGID Wrappers.2149machine # [ 76.410706] nixos[4752]: switching to system configuration /nix/store/25filfwx0pc8278ccxkncciqz80v3j2k-nixos-system-machine-test failed (status 4)2150machine: (finished: must fail: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.99 seconds)2151(finished: subtest: failing units, in 9.91 seconds)2152subtest: unit file parser2153machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12154machine # [ 76.684342] nixos[4895]: switching to system configuration /nix/store/hb6224q4069xw5wng9rddmckhna98vcz-nixos-system-machine-test2155machine # [ 76.687059] systemd[1]: Stopped target Local File Systems.2156machine # [ 76.689518] systemd[1]: Stopped target Remote File Systems.2157machine # [ 76.691193] systemd[1]: Stopped autorestart.service.2158machine # [ 76.974068] systemd[1]: Reload requested from client PID 4895 ('.switch-to-conf') (unit backdoor.service)...2159machine # [ 76.975677] systemd[1]: Reloading...2160machine # [ 77.337447] systemd[1]: Reloading finished in 360 ms.2161machine # [ 77.430457] systemd[573]: Reexecution requested from client PID 4964 ('switch-to-confi')...2162machine # [ 77.431914] systemd[573]: Reexecuting.2163machine # [ 77.487386] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2164machine # [ 77.606500] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2165machine # [ 77.612956] systemd[573]: Reload requested from client PID 4964 ('switch-to-confi')...2166machine # [ 77.615295] systemd[573]: Reloading...2167machine # [ 77.730247] systemd[573]: Reloading finished in 114 ms.2168machine # [ 77.744197] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2169machine # [ 77.754213] systemd[573]: Stopped Run user-specific NixOS activation.2170machine # [ 77.755324] systemd[573]: Stopping Run user-specific NixOS activation...2171machine # [ 77.757931] systemd[573]: Starting Run user-specific NixOS activation...2172machine # [ 77.788906] systemd[573]: Finished Run user-specific NixOS activation.2173machine # [ 77.792659] systemd[1]: Stopped target Reactivate sysinit units.2174machine # [ 77.795997] systemd[1]: Stopping Reactivate sysinit units...2175machine # [ 77.796988] systemd[1]: Reached target Reactivate sysinit units.2176machine # [ 77.800501] systemd[1]: Reached target Remote File Systems.2177machine # [ 77.804130] systemd[1]: Starting linger-users.service...2178machine # [ 77.807539] systemd[1]: Starting test.service...2179machine # [ 77.822211] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2180machine # [ 77.823678] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2181machine # [ 77.839165] systemd[1]: Reached target Local File Systems.2182machine # [ 77.845641] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2183machine # [ 77.854605] systemd[1]: Starting Create SUID/SGID Wrappers...2184machine # [ 77.859772] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2185machine # [ 77.863638] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672186machine # [ 77.870625] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2187machine # [ 77.876342] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2188machine # [ 77.879108] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2189machine # [ 77.883559] systemd[1]: Finished test.service.2190machine # [ 77.921440] systemd[1]: linger-users.service: Deactivated successfully.2191machine # [ 77.923896] systemd[1]: Finished linger-users.service.2192machine # [ 78.071274] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2193machine # [ 78.074020] systemd[1]: Finished Create SUID/SGID Wrappers.2194machine # [ 78.332913] nixos[4895]: finished switching to system configuration /nix/store/hb6224q4069xw5wng9rddmckhna98vcz-nixos-system-machine-test2195machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.92 seconds)2196machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&12197machine # [ 78.602995] nixos[5037]: switching to system configuration /nix/store/sxw072v3x7jpdc1cxf6n7m6sx2bwlahs-nixos-system-machine-test2198machine # [ 78.606176] systemd[1]: Stopped target Remote File Systems.2199machine # [ 78.608830] systemd[1]: Stopped target Local File Systems.2200machine # [ 78.925691] systemd[1]: Reload requested from client PID 5037 ('.switch-to-conf') (unit backdoor.service)...2201machine # [ 78.927745] systemd[1]: Reloading...2202machine # [ 79.276293] systemd[1]: Reloading finished in 346 ms.2203machine # [ 79.371289] systemd[573]: Reexecution requested from client PID 5106 ('switch-to-confi')...2204machine # [ 79.373467] systemd[573]: Reexecuting.2205machine # [ 79.427192] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2206machine # [ 79.547397] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2207machine # [ 79.554024] systemd[573]: Reload requested from client PID 5106 ('switch-to-confi')...2208machine # [ 79.556545] systemd[573]: Reloading...2209machine # [ 79.664797] systemd[573]: Reloading finished in 107 ms.2210machine # [ 79.680179] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2211machine # [ 79.689567] systemd[573]: Stopped Run user-specific NixOS activation.2212machine # [ 79.691973] systemd[573]: Stopping Run user-specific NixOS activation...2213machine # [ 79.694304] systemd[573]: Starting Run user-specific NixOS activation...2214machine # [ 79.725175] systemd[573]: Finished Run user-specific NixOS activation.2215machine # [ 79.728709] systemd[1]: Stopped target Reactivate sysinit units.2216machine # [ 79.730744] systemd[1]: Stopping Reactivate sysinit units...2217machine # [ 79.731602] systemd[1]: Reached target Reactivate sysinit units.2218machine # [ 79.735303] systemd[1]: test.service: Deactivated successfully.2219machine # [ 79.738895] systemd[1]: Stopped test.service.2220machine # [ 79.739675] systemd[1]: Stopping test.service...2221machine # [ 79.740880] systemd[1]: Starting test.service...2222machine # [ 79.765532] systemd[1]: Finished test.service.2223machine # [ 79.768719] systemd[1]: Reached target Local File Systems.2224machine # [ 79.773645] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2225machine # [ 79.777753] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2226machine # [ 79.780188] systemd[1]: Reached target Remote File Systems.2227machine # [ 79.784492] systemd[1]: Starting linger-users.service...2228machine # [ 79.795881] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2229machine # [ 79.804222] systemd[1]: Starting Create SUID/SGID Wrappers...2230machine # [ 79.805222] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2231machine # [ 79.806427] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672232machine # [ 79.814292] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2233machine # [ 79.815913] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2234machine # [ 79.823989] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2235machine # [ 79.864899] systemd[1]: linger-users.service: Deactivated successfully.2236machine # [ 79.868421] systemd[1]: Finished linger-users.service.2237machine # [ 80.011741] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2238machine # [ 80.013799] systemd[1]: Finished Create SUID/SGID Wrappers.2239machine # [ 80.274219] nixos[5037]: finished switching to system configuration /nix/store/sxw072v3x7jpdc1cxf6n7m6sx2bwlahs-nixos-system-machine-test2240machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.95 seconds)2241machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&12242machine # [ 80.578508] nixos[5179]: switching to system configuration /nix/store/dhvyzl1xmvl6c9yk49rhj87mlh6klb0b-nixos-system-machine-test2243machine # [ 80.583941] systemd[1]: Stopped target Local File Systems.2244machine # [ 80.586332] systemd[1]: Stopped target Remote File Systems.2245machine # [ 80.879862] systemd[1]: Reload requested from client PID 5179 ('.switch-to-conf') (unit backdoor.service)...2246machine # [ 80.882035] systemd[1]: Reloading...2247machine # [ 81.233170] systemd[1]: Reloading finished in 349 ms.2248machine # [ 81.329817] systemd[573]: Reexecution requested from client PID 5248 ('switch-to-confi')...2249machine # [ 81.333648] systemd[573]: Reexecuting.2250machine # [ 81.391431] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2251machine # [ 81.516176] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2252machine # [ 81.522999] systemd[573]: Reload requested from client PID 5248 ('switch-to-confi')...2253machine # [ 81.526979] systemd[573]: Reloading...2254machine # [ 81.639967] systemd[573]: Reloading finished in 114 ms.2255machine # [ 81.656188] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2256machine # [ 81.666095] systemd[573]: Stopped Run user-specific NixOS activation.2257machine # [ 81.668541] systemd[573]: Stopping Run user-specific NixOS activation...2258machine # [ 81.670812] systemd[573]: Starting Run user-specific NixOS activation...2259machine # [ 81.704622] systemd[573]: Finished Run user-specific NixOS activation.2260machine # [ 81.708987] systemd[1]: Stopped target Reactivate sysinit units.2261machine # [ 81.710955] systemd[1]: Stopping Reactivate sysinit units...2262machine # [ 81.711834] systemd[1]: Reached target Reactivate sysinit units.2263machine # [ 81.716282] systemd[1]: test.service: Deactivated successfully.2264machine # [ 81.717213] systemd[1]: Stopped test.service.2265machine # [ 81.717898] systemd[1]: Stopping test.service...2266machine # [ 81.720439] systemd[1]: Starting test.service...2267machine # [ 81.745987] systemd[1]: Finished test.service.2268machine # [ 81.748745] systemd[1]: Reached target Local File Systems.2269machine # [ 81.751983] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2270machine # [ 81.753890] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2271machine # [ 81.759488] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2272machine # [ 81.765804] systemd[1]: Starting Create SUID/SGID Wrappers...2273machine # [ 81.766718] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2274machine # [ 81.767944] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672275machine # [ 81.779604] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2276machine # [ 81.782457] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2277machine # [ 81.783755] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2278machine # [ 81.785082] systemd[1]: Reached target Remote File Systems.2279machine # [ 81.941798] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2280machine # [ 81.946755] systemd[1]: Finished Create SUID/SGID Wrappers.2281machine # [ 81.949236] systemd[1]: Starting linger-users.service...2282machine # [ 81.990588] systemd[1]: linger-users.service: Deactivated successfully.2283machine # [ 81.992589] systemd[1]: Finished linger-users.service.2284machine # [ 82.249608] nixos[5179]: finished switching to system configuration /nix/store/dhvyzl1xmvl6c9yk49rhj87mlh6klb0b-nixos-system-machine-test2285machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.97 seconds)2286machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12287machine # [ 82.481182] nixos[5321]: switching to system configuration /nix/store/hb6224q4069xw5wng9rddmckhna98vcz-nixos-system-machine-test2288machine # [ 82.484967] systemd[1]: Stopped target Local File Systems.2289machine # [ 82.487174] systemd[1]: Stopped target Remote File Systems.2290machine # [ 82.749955] systemd[1]: Reload requested from client PID 5321 ('.switch-to-conf') (unit backdoor.service)...2291machine # [ 82.751833] systemd[1]: Reloading...2292machine # [ 83.076916] systemd[1]: Reloading finished in 323 ms.2293machine # [ 83.166943] systemd[573]: Reexecution requested from client PID 5390 ('switch-to-confi')...2294machine # [ 83.170524] systemd[573]: Reexecuting.2295machine # [ 83.231678] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2296machine # [ 83.355891] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2297machine # [ 83.362606] systemd[573]: Reload requested from client PID 5390 ('switch-to-confi')...2298machine # [ 83.365143] systemd[573]: Reloading...2299machine # [ 83.477766] systemd[573]: Reloading finished in 111 ms.2300machine # [ 83.492180] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2301machine # [ 83.502110] systemd[573]: Stopped Run user-specific NixOS activation.2302machine # [ 83.504441] systemd[573]: Stopping Run user-specific NixOS activation...2303machine # [ 83.506579] systemd[573]: Starting Run user-specific NixOS activation...2304machine # [ 83.537036] systemd[573]: Finished Run user-specific NixOS activation.2305machine # [ 83.540640] systemd[1]: Stopped target Reactivate sysinit units.2306machine # [ 83.542946] systemd[1]: Stopping Reactivate sysinit units...2307machine # [ 83.543858] systemd[1]: Reached target Reactivate sysinit units.2308machine # [ 83.548764] systemd[1]: test.service: Deactivated successfully.2309machine # [ 83.549703] systemd[1]: Stopped test.service.2310machine # [ 83.550360] systemd[1]: Stopping test.service...2311machine # [ 83.551058] systemd[1]: Starting test.service...2312machine # [ 83.577836] systemd[1]: Finished test.service.2313machine # [ 83.582161] systemd[1]: Reached target Remote File Systems.2314machine # [ 83.587796] systemd[1]: Reached target Local File Systems.2315machine # [ 83.591213] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2316machine # [ 83.595490] systemd[1]: Starting Create SUID/SGID Wrappers...2317machine # [ 83.600576] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2318machine # [ 83.601932] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672319machine # [ 83.612378] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2320machine # [ 83.614435] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2321machine # [ 83.615825] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2322machine # [ 83.617227] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2323machine # [ 83.618753] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2324machine # [ 83.805164] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2325machine # [ 83.811009] systemd[1]: Finished Create SUID/SGID Wrappers.2326machine # [ 83.813800] systemd[1]: Starting linger-users.service...2327machine # [ 83.863113] systemd[1]: linger-users.service: Deactivated successfully.2328machine # [ 83.865143] systemd[1]: Finished linger-users.service.2329machine # [ 84.124966] nixos[5321]: finished switching to system configuration /nix/store/hb6224q4069xw5wng9rddmckhna98vcz-nixos-system-machine-test2330machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.88 seconds)2331machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&12332machine # [ 84.441751] nixos[5463]: switching to system configuration /nix/store/mhn5p1ikhahp6bdaahb43753g74g2yqn-nixos-system-machine-test2333machine # [ 84.444356] systemd[1]: Stopped target Local File Systems.2334machine # [ 84.446834] systemd[1]: Stopped target Remote File Systems.2335machine # [ 84.745275] systemd[1]: Reload requested from client PID 5463 ('.switch-to-conf') (unit backdoor.service)...2336machine # [ 84.747266] systemd[1]: Reloading...2337machine # [ 85.095842] systemd[1]: Reloading finished in 346 ms.2338machine # [ 85.185753] systemd[573]: Reexecution requested from client PID 5532 ('switch-to-confi')...2339machine # [ 85.189942] systemd[573]: Reexecuting.2340machine # [ 85.248087] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2341machine # [ 85.377433] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2342machine # [ 85.384653] systemd[573]: Reload requested from client PID 5532 ('switch-to-confi')...2343machine # [ 85.387460] systemd[573]: Reloading...2344machine # [ 85.505363] systemd[573]: Reloading finished in 116 ms.2345machine # [ 85.520390] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2346machine # [ 85.531774] systemd[573]: Stopped Run user-specific NixOS activation.2347machine # [ 85.534349] systemd[573]: Stopping Run user-specific NixOS activation...2348machine # [ 85.536554] systemd[573]: Starting Run user-specific NixOS activation...2349machine # [ 85.570658] systemd[573]: Finished Run user-specific NixOS activation.2350machine # [ 85.574429] systemd[1]: Stopped target Reactivate sysinit units.2351machine # [ 85.577646] systemd[1]: Stopping Reactivate sysinit units...2352machine # [ 85.578568] systemd[1]: Reached target Reactivate sysinit units.2353machine # [ 85.580952] systemd[1]: Reached target Remote File Systems.2354machine # [ 85.585580] systemd[1]: Starting linger-users.service...2355machine # [ 85.595729] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2356machine # [ 85.599012] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2357machine # [ 85.601745] systemd[1]: Reached target Local File Systems.2358machine # [ 85.603876] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2359machine # [ 85.611877] systemd[1]: Starting Create SUID/SGID Wrappers...2360machine # [ 85.617355] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2361machine # [ 85.624404] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672362machine # [ 85.628689] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2363machine # [ 85.630320] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2364machine # [ 85.631558] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2365machine # [ 85.677437] systemd[1]: linger-users.service: Deactivated successfully.2366machine # [ 85.681853] systemd[1]: Finished linger-users.service.2367machine # [ 85.861338] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2368machine # [ 85.864419] systemd[1]: Finished Create SUID/SGID Wrappers.2369machine # [ 86.123172] nixos[5463]: finished switching to system configuration /nix/store/mhn5p1ikhahp6bdaahb43753g74g2yqn-nixos-system-machine-test2370machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 2.00 seconds)2371machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&12372machine # [ 86.436557] nixos[5603]: switching to system configuration /nix/store/chh5b3q4zwljq0yp7yv8ia415kn90fkv-nixos-system-machine-test2373machine # [ 86.439483] systemd[1]: Stopped target Remote File Systems.2374machine # [ 86.442003] systemd[1]: Stopped target Local File Systems.2375machine # [ 86.738564] systemd[1]: Reload requested from client PID 5603 ('.switch-to-conf') (unit backdoor.service)...2376machine # [ 86.740601] systemd[1]: Reloading...2377machine # [ 87.081265] systemd[1]: Reloading finished in 339 ms.2378machine # [ 87.167581] systemd[573]: Reexecution requested from client PID 5672 ('switch-to-confi')...2379machine # [ 87.171242] systemd[573]: Reexecuting.2380machine # [ 87.227361] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2381machine # [ 87.346658] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2382machine # [ 87.353296] systemd[573]: Reload requested from client PID 5672 ('switch-to-confi')...2383machine # [ 87.355783] systemd[573]: Reloading...2384machine # [ 87.468956] systemd[573]: Reloading finished in 112 ms.2385machine # [ 87.484176] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2386machine # [ 87.493085] systemd[573]: Stopped Run user-specific NixOS activation.2387machine # [ 87.495432] systemd[573]: Stopping Run user-specific NixOS activation...2388machine # [ 87.497618] systemd[573]: Starting Run user-specific NixOS activation...2389machine # [ 87.528547] systemd[573]: Finished Run user-specific NixOS activation.2390machine # [ 87.532826] systemd[1]: Stopped target Reactivate sysinit units.2391machine # [ 87.533843] systemd[1]: Stopping Reactivate sysinit units...2392machine # [ 87.534621] systemd[1]: Reached target Reactivate sysinit units.2393machine # [ 87.539133] systemd[1]: test.service: Deactivated successfully.2394machine # [ 87.540459] systemd[1]: Stopped test.service.2395machine # [ 87.541155] systemd[1]: Stopping test.service...2396machine # [ 87.542892] systemd[1]: Starting test.service...2397machine # [ 87.572126] systemd[1]: Finished test.service.2398machine # [ 87.577660] systemd[1]: Reached target Remote File Systems.2399machine # [ 87.581081] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2400machine # [ 87.584451] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2401machine # [ 87.589962] systemd[1]: Starting linger-users.service...2402machine # [ 87.593210] systemd[1]: Reached target Local File Systems.2403machine # [ 87.602010] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2404machine # [ 87.603632] systemd[1]: Starting Create SUID/SGID Wrappers...2405machine # [ 87.610739] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2406machine # [ 87.614973] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672407machine # [ 87.617470] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2408machine # [ 87.619028] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2409machine # [ 87.623083] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2410machine # [ 87.675013] systemd[1]: linger-users.service: Deactivated successfully.2411machine # [ 87.677094] systemd[1]: Finished linger-users.service.2412machine # [ 87.814873] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2413machine # [ 87.818312] systemd[1]: Finished Create SUID/SGID Wrappers.2414machine # [ 88.076679] nixos[5603]: finished switching to system configuration /nix/store/chh5b3q4zwljq0yp7yv8ia415kn90fkv-nixos-system-machine-test2415machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.95 seconds)2416machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&12417machine # [ 88.387774] nixos[5745]: switching to system configuration /nix/store/jngl5b5bp2bs3zqwzz9qklxdzcwv0p1b-nixos-system-machine-test2418machine # [ 88.390307] systemd[1]: Stopped target Remote File Systems.2419machine # [ 88.392639] systemd[1]: Stopped target Local File Systems.2420machine # [ 88.695611] systemd[1]: Reload requested from client PID 5745 ('.switch-to-conf') (unit backdoor.service)...2421machine # [ 88.697883] systemd[1]: Reloading...2422machine # [ 89.094401] systemd[1]: Reloading finished in 394 ms.2423machine # [ 89.192536] systemd[573]: Reexecution requested from client PID 5814 ('switch-to-confi')...2424machine # [ 89.197129] systemd[573]: Reexecuting.2425machine # [ 89.256527] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2426machine # [ 89.380197] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2427machine # [ 89.387310] systemd[573]: Reload requested from client PID 5814 ('switch-to-confi')...2428machine # [ 89.391732] systemd[573]: Reloading...2429machine # [ 89.515509] systemd[573]: Reloading finished in 125 ms.2430machine # [ 89.532247] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2431machine # [ 89.543786] systemd[573]: Stopped Run user-specific NixOS activation.2432machine # [ 89.545107] systemd[573]: Stopping Run user-specific NixOS activation...2433machine # [ 89.547644] systemd[573]: Starting Run user-specific NixOS activation...2434machine # [ 89.583964] systemd[573]: Finished Run user-specific NixOS activation.2435machine # [ 89.588610] systemd[1]: Stopped target Reactivate sysinit units.2436machine # [ 89.590805] systemd[1]: Stopping Reactivate sysinit units...2437machine # [ 89.591779] systemd[1]: Reached target Reactivate sysinit units.2438machine # [ 89.596855] systemd[1]: test.service: Deactivated successfully.2439machine # [ 89.597806] systemd[1]: Stopped test.service.2440machine # [ 89.598440] systemd[1]: Stopping test.service...2441machine # [ 89.600419] systemd[1]: Starting test.service...2442machine # [ 89.629497] systemd[1]: Finished test.service.2443machine # [ 89.633288] systemd[1]: Reached target Local File Systems.2444machine # [ 89.637396] systemd[1]: Reached target Remote File Systems.2445machine # [ 89.639989] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2446machine # [ 89.642350] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2447machine # [ 89.651135] systemd[1]: Starting linger-users.service...2448machine # [ 89.660180] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2449machine # [ 89.667748] systemd[1]: Starting Create SUID/SGID Wrappers...2450machine # [ 89.673126] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2451machine # [ 89.674470] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672452machine # [ 89.681670] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2453machine # [ 89.683474] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2454machine # [ 89.685052] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2455machine # [ 89.756685] systemd[1]: linger-users.service: Deactivated successfully.2456machine # [ 89.759926] systemd[1]: Finished linger-users.service.2457machine # [ 89.901872] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2458machine # [ 89.904703] systemd[1]: Finished Create SUID/SGID Wrappers.2459machine # [ 90.163566] nixos[5745]: finished switching to system configuration /nix/store/jngl5b5bp2bs3zqwzz9qklxdzcwv0p1b-nixos-system-machine-test2460machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 2.09 seconds)2461machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&12462machine # [ 90.535723] nixos[5887]: switching to system configuration /nix/store/xkhxvbvxgj4w9dbg9w8zifvakzlx2zhx-nixos-system-machine-test2463machine # [ 90.538988] systemd[1]: Stopped target Local File Systems.2464machine # [ 90.542047] systemd[1]: Stopped target Remote File Systems.2465machine # [ 90.843302] systemd[1]: Reload requested from client PID 5887 ('.switch-to-conf') (unit backdoor.service)...2466machine # [ 90.845351] systemd[1]: Reloading...2467machine # [ 91.181587] systemd[1]: Reloading finished in 334 ms.2468machine # [ 91.269860] systemd[573]: Reexecution requested from client PID 5956 ('switch-to-confi')...2469machine # [ 91.274226] systemd[573]: Reexecuting.2470machine # [ 91.327524] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2471machine # [ 91.443345] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2472machine # [ 91.450033] systemd[573]: Reload requested from client PID 5956 ('switch-to-confi')...2473machine # [ 91.452538] systemd[573]: Reloading...2474machine # [ 91.564178] systemd[573]: Reloading finished in 110 ms.2475machine # [ 91.580185] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2476machine # [ 91.590415] systemd[573]: Stopped Run user-specific NixOS activation.2477machine # [ 91.591484] systemd[573]: Stopping Run user-specific NixOS activation...2478machine # [ 91.594299] systemd[573]: Starting Run user-specific NixOS activation...2479machine # [ 91.624101] systemd[573]: Finished Run user-specific NixOS activation.2480machine # [ 91.627855] systemd[1]: Stopped target Reactivate sysinit units.2481machine # [ 91.629699] systemd[1]: Stopping Reactivate sysinit units...2482machine # [ 91.630520] systemd[1]: Reached target Reactivate sysinit units.2483machine # [ 91.634410] systemd[1]: test.service: Deactivated successfully.2484machine # [ 91.635343] systemd[1]: Stopped test.service.2485machine # [ 91.635984] systemd[1]: Stopping test.service...2486machine # [ 91.638361] systemd[1]: Starting test.service...2487machine # [ 91.661465] systemd[1]: Finished test.service.2488machine # [ 91.667736] systemd[1]: Reached target Remote File Systems.2489machine # [ 91.673466] systemd[1]: Starting linger-users.service...2490machine # [ 91.682590] systemd[1]: Reached target Local File Systems.2491machine # [ 91.684770] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2492machine # [ 91.692568] systemd[1]: Starting Create SUID/SGID Wrappers...2493machine # [ 91.693485] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2494machine # [ 91.694719] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672495machine # [ 91.712242] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2496machine # [ 91.713904] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2497machine # [ 91.715176] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2498machine # [ 91.723121] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2499machine # [ 91.727086] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2500machine # [ 91.758273] systemd[1]: linger-users.service: Deactivated successfully.2501machine # [ 91.761540] systemd[1]: Finished linger-users.service.2502machine # [ 91.906685] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2503machine # [ 91.909960] systemd[1]: Finished Create SUID/SGID Wrappers.2504machine # [ 92.166801] nixos[5887]: finished switching to system configuration /nix/store/xkhxvbvxgj4w9dbg9w8zifvakzlx2zhx-nixos-system-machine-test2505machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 2.00 seconds)2506machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12507machine # [ 92.442557] nixos[6029]: switching to system configuration /nix/store/hb6224q4069xw5wng9rddmckhna98vcz-nixos-system-machine-test2508machine # [ 92.445106] systemd[1]: Stopped target Remote File Systems.2509machine # [ 92.447507] systemd[1]: Stopped target Local File Systems.2510machine # [ 92.720908] systemd[1]: Reload requested from client PID 6029 ('.switch-to-conf') (unit backdoor.service)...2511machine # [ 92.722875] systemd[1]: Reloading...2512machine # [ 93.051466] systemd[1]: Reloading finished in 326 ms.2513machine # [ 93.140441] systemd[573]: Reexecution requested from client PID 6098 ('switch-to-confi')...2514machine # [ 93.144002] systemd[573]: Reexecuting.2515machine # [ 93.208905] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2516machine # [ 93.331215] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2517machine # [ 93.338062] systemd[573]: Reload requested from client PID 6098 ('switch-to-confi')...2518machine # [ 93.342059] systemd[573]: Reloading...2519machine # [ 93.460831] systemd[573]: Reloading finished in 119 ms.2520machine # [ 93.476175] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2521machine # [ 93.487327] systemd[573]: Stopped Run user-specific NixOS activation.2522machine # [ 93.488456] systemd[573]: Stopping Run user-specific NixOS activation...2523machine # [ 93.490736] systemd[573]: Starting Run user-specific NixOS activation...2524machine # [ 93.525179] systemd[573]: Finished Run user-specific NixOS activation.2525machine # [ 93.529913] systemd[1]: Stopped target Reactivate sysinit units.2526machine # [ 93.531250] systemd[1]: Stopping Reactivate sysinit units...2527machine # [ 93.533373] systemd[1]: Reached target Reactivate sysinit units.2528machine # [ 93.536485] systemd[1]: test.service: Deactivated successfully.2529machine # [ 93.537466] systemd[1]: Stopped test.service.2530machine # [ 93.538116] systemd[1]: Stopping test.service...2531machine # [ 93.541055] systemd[1]: Starting test.service...2532machine # [ 93.566501] systemd[1]: Finished test.service.2533machine # [ 93.571894] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2534machine # [ 93.575969] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2535machine # [ 93.579858] systemd[1]: Reached target Local File Systems.2536machine # [ 93.583051] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2537machine # [ 93.590686] systemd[1]: Starting Create SUID/SGID Wrappers...2538machine # [ 93.591584] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2539machine # [ 93.596825] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672540machine # [ 93.599120] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2541machine # [ 93.604902] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2542machine # [ 93.606292] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2543machine # [ 93.607470] systemd[1]: Reached target Remote File Systems.2544machine # [ 93.779210] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2545machine # [ 93.784515] systemd[1]: Finished Create SUID/SGID Wrappers.2546machine # [ 93.786762] systemd[1]: Starting linger-users.service...2547machine # [ 93.830048] systemd[1]: linger-users.service: Deactivated successfully.2548machine # [ 93.832844] systemd[1]: Finished linger-users.service.2549machine # [ 94.090840] nixos[6029]: finished switching to system configuration /nix/store/hb6224q4069xw5wng9rddmckhna98vcz-nixos-system-machine-test2550machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.92 seconds)2551machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&12552machine # [ 94.383938] nixos[6171]: switching to system configuration /nix/store/9k7lm208rl7abm0wbdzlg61nr0ls67mi-nixos-system-machine-test2553machine # [ 94.386798] systemd[1]: Stopped target Remote File Systems.2554machine # [ 94.389121] systemd[1]: Stopped target Local File Systems.2555machine # [ 94.670918] systemd[1]: Reload requested from client PID 6171 ('.switch-to-conf') (unit backdoor.service)...2556machine # [ 94.672960] systemd[1]: Reloading...2557machine # [ 95.006713] systemd[1]: Reloading finished in 332 ms.2558machine # [ 95.103260] systemd[573]: Reexecution requested from client PID 6240 ('switch-to-confi')...2559machine # [ 95.106032] systemd[573]: Reexecuting.2560machine # [ 95.167585] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2561machine # [ 95.285094] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2562machine # [ 95.291730] systemd[573]: Reload requested from client PID 6240 ('switch-to-confi')...2563machine # [ 95.295247] systemd[573]: Reloading...2564machine # [ 95.409150] systemd[573]: Reloading finished in 115 ms.2565machine # [ 95.424169] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2566machine # [ 95.432993] systemd[573]: Stopped Run user-specific NixOS activation.2567machine # [ 95.435268] systemd[573]: Stopping Run user-specific NixOS activation...2568machine # [ 95.437411] systemd[573]: Starting Run user-specific NixOS activation...2569machine # [ 95.468590] systemd[573]: Finished Run user-specific NixOS activation.2570machine # [ 95.472490] systemd[1]: Stopped target Reactivate sysinit units.2571machine # [ 95.476443] systemd[1]: Stopping Reactivate sysinit units...2572machine # [ 95.477351] systemd[1]: Reached target Reactivate sysinit units.2573machine # [ 95.479692] systemd[1]: Reloading test.service...2574machine # [ 95.505748] systemd[1]: Reloaded test.service.2575machine # [ 95.510960] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2576machine # [ 95.513968] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2577machine # [ 95.518656] systemd[1]: Reached target Local File Systems.2578machine # [ 95.519533] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2579machine # [ 95.528420] systemd[1]: Starting Create SUID/SGID Wrappers...2580machine # [ 95.529347] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2581machine # [ 95.530576] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672582machine # [ 95.541948] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2583machine # [ 95.543615] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2584machine # [ 95.545076] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2585machine # [ 95.546287] systemd[1]: Reached target Remote File Systems.2586machine # [ 95.704135] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2587machine # [ 95.706944] systemd[1]: Finished Create SUID/SGID Wrappers.2588machine # [ 95.711304] systemd[1]: Starting linger-users.service...2589machine # [ 95.757658] systemd[1]: linger-users.service: Deactivated successfully.2590machine # [ 95.760933] systemd[1]: Finished linger-users.service.2591machine # [ 96.019608] nixos[6171]: finished switching to system configuration /nix/store/9k7lm208rl7abm0wbdzlg61nr0ls67mi-nixos-system-machine-test2592machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.93 seconds)2593machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&12594machine # [ 96.327707] nixos[6313]: switching to system configuration /nix/store/dw1zfwzay77jfmmd0y85dcrxsbqyxw0c-nixos-system-machine-test2595machine # [ 96.330584] systemd[1]: Stopped target Remote File Systems.2596machine # [ 96.333422] systemd[1]: Stopped target Local File Systems.2597machine # [ 96.657662] systemd[1]: Reload requested from client PID 6313 ('.switch-to-conf') (unit backdoor.service)...2598machine # [ 96.659637] systemd[1]: Reloading...2599machine # [ 97.006046] systemd[1]: Reloading finished in 344 ms.2600machine # [ 97.106451] systemd[573]: Reexecution requested from client PID 6382 ('switch-to-confi')...2601machine # [ 97.107901] systemd[573]: Reexecuting.2602machine # [ 97.163579] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2603machine # [ 97.282076] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2604machine # [ 97.288827] systemd[573]: Reload requested from client PID 6382 ('switch-to-confi')...2605machine # [ 97.292259] systemd[573]: Reloading...2606machine # [ 97.405054] systemd[573]: Reloading finished in 113 ms.2607machine # [ 97.420173] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2608machine # [ 97.430575] systemd[573]: Stopped Run user-specific NixOS activation.2609machine # [ 97.433177] systemd[573]: Stopping Run user-specific NixOS activation...2610machine # [ 97.435441] systemd[573]: Starting Run user-specific NixOS activation...2611machine # [ 97.468949] systemd[573]: Finished Run user-specific NixOS activation.2612machine # [ 97.473011] systemd[1]: Stopped target Reactivate sysinit units.2613machine # [ 97.476355] systemd[1]: Stopping Reactivate sysinit units...2614machine # [ 97.477274] systemd[1]: Reached target Reactivate sysinit units.2615machine # [ 97.480590] systemd[1]: Reloading test.service...2616machine # [ 97.506488] systemd[1]: Reloaded test.service.2617machine # [ 97.513450] systemd[1]: Reached target Remote File Systems.2618machine # [ 97.518260] systemd[1]: Starting linger-users.service...2619machine # [ 97.528533] systemd[1]: Reached target Local File Systems.2620machine # [ 97.529550] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2621machine # [ 97.534930] systemd[1]: Starting Create SUID/SGID Wrappers...2622machine # [ 97.535850] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2623machine # [ 97.545046] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672624machine # [ 97.547317] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2625machine # [ 97.560818] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2626machine # [ 97.562676] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2627machine # [ 97.563862] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2628machine # [ 97.573028] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2629machine # [ 97.606815] systemd[1]: linger-users.service: Deactivated successfully.2630machine # [ 97.610989] systemd[1]: Finished linger-users.service.2631machine # [ 97.754897] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2632machine # [ 97.758486] systemd[1]: Finished Create SUID/SGID Wrappers.2633machine # [ 98.015176] nixos[6313]: finished switching to system configuration /nix/store/dw1zfwzay77jfmmd0y85dcrxsbqyxw0c-nixos-system-machine-test2634machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.99 seconds)2635machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&12636machine # [ 98.316647] nixos[6455]: switching to system configuration /nix/store/a828i3w2bw0d7nfrvgsnzxbg7dvy21n8-nixos-system-machine-test2637machine # [ 98.319097] systemd[1]: Stopped target Local File Systems.2638machine # [ 98.321297] systemd[1]: Stopped target Remote File Systems.2639machine # [ 98.620491] systemd[1]: Reload requested from client PID 6455 ('.switch-to-conf') (unit backdoor.service)...2640machine # [ 98.622554] systemd[1]: Reloading...2641machine # [ 98.971432] systemd[1]: Reloading finished in 347 ms.2642machine # [ 99.061532] systemd[573]: Reexecution requested from client PID 6524 ('switch-to-confi')...2643machine # [ 99.065759] systemd[573]: Reexecuting.2644machine # [ 99.123605] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2645machine # [ 99.243285] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2646machine # [ 99.250347] systemd[573]: Reload requested from client PID 6524 ('switch-to-confi')...2647machine # [ 99.253875] systemd[573]: Reloading...2648machine # [ 99.365372] systemd[573]: Reloading finished in 112 ms.2649machine # [ 99.380168] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2650machine # [ 99.390846] systemd[573]: Stopped Run user-specific NixOS activation.2651machine # [ 99.393112] systemd[573]: Stopping Run user-specific NixOS activation...2652machine # [ 99.395184] systemd[573]: Starting Run user-specific NixOS activation...2653machine # [ 99.428666] systemd[573]: Finished Run user-specific NixOS activation.2654machine # [ 99.432407] systemd[1]: Stopped target Reactivate sysinit units.2655machine # [ 99.433721] systemd[1]: Stopping Reactivate sysinit units...2656machine # [ 99.434555] systemd[1]: Reached target Reactivate sysinit units.2657machine # [ 99.437266] systemd[1]: test.service: Deactivated successfully.2658machine # [ 99.440476] systemd[1]: Stopped test.service.2659machine # [ 99.441293] systemd[1]: Stopping test.service...2660machine # [ 99.444249] systemd[1]: Starting test.service...2661machine # [ 99.469320] systemd[1]: Finished test.service.2662machine # [ 99.474239] systemd[1]: Reached target Remote File Systems.2663machine # [ 99.477007] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2664machine # [ 99.480693] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2665machine # [ 99.484231] systemd[1]: Reached target Local File Systems.2666machine # [ 99.485094] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2667machine # [ 99.496333] systemd[1]: Starting Create SUID/SGID Wrappers...2668machine # [ 99.497328] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2669machine # [ 99.498575] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672670machine # [ 99.504262] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2671machine # [ 99.505868] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2672machine # [ 99.507179] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2673machine # [ 99.672173] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2674machine # [ 99.676304] systemd[1]: Finished Create SUID/SGID Wrappers.2675machine # [ 99.679168] systemd[1]: Starting linger-users.service...2676machine # [ 99.722692] systemd[1]: linger-users.service: Deactivated successfully.2677machine # [ 99.725772] systemd[1]: Finished linger-users.service.2678machine # [ 99.982935] nixos[6455]: finished switching to system configuration /nix/store/a828i3w2bw0d7nfrvgsnzxbg7dvy21n8-nixos-system-machine-test2679machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.97 seconds)2680machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&12681machine # [ 100.261915] nixos[6597]: switching to system configuration /nix/store/chh5b3q4zwljq0yp7yv8ia415kn90fkv-nixos-system-machine-test2682machine # [ 100.264963] systemd[1]: Stopped target Local File Systems.2683machine # [ 100.267406] systemd[1]: Stopped target Remote File Systems.2684machine # [ 100.533025] systemd[1]: Reload requested from client PID 6597 ('.switch-to-conf') (unit backdoor.service)...2685machine # [ 100.535132] systemd[1]: Reloading...2686machine # [ 100.931195] systemd[1]: Reloading finished in 394 ms.2687machine # [ 101.020436] systemd[573]: Reexecution requested from client PID 6666 ('switch-to-confi')...2688machine # [ 101.021864] systemd[573]: Reexecuting.2689machine # [ 101.067254] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2690machine # [ 101.181128] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2691machine # [ 101.187617] systemd[573]: Reload requested from client PID 6666 ('switch-to-confi')...2692machine # [ 101.191480] systemd[573]: Reloading...2693machine # [ 101.301409] systemd[573]: Reloading finished in 111 ms.2694machine # [ 101.316188] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2695machine # [ 101.325904] systemd[573]: Stopped Run user-specific NixOS activation.2696machine # [ 101.328124] systemd[573]: Stopping Run user-specific NixOS activation...2697machine # [ 101.330539] systemd[573]: Starting Run user-specific NixOS activation...2698machine # [ 101.364627] systemd[573]: Finished Run user-specific NixOS activation.2699machine # [ 101.368485] systemd[1]: Stopped target Reactivate sysinit units.2700machine # [ 101.370654] systemd[1]: Stopping Reactivate sysinit units...2701machine # [ 101.371551] systemd[1]: Reached target Reactivate sysinit units.2702machine # [ 101.375331] systemd[1]: Reached target Remote File Systems.2703machine # [ 101.378569] systemd[1]: Starting linger-users.service...2704machine # [ 101.384411] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2705machine # [ 101.385864] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2706machine # [ 101.394935] systemd[1]: Reached target Local File Systems.2707machine # [ 101.395898] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2708machine # [ 101.405992] systemd[1]: Starting Create SUID/SGID Wrappers...2709machine # [ 101.406911] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2710machine # [ 101.415020] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672711machine # [ 101.421727] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2712machine # [ 101.427324] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2713machine # [ 101.432276] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2714machine # [ 101.471430] systemd[1]: linger-users.service: Deactivated successfully.2715machine # [ 101.474494] systemd[1]: Finished linger-users.service.2716machine # [ 101.613134] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2717machine # [ 101.616483] systemd[1]: Finished Create SUID/SGID Wrappers.2718machine # [ 101.875171] nixos[6597]: finished switching to system configuration /nix/store/chh5b3q4zwljq0yp7yv8ia415kn90fkv-nixos-system-machine-test2719machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.89 seconds)2720(finished: subtest: unit file parser, in 25.47 seconds)2721subtest: restart and reload by activation script2722machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&12723machine # [ 102.158994] nixos[6737]: switching to system configuration /nix/store/k2l67iyjs5ln3zw4j84fhsvslw86awx2-nixos-system-machine-test2724machine # [ 102.161456] systemd[1]: Stopped target Remote File Systems.2725machine # [ 102.163940] systemd[1]: Stopped target Local File Systems.2726machine # [ 102.435334] systemd[1]: Reload requested from client PID 6737 ('.switch-to-conf') (unit backdoor.service)...2727machine # [ 102.437579] systemd[1]: Reloading...2728machine # [ 102.791663] systemd[1]: Reloading finished in 352 ms.2729machine # [ 102.881557] systemd[573]: Reexecution requested from client PID 6806 ('switch-to-confi')...2730machine # [ 102.885959] systemd[573]: Reexecuting.2731machine # [ 102.943392] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2732machine # [ 103.061538] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2733machine # [ 103.068164] systemd[573]: Reload requested from client PID 6806 ('switch-to-confi')...2734machine # [ 103.070609] systemd[573]: Reloading...2735machine # [ 103.181972] systemd[573]: Reloading finished in 110 ms.2736machine # [ 103.196169] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2737machine # [ 103.207998] systemd[573]: Stopped Run user-specific NixOS activation.2738machine # [ 103.209092] systemd[573]: Stopping Run user-specific NixOS activation...2739machine # [ 103.211600] systemd[573]: Starting Run user-specific NixOS activation...2740machine # [ 103.244966] systemd[573]: Finished Run user-specific NixOS activation.2741machine # [ 103.248852] systemd[1]: Stopped target Reactivate sysinit units.2742machine # [ 103.251865] systemd[1]: Stopping Reactivate sysinit units...2743machine # [ 103.253797] systemd[1]: Reached target Reactivate sysinit units.2744machine # [ 103.255400] systemd[1]: Reached target Remote File Systems.2745machine # [ 103.260813] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2746machine # [ 103.263889] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2747machine # [ 103.270226] systemd[1]: Starting linger-users.service...2748machine # [ 103.274509] systemd[1]: Reached target Local File Systems.2749machine # [ 103.282341] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2750machine # [ 103.294559] systemd[1]: Starting Create SUID/SGID Wrappers...2751machine # [ 103.295511] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2752machine # [ 103.301215] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672753machine # [ 103.303431] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2754machine # [ 103.312370] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2755machine # [ 103.313712] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2756machine # [ 103.355462] systemd[1]: linger-users.service: Deactivated successfully.2757machine # [ 103.359966] systemd[1]: Finished linger-users.service.2758machine # [ 103.515108] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2759machine # [ 103.518606] systemd[1]: Finished Create SUID/SGID Wrappers.2760machine # [ 103.773582] nixos[6737]: finished switching to system configuration /nix/store/k2l67iyjs5ln3zw4j84fhsvslw86awx2-nixos-system-machine-test2761machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.89 seconds)2762machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12763machine # [ 104.073853] nixos[6877]: switching to system configuration /nix/store/zci0jdhzkvn3k6lhx29la1g26l6l2bgd-nixos-system-machine-test2764machine # [ 104.077054] systemd[1]: test.service: Deactivated successfully.2765machine # [ 104.080843] systemd[1]: Stopped test.service.2766machine # [ 104.082072] systemd[1]: Stopped target Local File Systems.2767machine # [ 104.082873] systemd[1]: Stopped target Remote File Systems.2768machine # [ 104.381235] systemd[1]: Reload requested from client PID 6877 ('.switch-to-conf') (unit backdoor.service)...2769machine # [ 104.383166] systemd[1]: Reloading...2770machine # [ 104.743088] systemd[1]: Reloading finished in 358 ms.2771machine # [ 104.826433] systemd[573]: Reexecution requested from client PID 6948 ('switch-to-confi')...2772machine # [ 104.830131] systemd[573]: Reexecuting.2773machine # [ 104.875250] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2774machine # [ 104.991461] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2775machine # [ 104.999074] systemd[573]: Reload requested from client PID 6948 ('switch-to-confi')...2776machine # [ 105.002173] systemd[573]: Reloading...2777machine # [ 105.110286] systemd[573]: Reloading finished in 109 ms.2778machine # [ 105.124159] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2779machine # [ 105.133963] systemd[573]: Stopped Run user-specific NixOS activation.2780machine # [ 105.136297] systemd[573]: Stopping Run user-specific NixOS activation...2781machine # [ 105.138452] systemd[573]: Starting Run user-specific NixOS activation...2782machine # [ 105.172309] systemd[573]: Finished Run user-specific NixOS activation.2783machine # [ 105.176490] systemd[1]: Stopped target Reactivate sysinit units.2784machine # [ 105.178528] systemd[1]: Stopping Reactivate sysinit units...2785machine # [ 105.179414] systemd[1]: Reached target Reactivate sysinit units.2786machine # [ 105.185026] systemd[1]: Reached target Local File Systems.2787machine # [ 105.185885] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2788machine # [ 105.194009] systemd[1]: Starting Create SUID/SGID Wrappers...2789machine # [ 105.194934] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2790machine # [ 105.198621] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672791machine # [ 105.205064] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2792machine # [ 105.206687] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2793machine # [ 105.207930] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2794machine # [ 105.212311] systemd[1]: Reached target Remote File Systems.2795machine # [ 105.213228] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2796machine # [ 105.214730] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2797machine # [ 105.231948] systemd[1]: Created slice Slice /system/templated-simple-restart-service.2798machine # [ 105.241660] systemd[1]: Created slice Slice /system/templated-no-restart-service.2799machine # [ 105.251163] systemd[1]: Created slice Slice /system/templated-simple-service.2800machine # [ 105.260763] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as.2801machine # [ 105.270786] systemd[1]: Created slice Slice /system/templated-reload-triggers.2802machine # [ 105.274003] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart.2803machine # [ 105.284637] systemd[1]: Created slice Slice /system/templated-simple-reload-service.2804machine # [ 105.450859] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2805machine # [ 105.454225] systemd[1]: Finished Create SUID/SGID Wrappers.2806machine # [ 105.459179] systemd[1]: Starting linger-users.service...2807machine # [ 105.464664] systemd[1]: Starting no-restart-service.service...2808machine # [ 105.475918] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2809machine # [ 105.496273] systemd[1]: Starting reload-triggers-and-restart.service...2810machine # [ 105.497377] systemd[1]: Starting reload-triggers.service...2811machine # [ 105.498196] systemd[1]: Starting simple-reload-service.service...2812machine # [ 105.514824] systemd[1]: Starting simple-restart-service.service...2813machine # [ 105.528163] systemd[1]: Starting simple-service.service...2814machine # [ 105.563068] systemd[1]: Starting templated-no-restart-service@instance.service...2815machine # [ 105.584930] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2816machine # [ 105.586243] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2817machine # [ 105.587535] systemd[1]: Starting templated-reload-triggers@instance.service...2818machine # [ 105.647638] systemd[1]: Starting templated-simple-reload-service@instance.service...2819machine # [ 105.668413] systemd[1]: Starting templated-simple-restart-service@instance.service...2820machine # [ 105.669642] systemd[1]: Starting templated-simple-service@instance.service...2821machine # [ 105.718502] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2822machine # [ 105.735843] systemd[1]: Finished no-restart-service.service.2823machine # [ 105.753198] systemd[1]: Finished reload-triggers-and-restart.service.2824machine # [ 105.772783] systemd[1]: Finished simple-reload-service.service.2825machine # [ 105.787843] systemd[1]: Finished reload-triggers.service.2826machine # [ 105.803992] systemd[1]: Finished simple-restart-service.service.2827machine # [ 105.806081] systemd[1]: Finished simple-service.service.2828machine # [ 105.806952] systemd[1]: Finished templated-no-restart-service@instance.service.2829machine # [ 105.807955] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2830machine # [ 105.816316] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2831machine # [ 105.817545] systemd[1]: Finished templated-reload-triggers@instance.service.2832machine # [ 105.818493] systemd[1]: Finished templated-simple-restart-service@instance.service.2833machine # [ 105.819520] systemd[1]: Finished templated-simple-reload-service@instance.service.2834machine # [ 105.821810] systemd[1]: Finished templated-simple-service@instance.service.2835machine # [ 105.832388] systemd[1]: linger-users.service: Deactivated successfully.2836machine # [ 105.834791] systemd[1]: Finished linger-users.service.2837machine # [ 106.096415] nixos[6877]: finished switching to system configuration /nix/store/zci0jdhzkvn3k6lhx29la1g26l6l2bgd-nixos-system-machine-test2838machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.33 seconds)2839machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12840machine # [ 106.427456] nixos[7047]: switching to system configuration /nix/store/zci0jdhzkvn3k6lhx29la1g26l6l2bgd-nixos-system-machine-test2841machine # [ 106.430022] systemd[1]: Stopped target Local File Systems.2842machine # [ 106.432446] systemd[1]: Stopped target Remote File Systems.2843machine # [ 106.728502] systemd[1]: Reload requested from client PID 7047 ('.switch-to-conf') (unit backdoor.service)...2844machine # [ 106.730184] systemd[1]: Reloading...2845machine # [ 107.079619] systemd[1]: Reloading finished in 347 ms.2846machine # [ 107.172562] systemd[573]: Reexecution requested from client PID 7118 ('switch-to-confi')...2847machine # [ 107.176316] systemd[573]: Reexecuting.2848machine # [ 107.236050] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2849machine # [ 107.361199] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2850machine # [ 107.368142] systemd[573]: Reload requested from client PID 7118 ('switch-to-confi')...2851machine # [ 107.372456] systemd[573]: Reloading...2852machine # [ 107.486002] systemd[573]: Reloading finished in 115 ms.2853machine # [ 107.500193] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2854machine # [ 107.509912] systemd[573]: Stopped Run user-specific NixOS activation.2855machine # [ 107.512539] systemd[573]: Stopping Run user-specific NixOS activation...2856machine # [ 107.514722] systemd[573]: Starting Run user-specific NixOS activation...2857machine # [ 107.549351] systemd[573]: Finished Run user-specific NixOS activation.2858machine # [ 107.554198] systemd[1]: Stopped target Reactivate sysinit units.2859machine # [ 107.557632] systemd[1]: Stopping Reactivate sysinit units...2860machine # [ 107.558587] systemd[1]: Reached target Reactivate sysinit units.2861machine # [ 107.565340] systemd[1]: Reloading reload-triggers-and-restart.service...2862machine # [ 107.576275] systemd[1]: Reloading reload-triggers.service...2863machine # [ 107.591570] systemd[1]: Reloading simple-reload-service.service...2864machine # [ 107.594435] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service...2865machine # [ 107.611721] systemd[1]: Reloading templated-reload-triggers@instance.service...2866machine # [ 107.614294] systemd[1]: Reloading templated-simple-reload-service@instance.service...2867machine # [ 107.666290] systemd[1]: Reloaded simple-reload-service.service.2868machine # [ 107.672583] systemd[1]: Reloaded reload-triggers.service.2869machine # [ 107.673500] systemd[1]: Reloaded reload-triggers-and-restart.service.2870machine # [ 107.682176] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service.2871machine # [ 107.698137] systemd[1]: Reloaded templated-reload-triggers@instance.service.2872machine # [ 107.700718] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2873machine # [ 107.704288] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2874machine # [ 107.711950] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2875machine # [ 107.713354] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2876machine # [ 107.714315] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2877machine # [ 107.715250] systemd[1]: simple-restart-service.service: Deactivated successfully.2878machine # [ 107.728441] systemd[1]: Stopped simple-restart-service.service.2879machine # [ 107.729390] systemd[1]: Stopping simple-restart-service.service...2880machine # [ 107.730221] systemd[1]: Starting simple-restart-service.service...2881machine # [ 107.731056] systemd[1]: simple-service.service: Deactivated successfully.2882machine # [ 107.756201] systemd[1]: Stopped simple-service.service.2883machine # [ 107.757159] systemd[1]: Stopping simple-service.service...2884machine # [ 107.758126] systemd[1]: Starting simple-service.service...2885machine # [ 107.759013] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2886machine # [ 107.781504] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2887machine # [ 107.782780] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2888machine # [ 107.802048] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2889machine # [ 107.813783] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2890machine # [ 107.831696] systemd[1]: Stopped templated-simple-restart-service@instance.service.2891machine # [ 107.842212] systemd[1]: Stopping templated-simple-restart-service@instance.service...2892machine # [ 107.846675] systemd[1]: Starting templated-simple-restart-service@instance.service...2893machine # [ 107.847828] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2894machine # [ 107.856830] systemd[1]: Stopped templated-simple-service@instance.service.2895machine # [ 107.857999] systemd[1]: Stopping templated-simple-service@instance.service...2896machine # [ 107.859017] systemd[1]: Starting templated-simple-service@instance.service...2897machine # [ 107.859994] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2898machine # [ 107.861343] systemd[1]: Finished simple-restart-service.service.2899machine # [ 107.862359] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2900machine # [ 107.863678] systemd[1]: Finished simple-service.service.2901machine # [ 107.864936] systemd[1]: Finished templated-simple-restart-service@instance.service.2902machine # [ 107.870533] systemd[1]: Finished templated-simple-service@instance.service.2903machine # [ 107.873444] systemd[1]: Reached target Remote File Systems.2904machine # [ 107.885977] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2905machine # [ 107.893526] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2906machine # [ 107.898761] systemd[1]: Starting linger-users.service...2907machine # [ 107.899553] systemd[1]: Reached target Local File Systems.2908machine # [ 107.909295] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2909machine # [ 107.910857] systemd[1]: Starting Create SUID/SGID Wrappers...2910machine # [ 107.911650] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2911machine # [ 107.922674] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672912machine # [ 107.925645] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2913machine # [ 107.927238] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2914machine # [ 107.928559] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2915machine # [ 107.989458] systemd[1]: linger-users.service: Deactivated successfully.2916machine # [ 107.992115] systemd[1]: Finished linger-users.service.2917machine # [ 108.132465] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2918machine # [ 108.136285] systemd[1]: Finished Create SUID/SGID Wrappers.2919machine # [ 108.394937] nixos[7047]: finished switching to system configuration /nix/store/zci0jdhzkvn3k6lhx29la1g26l6l2bgd-nixos-system-machine-test2920machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.30 seconds)2921machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&12922machine # [ 108.753586] nixos[7213]: switching to system configuration /nix/store/vxd2f8xf28c4qydpnxczsr52p9pmc70x-nixos-system-machine-test2923machine # [ 108.756232] systemd[1]: Stopped target Local File Systems.2924machine # [ 108.758776] systemd[1]: Stopped target Remote File Systems.2925machine # [ 109.073064] systemd[1]: Reload requested from client PID 7213 ('.switch-to-conf') (unit backdoor.service)...2926machine # [ 109.074998] systemd[1]: Reloading...2927machine # [ 109.439023] systemd[1]: Reloading finished in 361 ms.2928machine # [ 109.530806] systemd[573]: Reexecution requested from client PID 7284 ('switch-to-confi')...2929machine # [ 109.534450] systemd[573]: Reexecuting.2930machine # [ 109.595436] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2931machine # [ 109.717169] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2932machine # [ 109.724096] systemd[573]: Reload requested from client PID 7284 ('switch-to-confi')...2933machine # [ 109.726345] systemd[573]: Reloading...2934machine # [ 109.839935] systemd[573]: Reloading finished in 112 ms.2935machine # [ 109.856189] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2936machine # [ 109.867911] systemd[573]: Stopped Run user-specific NixOS activation.2937machine # [ 109.870672] systemd[573]: Stopping Run user-specific NixOS activation...2938machine # [ 109.873339] systemd[573]: Starting Run user-specific NixOS activation...2939machine # [ 109.905862] systemd[573]: Finished Run user-specific NixOS activation.2940machine # [ 109.910083] systemd[1]: Stopped target Reactivate sysinit units.2941machine # [ 109.912897] systemd[1]: Stopping Reactivate sysinit units...2942machine # [ 109.913795] systemd[1]: Reached target Reactivate sysinit units.2943machine # [ 109.919011] systemd[1]: Reloading reload-triggers.service...2944machine # [ 109.925142] systemd[1]: Reloading simple-reload-service.service...2945machine # [ 109.941026] systemd[1]: Reloading templated-reload-triggers@instance.service...2946machine # [ 109.951954] systemd[1]: Reloading templated-simple-reload-service@instance.service...2947machine # [ 110.004434] systemd[1]: Reloaded reload-triggers.service.2948machine # [ 110.008965] systemd[1]: Reloaded simple-reload-service.service.2949machine # [ 110.009998] systemd[1]: Reloaded templated-reload-triggers@instance.service.2950machine # [ 110.010982] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2951machine # [ 110.016489] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2952machine # [ 110.017803] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2953machine # [ 110.018804] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2954machine # [ 110.022141] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2955machine # [ 110.026607] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully.2956machine # [ 110.027813] systemd[1]: Stopped reload-triggers-and-restart.service.2957machine # [ 110.041346] systemd[1]: Stopping reload-triggers-and-restart.service...2958machine # [ 110.042362] systemd[1]: Starting reload-triggers-and-restart.service...2959machine # [ 110.043291] systemd[1]: simple-restart-service.service: Deactivated successfully.2960machine # [ 110.064610] systemd[1]: Stopped simple-restart-service.service.2961machine # [ 110.065598] systemd[1]: Stopping simple-restart-service.service...2962machine # [ 110.066483] systemd[1]: Starting simple-restart-service.service...2963machine # [ 110.067392] systemd[1]: simple-service.service: Deactivated successfully.2964machine # [ 110.112992] systemd[1]: Stopped simple-service.service.2965machine # [ 110.113902] systemd[1]: Stopping simple-service.service...2966machine # [ 110.127378] systemd[1]: Starting simple-service.service...2967machine # [ 110.134067] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2968machine # [ 110.150745] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2969machine # [ 110.176509] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2970machine # [ 110.187245] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2971machine # [ 110.196539] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully.2972machine # [ 110.198099] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service.2973machine # [ 110.199347] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service...2974machine # [ 110.214349] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2975machine # [ 110.215747] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2976machine # [ 110.222561] systemd[1]: Stopped templated-simple-restart-service@instance.service.2977machine # [ 110.223683] systemd[1]: Stopping templated-simple-restart-service@instance.service...2978machine # [ 110.226732] systemd[1]: Starting templated-simple-restart-service@instance.service...2979machine # [ 110.227863] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2980machine # [ 110.231851] systemd[1]: Stopped templated-simple-service@instance.service.2981machine # [ 110.237120] systemd[1]: Stopping templated-simple-service@instance.service...2982machine # [ 110.238232] systemd[1]: Starting templated-simple-service@instance.service...2983machine # [ 110.239230] systemd[1]: Finished reload-triggers-and-restart.service.2984machine # [ 110.241162] systemd[1]: Finished simple-restart-service.service.2985machine # [ 110.242099] systemd[1]: Finished simple-service.service.2986machine # [ 110.242873] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2987machine # [ 110.243825] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2988machine # [ 110.257127] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2989machine # [ 110.258347] systemd[1]: Finished templated-simple-restart-service@instance.service.2990machine # [ 110.259377] systemd[1]: Finished templated-simple-service@instance.service.2991machine # [ 110.264364] systemd[1]: Reached target Local File Systems.2992machine # [ 110.265307] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2993machine # [ 110.266813] systemd[1]: Starting Create SUID/SGID Wrappers...2994machine # [ 110.267627] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2995machine # [ 110.268968] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672996machine # [ 110.271129] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2997machine # [ 110.272754] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2998machine # [ 110.274020] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2999machine # [ 110.275215] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os3000machine # [ 110.277266] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki3001machine # [ 110.278621] systemd[1]: Reached target Remote File Systems.3002machine # [ 110.461830] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.3003machine # [ 110.466971] systemd[1]: Finished Create SUID/SGID Wrappers.3004machine # [ 110.469565] systemd[1]: Starting linger-users.service...3005machine # [ 110.513150] systemd[1]: linger-users.service: Deactivated successfully.3006machine # [ 110.516593] systemd[1]: Finished linger-users.service.3007machine # [ 110.773979] nixos[7213]: finished switching to system configuration /nix/store/vxd2f8xf28c4qydpnxczsr52p9pmc70x-nixos-system-machine-test3008machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.38 seconds)3009machine: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&13010machine: (finished: must succeed: /nix/store/vr1ngh31a94lh2nmlqpjzf3i6ygxywfn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.40 seconds)3011(finished: subtest: restart and reload by activation script, in 9.31 seconds)3012(finished: run the VM test script, in 112.04 seconds)3013test script finished in 112.66s3014cleanup3015kill QemuMachine (pid 45)3016machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14)3017machine # [2026-09-25T03:06:13Z INFO virtiofsd] Client disconnected, shutting down3018machine # [2026-09-25T03:06:13Z INFO virtiofsd] Client disconnected, shutting down3019machine # [2026-09-25T03:06:13Z INFO virtiofsd] Client disconnected, shutting down3020(finished: cleanup, in 0.16 seconds)3021additionally exposed symbols:3022 machine, other,3023 vlan1,3024 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