vm-test-run-switch-test-services
checks.aarch64-linux.switchTest
· build #60
· raw
1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7machine: waiting for unit multi-user.target8machine: waiting for the VM to finish booting9machine: starting vm10machine # Disk image does not exist, creating the virtualisation disk image...11machine: QEMU running (pid 45)12machine # Formatting '/build/vm-state-machine/tmp.5wTx9menFy', 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: 224d0568-8d9f-44c3-bdae-47c506d0637a17machine # Superblock backups stored on blocks:18machine # 32768, 98304, 163840, 22937619machine # 20machine # Allocating group tables: 0/8 done21machine # Writing inode tables: 0/8 done22machine # Creating journal (8192 blocks): done23machine # Writing superblocks and filesystem accounting information: 0/8 done24machine # 25machine # Virtualisation disk image created.26machine # Starting virtiofs daemons...27machine # [2026-10-18T02:43:26Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)28machine # [2026-10-18T02:43:26Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether29machine # [2026-10-18T02:43:26Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)30machine # [2026-10-18T02:43:26Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether31machine # [2026-10-18T02:43:26Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)32machine # [2026-10-18T02:43:26Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether33machine # [2026-10-18T02:43:26Z INFO virtiofsd] Waiting for vhost-user socket connection...34machine # [2026-10-18T02:43:26Z INFO virtiofsd] Waiting for vhost-user socket connection...35machine # [2026-10-18T02:43:26Z INFO virtiofsd] Waiting for vhost-user socket connection...36machine # [2026-10-18T02:43:26Z INFO virtiofsd] Client connected, servicing requests37machine # [2026-10-18T02:43:26Z INFO virtiofsd] Client connected, servicing requests38machine # [2026-10-18T02:43:26Z INFO virtiofsd] Client connected, servicing requests39machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]40machine # [ 0.000000] Linux version 6.18.56 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT @179172517241machine # [ 0.000000] KASLR enabled42machine # [ 0.000000] random: crng init done43machine # [ 0.000000] Machine model: linux,dummy-virt44machine # [ 0.000000] efi: UEFI not found.45machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT46machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]47machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f]48machine # [ 0.000000] Zone ranges:49machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]50machine # [ 0.000000] DMA32 empty51machine # [ 0.000000] Normal empty52machine # [ 0.000000] Device empty53machine # [ 0.000000] Movable zone start for each node54machine # [ 0.000000] Early memory node ranges55machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]56machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]57machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc0000058machine # [ 0.000000] psci: probing for conduit method from DT.59machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.60machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs61machine # [ 0.000000] psci: Trusted OS migration not required62machine # [ 0.000000] psci: SMC Calling Convention v1.163machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)64machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186904 r8192 d116200 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/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/init regInfo=/nix/.ro-store/a3hdbm3dx1v86v48ij6shyi9ydvyllji-closure-info/registration console=ttyAMA0,115200n8 console=tty074machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/a3hdbm3dx1v86v48ij6shyi9ydvyllji-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 75049 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=512 to nr_cpu_ids=1.92machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.93machine # [ 0.000000] Rude variant of Tasks RCU enabled.94machine # [ 0.000000] Tracing variant of Tasks RCU enabled.95machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.96machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=197machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.98machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.99machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.100machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0101machine # [ 0.000000] GICv3: 256 SPIs implemented102machine # [ 0.000000] GICv3: 0 Extended SPIs implemented103machine # [ 0.000000] Root IRQ handler: gic_handle_irq104machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI105machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0106machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000107machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]108machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @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 @0x0000000044d10000111machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000112machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.113machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns114machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).115machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns116machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns117machine # [ 0.000032] arm-pv: using stolen time PV118machine # [ 0.000416] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)119machine # [ 0.000723] Console: colour dummy device 80x25120machine # [ 0.000732] printk: legacy console [tty0] enabled121machine # [ 0.000923] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)122machine # [ 0.000930] pid_max: default: 32768 minimum: 301123machine # [ 0.001010] LSM: initializing lsm=capability,landlock,yama,bpf,ima124machine # [ 0.001182] landlock: Up and running.125machine # [ 0.001185] Yama: becoming mindful.126machine # [ 0.001647] LSM support for eBPF active127machine # [ 0.001788] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)128machine # [ 0.001807] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)129machine # [ 0.003790] rcu: Hierarchical SRCU implementation.130machine # [ 0.003797] rcu: Max phase no-delay instances is 1000.131machine # [ 0.005177] fsl-mc MSI: its@8080000 domain created132machine # [ 0.005306] EFI services will not be available.133machine # [ 0.005441] smp: Bringing up secondary CPUs ...134machine # [ 0.005451] smp: Brought up 1 node, 1 CPU135machine # [ 0.005455] SMP: Total of 1 processors activated.136machine # [ 0.005457] CPU: All CPU(s) started at EL1137machine # [ 0.005467] CPU features: detected: Branch Target Identification138machine # [ 0.005472] CPU features: detected: ARMv8.4 Translation Table Level139machine # [ 0.005476] CPU features: detected: Instruction cache invalidation not required for I/D coherence140machine # [ 0.005479] CPU features: detected: Data cache clean to the PoU not required for I/D coherence141machine # [ 0.005488] CPU features: detected: Common not Private translations142machine # [ 0.005492] CPU features: detected: CRC32 instructions143machine # [ 0.005494] CPU features: detected: Data cache clean to Point of Deep Persistence144machine # [ 0.005498] CPU features: detected: Data cache clean to Point of Persistence145machine # [ 0.005501] CPU features: detected: Data independent timing control (DIT)146machine # [ 0.005504] CPU features: detected: E0PD147machine # [ 0.005507] CPU features: detected: Enhanced Counter Virtualization148machine # [ 0.005510] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)149machine # [ 0.005513] CPU features: detected: Enhanced Virtualization Traps150machine # [ 0.005516] CPU features: detected: Fine Grained Traps151machine # [ 0.005520] CPU features: detected: Generic authentication (architected QARMA5 algorithm)152machine # [ 0.005525] CPU features: detected: RCpc load-acquire (LDAPR)153machine # [ 0.005528] CPU features: detected: LSE atomic instructions154machine # [ 0.005531] CPU features: detected: Privileged Access Never155machine # [ 0.005534] CPU features: detected: PMUv3156machine # [ 0.005537] CPU features: detected: RAS Extension Support157machine # [ 0.005540] CPU features: detected: RASv1p1 Extension Support158machine # [ 0.005543] CPU features: detected: Random Number Generator159machine # [ 0.005549] CPU features: detected: Speculation barrier (SB)160machine # [ 0.005552] CPU features: detected: Stage-2 Force Write-Back161machine # [ 0.005555] CPU features: detected: TLB range maintenance instructions162machine # [ 0.005559] CPU features: detected: Speculative Store Bypassing Safe (SSBS)163machine # [ 0.005598] alternatives: applying system-wide alternatives164machine # [ 0.008857] CPU features: detected: BBM Level 2 without TLB conflict abort165machine # [ 0.009034] Memory: 892864K/1048576K available (24512K kernel code, 7102K rwdata, 26572K rodata, 4736K init, 1184K bss, 114392K reserved, 32768K cma-reserved)166machine # [ 0.009427] devtmpfs: initialized167machine # [ 0.011296] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)168machine # [ 0.011321] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).169machine # [ 0.011495] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL170machine # [ 0.011499] 0 pages in range for non-PLT usage171machine # [ 0.011501] 508192 pages in range for PLT usage172machine # [ 0.011631] pinctrl core: initialized pinctrl subsystem173machine # [ 0.012572] DMI not present or invalid.174machine # [ 0.015953] NET: Registered PF_NETLINK/PF_ROUTE protocol family175machine # [ 0.018434] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations176machine # [ 0.018579] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations177machine # [ 0.018741] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations178machine # [ 0.018770] audit: initializing netlink subsys (disabled)179machine # [ 0.019455] thermal_sys: Registered thermal governor 'fair_share'180machine # [ 0.019457] thermal_sys: Registered thermal governor 'bang_bang'181machine # [ 0.019461] thermal_sys: Registered thermal governor 'step_wise'182machine # [ 0.019464] thermal_sys: Registered thermal governor 'user_space'183machine # [ 0.019467] thermal_sys: Registered thermal governor 'power_allocator'184machine # [ 0.019497] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1185machine # [ 0.019506] cpuidle: using governor ladder186machine # [ 0.019512] cpuidle: using governor menu187machine # [ 0.019739] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.188machine # [ 0.019757] ASID allocator initialised with 65536 entries189machine # [ 0.021303] Serial: AMBA PL011 UART driver190machine # [ 0.027204] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1191machine # [ 0.027393] printk: console [ttyAMA0] enabled192machine # [ 0.158873] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages193machine # [ 0.158886] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page194machine # [ 0.158889] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages195machine # [ 0.158892] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page196machine # [ 0.158894] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages197machine # [ 0.158897] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page198machine # [ 0.158900] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages199machine # [ 0.158902] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page200machine # [ 0.160233] fbcon: Taking over console201machine # [ 0.160244] ACPI: Interpreter disabled.202machine # [ 0.170296] iommu: Default domain type: Translated203machine # [ 0.170302] iommu: DMA domain TLB invalidation policy: strict mode204machine # [ 0.170753] SCSI subsystem initialized205machine # [ 0.173002] usbcore: registered new interface driver usbfs206machine # [ 0.173035] usbcore: registered new interface driver hub207machine # [ 0.173051] usbcore: registered new device driver usb208machine # [ 0.173385] pps_core: LinuxPPS API ver. 1 registered209machine # [ 0.173388] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>210machine # [ 0.173397] PTP clock support registered211machine # [ 0.173436] EDAC MC: Ver: 3.0.0212machine # [ 0.174854] scmi_core: SCMI protocol bus registered213machine # [ 0.181009] FPGA manager framework214machine # [ 0.183218] vgaarb: loaded215machine # [ 0.184354] clocksource: Switched to clocksource arch_sys_counter216machine # [ 0.192244] VFS: Disk quotas dquot_6.6.0217machine # [ 0.192278] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)218machine # [ 0.196419] netfs: FS-Cache loaded219machine # [ 0.196601] pnp: PnP ACPI: disabled220machine # [ 0.200036] NET: Registered PF_INET protocol family221machine # [ 0.200207] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)222machine # [ 0.232904] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)223machine # [ 0.232944] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)224machine # [ 0.232968] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)225machine # [ 0.233014] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)226machine # [ 0.233087] TCP: Hash tables configured (established 8192 bind 8192)227machine # [ 0.233171] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)228machine # [ 0.233227] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)229machine # [ 0.233281] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)230machine # [ 0.233376] NET: Registered PF_UNIX/PF_LOCAL protocol family231machine # [ 0.233395] NET: Registered PF_XDP protocol family232machine # [ 0.233410] PCI: CLS 0 bytes, default 64233machine # [ 0.233829] Trying to unpack rootfs image as initramfs...234machine # [ 0.246654] kvm [1]: HYP mode not available235machine # [ 0.369426] Initialise system trusted keyrings236machine # [ 0.369569] workingset: timestamp_bits=42 max_order=18 bucket_order=0237machine # [ 0.369963] squashfs: version 4.0 (2009/01/31) Phillip Lougher238machine # [ 0.370016] 9p: Installing v9fs 9p2000 file system support239machine # [ 0.393101] Key type asymmetric registered240machine # [ 0.393120] Asymmetric key parser 'x509' registered241machine # [ 0.393198] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)242machine # [ 0.393386] io scheduler mq-deadline registered243machine # [ 0.393392] io scheduler kyber registered244machine # [ 0.405963] pl061_gpio 9030000.pl061: PL061 GPIO chip registered245machine # [ 0.409323] ledtrig-cpu: registered to indicate activity on CPUs246machine # [ 0.409782] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:247machine # [ 0.409798] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000248machine # [ 0.409808] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000249machine # [ 0.409814] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000250machine # [ 0.409834] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits251machine # [ 0.409859] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]252machine # [ 0.409949] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00253machine # [ 0.409956] pci_bus 0000:00: root bus resource [bus 00-ff]254machine # [ 0.409960] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]255machine # [ 0.409964] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]256machine # [ 0.409967] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]257machine # [ 0.410020] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint258machine # [ 0.410475] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint259machine # [ 0.410671] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]260machine # [ 0.410683] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]261machine # [ 0.410709] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]262machine # [ 0.410721] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]263machine # [ 0.411215] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint264machine # [ 0.411403] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]265machine # [ 0.411414] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]266machine # [ 0.411440] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]267machine # [ 0.411908] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint268machine # [ 0.412099] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]269machine # [ 0.412110] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]270machine # [ 0.412136] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]271machine # [ 0.444853] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint272machine # [ 0.445073] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]273machine # [ 0.445086] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]274machine # [ 0.445114] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]275machine # [ 0.445126] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]276machine # [ 0.445627] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint277machine # [ 0.445826] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]278machine # [ 0.445853] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]279machine # [ 0.446335] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint280machine # [ 0.446525] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]281machine # [ 0.446553] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]282machine # [ 0.446966] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint283machine # [ 0.447151] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]284machine # [ 0.447451] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint285machine # [ 0.447641] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]286machine # [ 0.447667] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]287machine # [ 0.448137] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint288machine # [ 0.448325] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]289machine # [ 0.448351] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]290machine # [ 0.466259] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint291machine # [ 0.466453] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]292machine # [ 0.466483] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]293machine # [ 0.466977] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint294machine # [ 0.467264] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]295machine # [ 0.467276] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]296machine # [ 0.467306] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]297machine # [ 0.467802] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint298machine # [ 0.467998] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]299machine # [ 0.468010] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]300machine # [ 0.468036] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]301machine # [ 0.484876] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned302machine # [ 0.484893] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned303machine # [ 0.484897] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned304machine # [ 0.484953] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned305machine # [ 0.485000] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned306machine # [ 0.485053] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned307machine # [ 0.485097] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned308machine # [ 0.485142] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned309machine # [ 0.485187] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned310machine # [ 0.485236] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned311machine # [ 0.485287] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned312machine # [ 0.485333] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned313machine # [ 0.485454] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned314machine # [ 0.485498] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned315machine # [ 0.485516] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned316machine # [ 0.485533] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned317machine # [ 0.485551] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned318machine # [ 0.485568] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned319machine # [ 0.485586] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned320machine # [ 0.485604] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned321machine # [ 0.485623] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned322machine # [ 0.485641] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned323machine # [ 0.485659] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned324machine # [ 0.485677] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned325machine # [ 0.485696] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned326machine # [ 0.485714] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned327machine # [ 0.485731] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned328machine # [ 0.485748] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned329machine # [ 0.485765] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned330machine # [ 0.485783] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned331machine # [ 0.485800] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned332machine # [ 0.485823] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]333machine # [ 0.485828] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]334machine # [ 0.485831] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]335machine # [ 0.486735] pci 0000:00:07.0: enabling device (0000 -> 0002)336machine # [ 0.540324] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)337machine # [ 0.551001] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)338machine # [ 0.554250] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)339machine # [ 0.556242] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)340machine # [ 0.565920] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)341machine # [ 0.568182] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)342machine # [ 0.577932] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)343machine # [ 0.579934] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)344machine # [ 0.590348] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)345machine # [ 0.593422] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)346machine # [ 0.595818] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)347machine # [ 0.617493] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled348machine # [ 0.619528] msm_serial: driver initialized349machine # [ 0.619666] SuperH (H)SCI(F) driver initialized350machine # [ 0.619723] STM32 USART driver initialized351machine # [ 0.656174] loop: module loaded352machine # [ 0.656997] virtio_blk virtio2: 1/0/0 default/read/poll queues353machine # [ 0.657871] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)354machine # [ 0.663049] megasas: 07.734.00.00-rc1355machine # [ 0.663875] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]356machine # [ 0.673759] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000357machine # [ 0.673785] Intel/Sharp Extended Query Table at 0x0031358machine # [ 0.676317] Using buffer write method359machine # [ 0.678808] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]360machine # [ 0.688395] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000361machine # [ 0.688441] Intel/Sharp Extended Query Table at 0x0031362machine # [ 0.690507] Using buffer write method363machine # [ 0.690527] Concatenating MTD devices:364machine # [ 0.690530] (0): "0.flash"365machine # [ 0.690533] (1): "0.flash"366machine # [ 0.690535] into device "0.flash"367machine # [ 1.032836] Freeing initrd memory: 27148K368machine # [ 1.038827] tun: Universal TUN/TAP device driver, 1.6369machine # [ 1.043473] thunder_xcv, ver 1.0370machine # [ 1.043506] thunder_bgx, ver 1.0371machine # [ 1.043530] nicpf, ver 1.0372machine # [ 1.044102] e1000: Intel(R) PRO/1000 Network Driver373machine # [ 1.044107] e1000: Copyright (c) 1999-2006 Intel Corporation.374machine # [ 1.044135] e1000e: Intel(R) PRO/1000 Network Driver375machine # [ 1.044144] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.376machine # [ 1.044172] igb: Intel(R) Gigabit Ethernet Network Driver377machine # [ 1.044177] igb: Copyright (c) 2007-2014 Intel Corporation.378machine # [ 1.044198] igbvf: Intel(R) Gigabit Virtual Function Network Driver379machine # [ 1.044202] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.380machine # [ 1.044338] sky2: driver version 1.30381machine # [ 1.053829] usbcore: registered new interface driver usb-storage382machine # [ 1.053959] usbcore: registered new interface driver usbserial_generic383machine # [ 1.053971] usbserial: USB Serial support registered for generic384machine # [ 1.054585] hv_vmbus: registering driver hyperv_keyboard385machine # [ 1.055945] ehci-pci 0000:00:07.0: EHCI Host Controller386machine # [ 1.055965] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1387machine # [ 1.056150] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000388machine # [ 1.062376] rtc-pl031 9010000.pl031: registered as rtc0389machine # [ 1.062411] rtc-pl031 9010000.pl031: setting system clock to 2026-10-18T02:43:28 UTC (1792291408)390machine # [ 1.062851] i2c_dev: i2c /dev entries driver391machine # [ 1.066350] sdhci: Secure Digital Host Controller Interface driver392machine # [ 1.066358] sdhci: Copyright(c) Pierre Ossman393machine # [ 1.066647] Synopsys Designware Multimedia Card Interface Driver394machine # [ 1.067038] sdhci-pltfm: SDHCI platform and OF driver helper395machine # [ 1.068442] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00396machine # [ 1.068796] hub 1-0:1.0: USB hub found397machine # [ 1.068812] hub 1-0:1.0: 6 ports detected398machine # [ 1.076662] hid: raw HID events driver (C) Jiri Kosina399machine # [ 1.076922] usbcore: registered new interface driver usbhid400machine # [ 1.076926] usbhid: USB HID core driver401machine # [ 1.078132] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available402machine # [ 1.079715] drop_monitor: Initializing network drop monitor service403machine # [ 1.079914] NET: Registered PF_INET6 protocol family404machine # [ 1.085201] Segment Routing with IPv6405machine # [ 1.085215] In-situ OAM (IOAM) with IPv6406machine # [ 1.085243] NET: Registered PF_PACKET protocol family407machine # [ 1.085320] 9pnet: Installing 9P2000 support408machine # [ 1.085401] Key type dns_resolver registered409machine # [ 1.094553] registered taskstats version 1410machine # [ 1.094724] Loading compiled-in X.509 certificates411machine # [ 1.103676] Demotion targets for Node 0: null412machine # [ 1.103803] Key type .fscrypt registered413machine # [ 1.103807] Key type fscrypt-provisioning registered414machine # [ 1.103918] ima: No TPM chip found, activating TPM-bypass!415machine # [ 1.103935] ima: Allocated hash algorithm: sha1416machine # [ 1.103957] ima: No architecture policies found417machine # [ 1.108566] input: gpio-keys as /devices/platform/gpio-keys/input/input0418machine # [ 1.128806] clk: Disabling unused clocks419machine # [ 1.128826] PM: genpd: Disabling unused power domains420machine # [ 1.131798] Freeing unused kernel memory: 4736K421machine # [ 1.132014] Run /init as init process422machine # [ 1.153674] fuse: init (API version 7.45)423machine # [ 1.157407] virtiofs virtio6: discovered new tag: nix-store424machine # [ 1.158246] virtiofs virtio6: virtio_fs_setup_dax: No cache capability425machine # [ 1.174302] virtiofs virtio7: discovered new tag: shared426machine # [ 1.175104] virtiofs virtio7: virtio_fs_setup_dax: No cache capability427machine # [ 1.178155] virtiofs virtio8: discovered new tag: xchg428machine # [ 1.178898] virtiofs virtio8: virtio_fs_setup_dax: No cache capability429machine # [ 1.191388] systemd[1]: Successfully made /usr/ read-only.430machine # [ 1.191916] systemd[1]: systemd 263-409be20 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR)431machine # [ 1.191930] systemd[1]: Detected virtualization qemu.432machine # [ 1.191950] systemd[1]: Detected architecture arm64.433machine # [ 1.191956] systemd[1]: Running in initrd.434machine # [ 1.192240] systemd[1]: Initializing machine ID from random generator.435machine # [ 1.192348] systemd[1]: Hostname set to <machine>.436machine # [ 1.294894] systemd[1]: bpf-restrict-fs: LSM BPF program attached437machine # [ 1.320722] usb 1-1: new high-speed USB device number 2 using ehci-pci438machine # [ 1.358099] systemd[1]: Queued start job for default target Initrd Default Target.439machine # [ 1.366791] systemd[1]: Created slice Slice /system/modprobe.440machine # [ 1.367012] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.441machine # [ 1.367042] systemd[1]: Expecting device /dev/disk/by-label/nixos...442machine # [ 1.367064] systemd[1]: Reached target Path Units.443machine # [ 1.367079] systemd[1]: Reached target Slice Units.444machine # [ 1.367095] systemd[1]: Reached target Swaps.445machine # [ 1.367109] systemd[1]: Reached target Timer Units.446machine # [ 1.367266] systemd[1]: Listening on D-Bus System Message Bus Socket.447machine # [ 1.367427] systemd[1]: Listening on Journal Socket (/dev/log).448machine # [ 1.367580] systemd[1]: Listening on Journal Sockets.449machine # [ 1.367655] systemd[1]: Listening on udev Kernel Socket.450machine # [ 1.367669] systemd[1]: Reached target Socket Units.451machine # [ 1.378331] systemd[1]: Starting Create List of Static Device Nodes...452machine # [ 1.378413] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs453machine # [ 1.388684] systemd[1]: Mounting Kernel Configuration File System...454machine # [ 1.398355] systemd[1]: Starting Journal Service...455machine # [ 1.412930] systemd[1]: Starting Load Kernel Modules...456machine # [ 1.413075] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os457machine # [ 1.445036] systemd[1]: Starting Coldplug All udev Devices...458machine # [ 1.451389] systemd-journald[71]: Collecting audit messages is disabled.459machine # [ 1.465649] systemd[1]: Finished Create List of Static Device Nodes.460machine # [ 1.481458] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...461machine # [ 1.487455] 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/input1462machine # [ 1.488176] systemd[1]: Mounted Kernel Configuration File System.463machine # [ 1.535768] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.464machine # [ 1.552706] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev465machine # [ 1.554669] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.466machine # [ 1.566029] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0467machine # [ 1.566282] [drm] features: -virgl +edid -resource_blob -host_visible468machine # [ 1.566285] [drm] features: -context_init469machine # [ 1.567126] [drm] number of scanouts: 1470machine # [ 1.567139] [drm] number of cap sets: 0471machine # [ 1.567654] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0472machine # [ 1.572933] systemd[1]: Starting Create Static Device Nodes in /dev...473machine # [ 1.593060] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic474machine # [ 1.593078] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0475machine # [ 1.628954] Console: switching to colour frame buffer device 160x50476machine # [ 1.622762] systemd-modules-load[73]: Inserted module 'dm_mod'477machine # [ 1.642457] systemd[1]: Started Journal Service.478machine # [ 1.647763] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device479machine # [ 1.636615] systemd-modules-load[73]: Module 'virtio_balloon' is built in480machine # [ 1.641061] systemd-modules-load[73]: Module 'virtio_console' is built in481machine # [ 1.645226] systemd[1]: Finished Create Static Device Nodes in /dev.482machine # [ 1.656632] systemd[1]: Reached target Preparation for Local File Systems.483machine # [ 1.657977] systemd[1]: Reached target Local File Systems.484machine # [ 1.658916] systemd[1]: Starting Create System Files and Directories...485machine # [ 1.660483] systemd-modules-load[73]: Inserted module 'virtio_gpu'486machine # [ 1.684447] usb 1-2: new high-speed USB device number 3 using ehci-pci487machine # [ 1.669434] systemd-modules-load[73]: Module 'virtio_rng' is built in488machine # [ 1.671653] systemd[1]: Starting Rule-based Manager for Device Events and Files...489machine # [ 1.676985] systemd[1]: Finished Load Kernel Modules.490machine # [ 1.696950] systemd[1]: Starting Apply Kernel Variables...491machine # [ 1.729451] systemd[1]: Finished Create System Files and Directories.492machine # [ 1.757961] systemd[1]: Finished Apply Kernel Variables.493machine # [ 1.775398] systemd-udevd[79]: Using default interface naming scheme 'v261'.494machine # [ 1.805835] systemd[1]: Started Rule-based Manager for Device Events and Files.495machine # [ 1.831950] 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/input2496machine # [ 1.832213] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0497machine # [ 1.929773] systemd[1]: Starting Virtual Console Setup...498machine # [ 2.022569] systemd-vconsole-setup[97]: Configuration of first virtual console was skipped, ignoring remaining ones.499machine # [ 2.028422] systemd[1]: Finished Virtual Console Setup.500machine # [ 2.714537] systemd[1]: Found device /dev/disk/by-label/nixos.501machine # [ 2.728337] systemd[1]: Reached target Initrd Root Device.502machine # [ 2.729239] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...503machine # [ 2.736525] systemd[1]: Finished Coldplug All udev Devices.504machine # [ 2.741664] systemd[1]: Reached target System Initialization.505machine # [ 2.749213] systemd[1]: Reached target Basic System.506machine # [ 2.754457] (udev-worker)[93]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.507machine # [ 2.764455] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.508machine # [ 2.784810] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks509machine # [ 2.792692] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.510machine # [ 2.795624] systemd[1]: Mounting /sysroot...511machine # [ 2.856166] EXT4-fs (vda): mounted filesystem 224d0568-8d9f-44c3-bdae-47c506d0637a r/w with ordered data mode. Quota mode: none.512machine # [ 2.843149] systemd[1]: Mounted /sysroot.513machine # [ 2.845112] systemd[1]: Reached target Initrd Root File System.514machine # [ 2.849793] systemd[1]: Starting Mountpoints Configured in the Real Root...515machine # [ 2.876239] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload.516machine # [ 2.882391] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)...517machine # [ 2.887883] systemd[1]: Reloading...518machine # [ 3.077625] systemd[1]: Reloading finished in 189 ms.519machine # [ 3.114575] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace...520machine # [ 3.120006] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace...521machine # [ 3.129050] systemd[1]: initrd-parse-etc.service: Deactivated successfully.522machine # [ 3.132678] systemd[1]: Finished Mountpoints Configured in the Real Root.523machine # [ 3.134256] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.524machine # [ 3.431784] systemd[1]: Mounting /sysroot/nix/.ro-store...525machine # [ 3.443974] systemd[1]: Mounting /sysroot/nix/.rw-store...526machine # [ 3.456998] systemd[1]: Mounting /sysroot/run...527machine # [ 3.470184] systemd[1]: Mounting /sysroot/tmp/shared...528machine # [ 3.525874] systemd[1]: Mounting /sysroot/tmp/xchg...529machine # [ 3.541803] systemd[1]: Mounted /sysroot/nix/.ro-store.530machine # [ 3.550308] systemd[1]: Mounted /sysroot/nix/.rw-store.531machine # [ 3.556805] systemd[1]: Mounted /sysroot/run.532machine # [ 3.570579] systemd[1]: Mounted /sysroot/tmp/shared.533machine # [ 3.584923] systemd[1]: Starting rw-sysroot-nix-store.service...534machine # [ 3.591942] systemd[1]: Mounted /sysroot/tmp/xchg.535machine # [ 3.624134] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.536machine # [ 3.626008] systemd[1]: Finished rw-sysroot-nix-store.service.537machine # [ 4.038759] (udev-worker)[91]: mtd0ro: Failed to find and pin callout binary "/nix/store/126w02q3bp3kh7554k53zak86km11gnz-systemd-263-409be20/lib/udev/mtd_probe": No such file or directory538machine # [ 4.045271] (udev-worker)[91]: 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.071041] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.540machine # [ 4.078560] systemd[1]: Stopped Virtual Console Setup.541machine # [ 4.079415] systemd[1]: Stopping Virtual Console Setup...542machine # [ 4.080415] systemd[1]: Starting Virtual Console Setup...543machine # [ 4.094503] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.544machine # [ 4.100272] systemd[1]: Stopped Virtual Console Setup.545machine # [ 4.101131] systemd[1]: Starting Virtual Console Setup...546machine # [ 4.120738] systemd-vconsole-setup[151]: Configuration of first virtual console was skipped, ignoring remaining ones.547machine # [ 4.124696] systemd[1]: Finished Virtual Console Setup.548machine # [ 4.430743] systemd[1]: Mounting /sysroot/nix/store...549machine # [ 4.476219] systemd[1]: Mounted /sysroot/nix/store.550machine # [ 4.479035] systemd[1]: Reached target Initrd File Systems.551machine # [ 4.482427] systemd[1]: Starting Find NixOS closure...552machine # [ 4.492517] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...553machine # [ 4.536207] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.554machine # [ 4.539285] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.555machine # [ 4.548512] systemd[1]: Finished Find NixOS closure.556machine # [ 4.550349] systemd[1]: Reached target Initrd Default Target.557machine # [ 4.553485] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...558machine # [ 4.578671] systemd[1]: Stopped target Initrd Default Target.559machine # [ 4.580497] systemd[1]: Stopped target Basic System.560machine # [ 4.584539] systemd[1]: Stopped target Initrd Root Device.561machine # [ 4.585563] systemd[1]: Stopped target Path Units.562machine # [ 4.586409] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.563machine # [ 4.588888] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.564machine # [ 4.595193] systemd[1]: Stopped target Slice Units.565machine # [ 4.600397] systemd[1]: Stopped target Socket Units.566machine # [ 4.602226] systemd[1]: Stopped target System Initialization.567machine # [ 4.605203] systemd[1]: Stopped target Swaps.568machine # [ 4.606462] systemd[1]: Stopped target Timer Units.569machine # [ 4.608368] systemd[1]: dbus.socket: Deactivated successfully.570machine # [ 4.614306] systemd[1]: Closed D-Bus System Message Bus Socket.571machine # [ 4.615354] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.572machine # [ 4.618672] systemd[1]: Stopped Find NixOS closure.573machine # [ 4.619583] systemd[1]: Starting rw-sysroot-nix-store.service...574machine # [ 4.621575] systemd[1]: systemd-sysctl.service: Deactivated successfully.575machine # [ 4.622572] systemd[1]: Stopped Apply Kernel Variables.576machine # [ 4.623366] systemd[1]: systemd-modules-load.service: Deactivated successfully.577machine # [ 4.629844] systemd[1]: Stopped Load Kernel Modules.578machine # [ 4.631615] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.579machine # [ 4.636522] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.580machine # [ 4.639986] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.581machine # [ 4.643260] systemd[1]: Stopped Create System Files and Directories.582machine # [ 4.648332] systemd[1]: Stopped target Local File Systems.583machine # [ 4.649165] systemd[1]: Stopped target Preparation for Local File Systems.584machine # [ 4.650129] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.585machine # [ 4.651152] systemd[1]: Stopped Coldplug All udev Devices.586machine # [ 4.651939] systemd[1]: Stopping Rule-based Manager for Device Events and Files...587machine # [ 4.655189] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.588machine # [ 4.656538] systemd[1]: Stopped Virtual Console Setup.589machine # [ 4.657308] systemd[1]: systemd-udevd.service: Deactivated successfully.590machine # [ 4.658260] systemd[1]: Stopped Rule-based Manager for Device Events and Files.591machine # [ 4.659281] systemd[1]: systemd-udevd.service: Consumed 1.369s CPU time over 2.974s wall clock time, 34M memory peak.592machine # [ 4.660888] systemd[1]: initrd-cleanup.service: Deactivated successfully.593machine # [ 4.661860] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.594machine # [ 4.662812] systemd[1]: Starting Cleanup udev Database...595machine # [ 4.663606] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.596machine # [ 4.669513] systemd[1]: Stopped Create Static Device Nodes in /dev.597machine # [ 4.670486] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.598machine # [ 4.671789] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.599machine # [ 4.676388] systemd[1]: kmod-static-nodes.service: Deactivated successfully.600machine # [ 4.680234] systemd[1]: Stopped Create List of Static Device Nodes.601machine # [ 4.681235] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.602machine # [ 4.684262] systemd[1]: Finished rw-sysroot-nix-store.service.603machine # [ 4.715383] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.604machine # [ 4.718866] systemd[1]: Finished Cleanup udev Database.605machine # [ 4.724299] systemd[1]: Reached target Switch Root.606machine # [ 4.725128] systemd[1]: Starting NixOS Activation...607machine # [ 4.813668] initrd-nixos-activation-start[175]: booting system configuration /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test608machine # [ 4.847712] initrd-nixos-activation-start[175]: running activation script...609machine # [ 5.080782] initrd-nixos-activation-start[198]: setting up /etc...610machine # [ 5.204834] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.611machine # [ 5.207769] systemd[1]: Finished NixOS Activation.612machine # [ 5.212363] systemd[1]: Starting Switch Root...613machine # [ 5.228896] systemd[1]: Switching root.614machine # [ 5.405794] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).615machine # [ 5.502503] NET: Registered PF_VSOCK protocol family616machine # [ 5.580035] systemd[1]: systemd 263-409be20 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR)617machine # [ 5.588667] systemd[1]: Detected virtualization qemu.618machine # [ 5.588727] systemd[1]: Detected architecture arm64.619machine # [ 5.588831] systemd[1]: Detected first boot.620machine # [ 5.590501] systemd[1]: Initializing machine ID from random generator.621machine # [ 5.708592] systemd[1]: bpf-restrict-fs: LSM BPF program attached622machine # [ 5.865279] systemd[1]: Applying preset policy.623machine # [ 6.078520] systemd[1]: Populated /etc with preset unit settings.624machine # [ 6.278668] systemd[1]: initrd-switch-root.service: Deactivated successfully.625machine # [ 6.279103] systemd[1]: Stopped initrd-switch-root.service.626machine # [ 6.284159] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.627machine # [ 6.287341] systemd[1]: Created slice Slice /system/getty.628machine # [ 6.288302] systemd[1]: Created slice User and Session Slice.629machine # [ 6.290974] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.630machine # [ 6.291074] systemd[1]: Started Forward Password Requests to Wall Directory Watch.631machine # [ 6.291458] systemd[1]: Expecting device /dev/hvc0...632machine # [ 6.291734] systemd[1]: Expecting device /dev/ttyAMA0...633machine # [ 6.292013] systemd[1]: Reached target Local Encrypted Volumes.634machine # [ 6.292292] systemd[1]: Stopped target initrd-fs.target.635machine # [ 6.298621] systemd[1]: Stopped target initrd-root-fs.target.636machine # [ 6.299055] systemd[1]: Stopped target initrd-switch-root.target.637machine # [ 6.299776] systemd[1]: Reached target Virtual Machines and Containers.638machine # [ 6.303495] systemd[1]: Reached target Path Units.639machine # [ 6.303899] systemd[1]: Reached target Remote File Systems.640machine # [ 6.306665] systemd[1]: Reached target Slice Units.641machine # [ 6.307063] systemd[1]: Reached target Swaps.642machine # [ 6.310532] systemd[1]: Listening on Query the User Interactively for a Password.643machine # [ 6.313611] systemd[1]: Listening on Process Core Dump Socket.644machine # [ 6.315008] systemd[1]: Listening on Credential Encryption/Decryption.645machine # [ 6.316259] systemd[1]: Listening on Factory Reset Management.646machine # [ 6.319349] systemd[1]: Listening on Hostname Service Socket.647machine # [ 6.323973] systemd[1]: Starting Journal Log Access Socket...648machine # [ 6.327956] systemd[1]: Listening on Journal Audit Socket.649machine # [ 6.331495] systemd[1]: Listening on Console Output Muting Service Socket.650machine # [ 6.332205] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.651machine # [ 6.334756] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os652machine # [ 6.336041] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki653machine # [ 6.344051] systemd[1]: Listening on Disk Repartitioning Service Socket.654machine # [ 6.345744] systemd[1]: Listening on udev Varlink Socket.655machine # [ 6.349288] systemd[1]: Mounting Huge Pages File System...656machine # [ 6.354570] systemd[1]: Mounting POSIX Message Queue File System...657machine # [ 6.366230] systemd[1]: Mounting Kernel Debug File System...658machine # [ 6.374087] systemd[1]: Mounting Kernel Trace File System...659machine # [ 6.391539] systemd[1]: Starting Create List of Static Device Nodes...660machine # [ 6.392105] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs661machine # [ 6.412549] systemd[1]: Mounting Kernel Configuration File System...662machine # [ 6.413111] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm663machine # [ 6.415078] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore664machine # [ 6.415929] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse665machine # [ 6.438440] systemd[1]: Mounting FUSE Control File System...666machine # [ 6.438940] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67667machine # [ 6.477109] systemd[1]: Starting Journal Service...668machine # [ 6.502878] systemd[1]: Starting Load Kernel Modules...669machine # [ 6.540721] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...670machine # [ 6.563475] systemd[1]: Starting Remount Root and Kernel File Systems...671machine # [ 6.563882] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os672machine # [ 6.574780] systemd-journald[269]: Collecting audit messages is enabled.673machine # [ 6.569265] systemd[1]: Queued start job for default target Multi-User System.674machine # [ 6.570735] systemd[1]: Unnecessary job was removed for /sys/devices/platform/9000000.pl011/9000000.pl011:0/9000000.pl011:0.0/tty/ttyAMA0.675machine # [ 6.574200] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0.676machine # [ 6.575528] systemd[1]: systemd-journald.service: Deactivated successfully.677machine # [ 6.597261] systemd[1]: Starting Coldplug All udev Devices...678machine # [ 6.600092] systemd[1]: Started Journal Service.679machine # [ 6.586708] systemd-modules-load[270]: Module 'atkbd' is built in680machine # [ 6.590168] systemd-modules-load[270]: Module 'loop' is built in681machine # [ 6.612343] systemd[1]: Listening on Journal Log Access Socket.682machine # [ 6.621508] systemd[1]: Mounted Huge Pages File System.683machine # [ 6.628076] systemd[1]: Mounted POSIX Message Queue File System.684machine # [ 6.629228] systemd[1]: Mounted Kernel Debug File System.685machine # [ 6.630031] systemd[1]: Mounted Kernel Trace File System.686machine # [ 6.634585] systemd[1]: Finished Create List of Static Device Nodes.687machine # [ 6.643995] systemd[1]: Finished Load Kernel Modules.688machine # [ 6.660415] systemd[1]: Mounted Kernel Configuration File System.689machine # [ 6.677432] systemd[1]: Starting Firewall...690machine # [ 6.691128] systemd[1]: Starting Apply Kernel Variables...691machine # [ 6.693528] systemd-oomd[271]: No swap; memory pressure usage will be degraded692machine # [ 6.698781] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...693machine # [ 6.724627] EXT4-fs (vda): re-mounted 224d0568-8d9f-44c3-bdae-47c506d0637a.694machine # [ 6.709404] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.695machine # [ 6.735187] systemd[1]: Finished Remount Root and Kernel File Systems.696machine # [ 6.750886] systemd[1]: Mounted FUSE Control File System.697machine # [ 6.768296] systemd[1]: Listening on Disk Image Download Service Socket.698machine # [ 6.783393] systemd[1]: Starting Flush Journal to Persistent Storage...699machine # [ 6.786711] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore700machine # [ 6.800948] systemd[1]: Starting Load/Save OS Random Seed...701machine # [ 6.801871] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os702machine # [ 6.922409] systemd-journald[269]: Received client request to flush runtime journal.703machine # [ 6.990294] systemd[1]: Finished Apply Kernel Variables.704machine # [ 6.991504] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.705machine # [ 7.008526] systemd[1]: Starting Create Static Device Nodes in /dev...706machine # [ 7.009563] systemd[1]: Finished Load/Save OS Random Seed.707machine # [ 7.010469] systemd[1]: Reached target First Boot Complete.708machine # [ 7.011337] systemd[1]: Finished Flush Journal to Persistent Storage.709machine # [ 7.137434] systemd[1]: Finished Create Static Device Nodes in /dev.710machine # [ 7.140144] systemd[1]: Reached target Preparation for Local File Systems.711machine # [ 7.143110] systemd[1]: Starting Rule-based Manager for Device Events and Files...712machine # [ 7.268459] systemd[1]: Mounting /run/wrappers...713machine # [ 7.295733] systemd-udevd[307]: Using default interface naming scheme 'v261'.714machine # [ 7.350053] systemd[1]: Mounted /run/wrappers.715machine # [ 7.350929] systemd[1]: Reached target Local File Systems.716machine # [ 7.358974] systemd[1]: Listening on Boot Loader Control Service Socket.717machine # [ 7.366414] systemd[1]: Starting Create SUID/SGID Wrappers...718machine # [ 7.367439] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.719machine # [ 7.380338] systemd[1]: Starting Save Transient machine-id to Disk...720machine # [ 7.396776] systemd[1]: Starting Create System Files and Directories...721machine # [ 7.525666] systemd[1]: Started Rule-based Manager for Device Events and Files.722machine # [ 7.632347] systemd[1]: Finished Create System Files and Directories.723machine # [ 7.642332] systemd[1]: Starting Rebuild Journal Catalog...724machine # [ 7.654945] systemd[1]: Starting Record System Boot/Shutdown in UTMP...725machine # [ 7.789477] systemd[1]: Finished Record System Boot/Shutdown in UTMP.726machine # [ 7.808980] systemd[1]: Finished Rebuild Journal Catalog.727machine # [ 7.818827] systemd[1]: Starting Update is Completed...728machine # [ 7.884259] systemd[1]: Finished Update is Completed.729machine # [ 8.074972] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.730machine # [ 8.087626] systemd[1]: Finished Save Transient machine-id to Disk.731machine # [ 8.108221] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs732machine # [ 8.165044] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse733machine # [ 8.303078] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.734machine # [ 8.309044] systemd[1]: Finished Create SUID/SGID Wrappers.735machine # [ 8.440844] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.736machine # [ 8.480291] systemd[1]: Finished Coldplug All udev Devices.737machine # [ 8.482981] systemd[1]: Reached target System Initialization.738machine # [ 8.483994] systemd[1]: Started Discard unused filesystem blocks once a week.739machine # [ 8.491611] systemd[1]: Started Daily Cleanup of Temporary Directories.740machine # [ 8.496653] systemd[1]: Reached target Timer Units.741machine # [ 8.497497] systemd[1]: Listening on D-Bus System Message Bus Socket.742machine # [ 8.498468] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.743machine # [ 8.499743] systemd[1]: Reached target Socket Units.744machine # [ 8.512244] systemd[1]: Reached target Basic System.745machine # [ 8.513091] systemd[1]: Starting Import lastlog data into lastlog2 database...746machine # [ 8.514185] systemd[1]: Starting Name Service Cache Daemon (nsncd)...747machine # [ 8.515145] systemd[1]: Starting Post-Boot Actions...748machine # [ 8.557445] systemd[1]: Started Reset console on configuration changes.749machine # [ 8.593778] systemd[1]: Starting resolvconf update...750machine # [ 8.602952] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.751machine # [ 8.645428] systemd[1]: Started backdoor.service.752machine # [ 8.701934] systemd[1]: Starting D-Bus System Message Bus...753machine # [ 8.710351] nsncd[429]: Oct 18 02:43:36.163 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"754machine # [ 8.736489] systemd[1]: Started Name Service Cache Daemon (nsncd).755machine # [ 8.751980] systemd[1]: Finished Post-Boot Actions.756machine # [ 8.767821] systemd[1]: Reached target Host and Network Name Lookups.757machine # [ 8.776860] systemd[1]: Reached target User and Group Name Lookups.758machine # [ 8.835503] systemd[1]: Starting User Login Management...759machine # [ 8.849755] (udev-worker)[338]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.760machine # [ 8.868804] (udev-worker)[338]: Network interface NamePolicy= disabled on kernel command line.761machine # connecting to host...762machine: Guest shell says: b'Spawning backdoor root shell...\n'763machine: connected to guest root shell764machine # [ 8.959493] dbus-broker-launch[440]: Looking up NSS user entry for 'systemd-timesync'...765machine: (connecting took 9.29 seconds)766machine: (finished: waiting for the VM to finish booting, in 9.74 seconds)767machine # [ 8.970654] dbus-broker-launch[440]: NSS returned no entry for 'systemd-timesync'768machine # [ 8.971849] dbus-broker-launch[440]: Invalid user-name in /nix/store/aw77bp4zfc97zizid5h923yc6ngjgsdp-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"769machine # [ 8.995421] systemd[1]: Finished Import lastlog data into lastlog2 database.770machine # [ 9.028481] systemd[1]: Started D-Bus System Message Bus.771machine # [ 9.096748] dbus-broker-launch[440]: Ready772machine # [ 9.151039] systemd-logind[457]: New seat seat0.773machine # [ 9.232549] systemd[1]: Started User Login Management.774machine # [ 9.262830] systemd[1]: Stopped target Host and Network Name Lookups.775machine # [ 9.270511] systemd[1]: Stopping Host and Network Name Lookups...776machine # [ 9.271555] systemd[1]: Stopped target User and Group Name Lookups.777machine # [ 9.279689] systemd[1]: Stopping User and Group Name Lookups...778machine # [ 9.287442] systemd[1]: Starting linger-users.service...779machine # [ 9.293689] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...780machine # [ 9.294738] systemd[1]: nscd.service: Deactivated successfully.781machine # [ 9.302529] systemd[1]: Stopped Name Service Cache Daemon (nsncd).782machine # [ 9.389778] systemd[1]: Starting Name Service Cache Daemon (nsncd)...783machine # [ 9.483814] systemd[1]: Created slice Slice /user/1001.784machine # [ 9.507658] systemd[1]: Starting User Runtime Directory /run/user/1001...785machine # [ 9.516773] systemd[1]: Started Name Service Cache Daemon (nsncd).786machine # [ 9.518150] nsncd[547]: Oct 18 02:43:36.971 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"787machine # [ 9.551086] systemd[1]: Reached target Host and Network Name Lookups.788machine # [ 9.558927] systemd[1]: Reached target User and Group Name Lookups.789machine # [ 9.567739] systemd[1]: linger-users.service: Deactivated successfully.790machine # [ 9.571729] systemd[1]: Finished linger-users.service.791machine # [ 9.575954] systemd[1]: Finished resolvconf update.792machine # [ 9.593179] systemd[1]: Condition check resulted in Virtio network device being skipped.793machine # [ 9.594456] systemd[1]: Condition check resulted in Virtio network device being skipped.794machine # [ 9.606087] systemd[1]: Starting DHCP Client...795machine # [ 9.660957] systemd[1]: Finished User Runtime Directory /run/user/1001.796machine # [ 9.694103] systemd[1]: Starting User Manager for UID 1001...797machine # [ 9.729809] systemd[1]: Finished Firewall.798machine # [ 9.730585] systemd[1]: Reached target Preparation for Network.799machine # [ 9.763392] systemd-logind[457]: Watching system buttons on /dev/input/event0 (gpio-keys)800machine # [ 9.792397] systemd[1]: Starting Address configuration of eth1...801machine # [ 9.820485] systemd[1]: Starting Extra networking commands....802machine # [ 9.911136] mousedev: PS/2 mouse device common for all mice803machine # [ 9.908530] (systemd)[589]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0)804machine # [ 9.949504] systemd-logind[457]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'.805machine # [ 10.024596] systemd-logind[457]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)806machine # [ 10.026339] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy807machine # [ 10.308986] systemd[589]: Queued start job for default target Main User Target.808machine # [ 10.310239] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy809machine # [ 10.334335] systemd[589]: Created slice User Application Slice.810machine # [ 10.335494] systemd[589]: Started Daily Cleanup of User's Temporary Directories.811machine # [ 10.337209] systemd[589]: Reached target Paths.812machine # [ 10.338035] systemd[589]: Reached target Timers.813machine # [ 10.338774] systemd[589]: Starting D-Bus User Message Bus Socket...814machine # [ 10.339723] systemd[589]: Starting Create User Files and Directories...815machine # [ 10.401321] systemd[589]: Finished Create User Files and Directories.816machine # [ 10.424712] systemd[589]: Listening on D-Bus User Message Bus Socket.817machine # [ 10.425826] systemd[589]: Reached target Sockets.818machine # [ 10.426571] systemd[589]: Reached target Basic System.819machine # [ 10.427374] systemd[1]: Started User Manager for UID 1001.820machine # [ 10.466065] systemd[589]: Starting Run user-specific NixOS activation...821machine # [ 10.484387] systemd[589]: Finished Run user-specific NixOS activation.822machine # [ 10.492917] systemd[589]: Reached target Main User Target.823machine # [ 10.493896] systemd[589]: Startup finished in 494ms.824machine # [ 10.510192] network-addresses-eth1-start[592]: adding address 192.168.1.1/24... done825machine # [ 10.539184] network-addresses-eth1-start[592]: adding address 2001:db8:1::1/64... done826machine # [ 10.621795] systemd[1]: Finished Address configuration of eth1.827machine # [ 10.717463] dhcpcd[596]: dhcpcd-10.3.2 starting828machine # [ 10.769404] dhcpcd[663]: dev: loaded udev829machine # [ 10.822628] 8021q: 802.1Q VLAN Support v1.8830machine # [ 10.822991] 8021q: adding VLAN 0 to HW filter on device eth1831machine # [ 10.935777] cfg80211: Loading compiled-in X.509 certificates for regulatory database832machine # [ 10.997479] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'833machine # [ 10.997980] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'834machine # [ 11.000119] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2835machine # [ 11.000625] cfg80211: failed to load regulatory.db836machine # [ 11.296823] systemd[1]: Finished Extra networking commands..837machine # [ 11.297759] systemd[1]: Reached target Network.838machine # [ 11.334506] systemd[1]: Starting Permit User Sessions...839machine # [ 11.384585] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3840machine # [ 11.574222] systemd[1]: Finished Permit User Sessions.841machine # [ 11.613918] systemd[1]: Started Getty on tty1.842machine # [ 11.614728] systemd[1]: Reached target Login Prompts.843machine # [ 11.760135] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.844machine # [ 11.770288] systemd[1]: Starting Virtual Console Setup...845machine # [ 11.812397] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.846machine # [ 11.816223] systemd[1]: Stopped Virtual Console Setup.847machine # [ 11.818509] systemd[1]: Starting Virtual Console Setup...848machine # [ 11.827238] systemd-logind[457]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)849machine # [ 11.992882] systemd-vconsole-setup[709]: Configuration of first virtual console was skipped, ignoring remaining ones.850machine # [ 11.998810] systemd[1]: Finished Virtual Console Setup.851machine # [ 12.379601] 8021q: adding VLAN 0 to HW filter on device eth0852machine # [ 12.363174] dhcpcd[663]: eth0: waiting for carrier853machine # [ 12.369751] dhcpcd[663]: libudev: received NULL device854machine # [ 12.371137] dhcpcd[663]: libudev: received NULL device855machine # [ 12.374106] dhcpcd[663]: eth0: carrier acquired856machine # [ 12.382529] dhcpcd[663]: DUID 00:01:00:01:32:66:ee:db:52:54:00:12:34:56857machine # [ 12.384758] dhcpcd[663]: eth0: IAID 00:12:34:56858machine # [ 12.385935] dhcpcd[663]: eth0: adding address fe80::5054:ff:fe12:3456859machine # [ 13.545313] dhcpcd[663]: eth0: soliciting an IPv6 router860machine # [ 13.547058] dhcpcd[663]: eth0: Router Advertisement from fe80::2861machine # [ 13.548577] dhcpcd[663]: eth0: adding address fec0::5054:ff:fe12:3456/64862machine # [ 13.550164] dhcpcd[663]: eth0: adding route to fec0::/64863machine # [ 13.551447] dhcpcd[663]: eth0: adding default route via fe80::2864machine # [ 14.003943] dhcpcd[663]: eth0: soliciting a DHCP lease865machine # [ 14.006209] dhcpcd[663]: eth0: offered 10.0.2.15 from 10.0.2.2866machine # [ 14.008490] dhcpcd[663]: eth0: probing address 10.0.2.15/24867machine # [ 18.440789] dhcpcd[663]: eth0: leased 10.0.2.15 for 86400 seconds868machine # [ 18.443092] dhcpcd[663]: eth0: adding route to 10.0.2.0/24869machine # [ 18.446070] dhcpcd[663]: eth0: adding default route via 10.0.2.2870machine # [ 18.550537] systemd[1]: Started DHCP Client.871machine # [ 18.552738] systemd[1]: Reached target Multi-User System.872machine # [ 18.553635] systemd[1]: Startup finished in 1.117s (kernel) + 4.344s (initrd) + 13.090s (userspace) = 18.552s.873machine: (finished: waiting for unit multi-user.target, in 20.22 seconds)874machine: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/bin/switch-to-configuration test875machine # Checking switch inhibitors... done876machine # [ 19.686810] nixos[848]: switching to system configuration /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test877machine # activating the configuration...878machine # [ 19.692068] systemd[1]: Stopped target Remote File Systems.879machine # [ 19.694312] systemd[1]: Stopped target Local File Systems.880machine # setting up /etc...881machine # [ 20.003176] systemd[1]: Reload requested from client PID 848 ('.switch-to-conf') (unit backdoor.service)...882machine # [ 20.005529] systemd[1]: Reloading...883machine # [ 20.360259] systemd[1]: Reloading finished in 353 ms.884machine # reloading user units for usertest...885machine # [ 20.416664] systemd[589]: Created slice User Core Session Slice.886machine # [ 20.419617] systemd[589]: Starting D-Bus User Message Bus...887machine # [ 20.456584] dbus-broker-launch[918]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/aw77bp4zfc97zizid5h923yc6ngjgsdp-system-path/share/dbus-1/services/org.freedesktop.import1.service'888machine # [ 20.459873] dbus-broker-launch[918]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/aw77bp4zfc97zizid5h923yc6ngjgsdp-system-path/share/dbus-1/services/org.freedesktop.machine1.service'889machine # [ 20.463761] dbus-broker-launch[918]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/aw77bp4zfc97zizid5h923yc6ngjgsdp-system-path/share/dbus-1/services/org.freedesktop.portable1.service'890machine # [ 20.467260] dbus-broker-launch[918]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/aw77bp4zfc97zizid5h923yc6ngjgsdp-system-path/share/dbus-1/services/org.freedesktop.systemd1.service'891machine # [ 20.472347] dbus-broker-launch[918]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored892machine # [ 20.474532] dbus-broker-launch[918]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored893machine # [ 20.478267] systemd[589]: Started D-Bus User Message Bus.894machine # [ 20.481531] dbus-broker-launch[918]: Ready895machine # [ 20.528354] systemd[589]: Reexecution requested from client PID 917 ('switch-to-confi')...896machine # [ 20.530684] systemd[589]: Reexecuting.897machine # [ 20.583649] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy898machine # [ 20.698300] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy899machine # [ 20.705542] systemd[589]: Reload requested from client PID 917 ('switch-to-confi')...900machine # [ 20.709897] systemd[589]: Reloading...901machine # [ 20.818638] systemd[589]: Reloading finished in 109 ms.902machine # [ 20.836227] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy903machine # restarting the following user units: nixos-activation.service904machine # [ 20.849901] systemd[589]: Stopped Run user-specific NixOS activation.905machine # [ 20.851056] systemd[589]: Stopping Run user-specific NixOS activation...906machine # [ 20.854478] systemd[589]: Starting Run user-specific NixOS activation...907machine # [ 20.891080] systemd[589]: Finished Run user-specific NixOS activation.908machine # restarting sysinit-reactivation.target909machine # [ 20.904556] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....910machine # [ 21.016369] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..911machine # [ 21.021151] systemd[1]: Reached target Reactivate sysinit units.912machine # [ 21.031700] systemd[1]: Reached target Remote File Systems.913machine # [ 21.038159] systemd[1]: Starting linger-users.service...914machine # [ 21.051072] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os915machine # [ 21.061826] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki916machine # [ 21.063320] systemd[1]: Reached target Local File Systems.917machine # [ 21.076172] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore918machine # [ 21.077861] systemd[1]: Starting Create SUID/SGID Wrappers...919machine # [ 21.084939] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.920machine # [ 21.090026] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67921machine # [ 21.094635] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore922machine # [ 21.101898] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os923machine # [ 21.106995] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os924machine # [ 21.144878] systemd[1]: linger-users.service: Deactivated successfully.925machine # [ 21.149807] systemd[1]: Finished linger-users.service.926machine # [ 21.297946] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.927machine # [ 21.301174] systemd[1]: Finished Create SUID/SGID Wrappers.928machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service929machine # [ 21.559238] nixos[848]: finished switching to system configuration /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test930machine: (finished: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/bin/switch-to-configuration test, in 2.11 seconds)931machine: must succeed: rm /etc/NIXOS932machine: (finished: must succeed: rm /etc/NIXOS, in 0.02 seconds)933machine: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/22ll2x53424p9fj6p91fp0gs4x5k1nb0-nixos-system-other-test/bin/switch-to-configuration test934machine # this should succeed (config: /nix/store/22ll2x53424p9fj6p91fp0gs4x5k1nb0-nixos-system-other-test, action: test)935machine # Checking switch inhibitors... done936machine # [ 21.819036] nixos[996]: switching to system configuration /nix/store/22ll2x53424p9fj6p91fp0gs4x5k1nb0-nixos-system-other-test937machine # [ 21.822369] systemd[1]: Stopped target Local File Systems.938machine # activating the configuration...939machine # [ 21.826366] systemd[1]: Stopped target Remote File Systems.940machine # removing user ‘usertest’941machine # setting up /etc...942machine # [ 22.134656] systemd[1]: Reload requested from client PID 996 ('.switch-to-conf') (unit backdoor.service)...943machine # [ 22.136882] systemd[1]: Reloading...944machine # [ 22.481243] systemd[1]: Reloading finished in 342 ms.945machine # reloading user units for usertest...946machine # [ 22.579476] systemd[589]: Reexecution requested from client PID 1067 ('switch-to-confi')...947machine # [ 22.584430] systemd[589]: Reexecuting.948machine # [ 22.643582] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy949machine # [ 22.762410] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy950machine # [ 22.769553] systemd[589]: Reload requested from client PID 1067 ('switch-to-confi')...951machine # [ 22.773411] systemd[589]: Reloading...952machine # [ 22.884489] systemd[589]: Reloading finished in 112 ms.953machine # [ 22.900197] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy954machine # restarting the following user units: nixos-activation.service955machine # [ 22.911269] systemd[589]: Stopped Run user-specific NixOS activation.956machine # [ 22.913821] systemd[589]: Stopping Run user-specific NixOS activation...957machine # [ 22.916189] systemd[589]: Starting Run user-specific NixOS activation...958machine # [ 22.949160] systemd[589]: Finished Run user-specific NixOS activation.959machine # restarting sysinit-reactivation.target960machine # [ 22.954093] systemd[1]: Stopped target Reactivate sysinit units.961machine # [ 22.957378] systemd[1]: Stopping Reactivate sysinit units...962machine # [ 22.958304] systemd[1]: Reached target Reactivate sysinit units.963machine # reloading the following units: dbus-broker.service964machine # [ 22.962768] systemd[1]: Reloading D-Bus System Message Bus...965machine # [ 22.964699] dbus-broker-launch[440]: Caught SIGHUP, trigger reload.966machine # [ 22.972164] dbus-broker-launch[440]: Looking up NSS user entry for 'systemd-timesync'...967machine # [ 22.975219] dbus-broker-launch[440]: NSS returned no entry for 'systemd-timesync'968machine # [ 22.976721] dbus-broker-launch[440]: Invalid user-name in /nix/store/vyh4zsqmi6nyb6wdmb4339cvwm6bpmb8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"969machine # [ 22.994825] systemd[1]: Reloaded D-Bus System Message Bus.970machine # restarting the following units: network-addresses-eth1.service971machine # [ 23.002715] systemd[1]: Stopping Address configuration of eth1...972machine # [ 23.042482] network-addresses-eth1-pre-stop[1079]: deleting address 192.168.1.1/24... done973machine # [ 23.051766] network-addresses-eth1-pre-stop[1079]: deleting address 2001:db8:1::1/64... done974machine # [ 23.059855] systemd[1]: network-addresses-eth1.service: Deactivated successfully.975machine # [ 23.062728] systemd[1]: Stopped Address configuration of eth1.976machine # [ 23.067733] systemd[1]: Starting Address configuration of eth1...977machine # [ 23.111469] network-addresses-eth1-start[1084]: adding address 192.168.1.2/24... done978machine # [ 23.122108] network-addresses-eth1-start[1084]: adding address 2001:db8:1::2/64... done979machine # [ 23.132191] systemd[1]: Finished Address configuration of eth1.980machine # [ 23.135846] systemd[1]: Reached target Remote File Systems.981machine # [ 23.139617] systemd[1]: Reached target Local File Systems.982machine # [ 23.146813] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore983machine # [ 23.152667] systemd[1]: Starting Create SUID/SGID Wrappers...984machine # [ 23.153613] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.985machine # [ 23.154907] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67986machine # [ 23.162595] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore987machine # [ 23.173008] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os988machine # [ 23.174543] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os989machine # [ 23.177044] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os990machine # [ 23.179101] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki991machine # [ 23.361747] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.992machine # [ 23.364359] systemd[1]: Finished Create SUID/SGID Wrappers.993machine # [ 23.369211] systemd[1]: Starting linger-users.service...994machine # [ 23.399125] linger-users-start[1156]: id: ‘usertest’: no such user995machine # [ 23.401302] linger-users-start[1154]: Removing linger for missing user usertest996machine # [ 23.408177] systemd[1]: linger-users.service: Deactivated successfully.997machine # [ 23.410014] systemd[1]: Finished linger-users.service.998machine # [ 23.666770] nixos[996]: finished switching to system configuration /nix/store/22ll2x53424p9fj6p91fp0gs4x5k1nb0-nixos-system-other-test999machine: (finished: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/22ll2x53424p9fj6p91fp0gs4x5k1nb0-nixos-system-other-test/bin/switch-to-configuration test, in 2.09 seconds)1000subtest: services1001machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/bin/switch-to-configuration test 2>&11002machine # [ 23.891536] nixos[1162]: switching to system configuration /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test1003machine # [ 23.894174] systemd[1]: Stopped target Remote File Systems.1004machine # [ 23.896641] systemd[1]: Stopped target Local File Systems.1005machine # [ 24.171734] systemd[1]: Reload requested from client PID 1162 ('.switch-to-conf') (unit backdoor.service)...1006machine # [ 24.174184] systemd[1]: Reloading...1007machine # [ 24.506562] systemd[1]: Reloading finished in 331 ms.1008machine # [ 24.627573] systemd[589]: Reexecution requested from client PID 1231 ('switch-to-confi')...1009machine # [ 24.630086] systemd[589]: Reexecuting.1010machine # [ 24.688167] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1011machine # [ 24.805129] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1012machine # [ 24.812278] systemd[589]: Reload requested from client PID 1231 ('switch-to-confi')...1013machine # [ 24.814747] systemd[589]: Reloading...1014machine # [ 24.927370] systemd[589]: Reloading finished in 111 ms.1015machine # [ 24.940210] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1016machine # [ 24.952585] systemd[589]: Stopped Run user-specific NixOS activation.1017machine # [ 24.955268] systemd[589]: Stopping Run user-specific NixOS activation...1018machine # [ 24.957752] systemd[589]: Starting Run user-specific NixOS activation...1019machine # [ 24.994196] systemd[589]: Finished Run user-specific NixOS activation.1020machine # [ 24.998694] systemd[1]: Stopped target Reactivate sysinit units.1021machine # [ 25.004325] systemd[1]: Stopping Reactivate sysinit units...1022machine # [ 25.005339] systemd[1]: Reached target Reactivate sysinit units.1023machine # [ 25.006591] dbus-broker-launch[440]: Caught SIGHUP, trigger reload.1024machine # [ 25.007540] systemd[1]: Reloading D-Bus System Message Bus...1025machine # [ 25.012326] dbus-broker-launch[440]: Looking up NSS user entry for 'systemd-timesync'...1026machine # [ 25.014642] dbus-broker-launch[440]: NSS returned no entry for 'systemd-timesync'1027machine # [ 25.015783] dbus-broker-launch[440]: Invalid user-name in /nix/store/aw77bp4zfc97zizid5h923yc6ngjgsdp-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1028machine # [ 25.042727] systemd[1]: Reloaded D-Bus System Message Bus.1029machine # [ 25.049369] systemd[1]: Stopping Address configuration of eth1...1030machine # [ 25.085353] network-addresses-eth1-pre-stop[1244]: deleting address 192.168.1.2/24... done1031machine # [ 25.092653] network-addresses-eth1-pre-stop[1244]: deleting address 2001:db8:1::2/64... done1032machine # [ 25.100356] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1033machine # [ 25.102823] systemd[1]: Stopped Address configuration of eth1.1034machine # [ 25.107688] systemd[1]: Starting Address configuration of eth1...1035machine # [ 25.152989] network-addresses-eth1-start[1249]: adding address 192.168.1.1/24... done1036machine # [ 25.160875] network-addresses-eth1-start[1249]: adding address 2001:db8:1::1/64... done1037machine # [ 25.171039] systemd[1]: Finished Address configuration of eth1.1038machine # [ 25.174874] systemd[1]: Reached target Local File Systems.1039machine # [ 25.180454] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1040machine # [ 25.187344] systemd[1]: Starting Create SUID/SGID Wrappers...1041machine # [ 25.192694] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1042machine # [ 25.194015] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671043machine # [ 25.201266] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1044machine # [ 25.202976] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1045machine # [ 25.210019] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1046machine # [ 25.211357] systemd[1]: Reached target Remote File Systems.1047machine # [ 25.212319] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1048machine # [ 25.213653] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1049machine # [ 25.405685] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1050machine # [ 25.407734] systemd[1]: Finished Create SUID/SGID Wrappers.1051machine # [ 25.415113] systemd[1]: Starting linger-users.service...1052machine # [ 25.456001] systemd[1]: linger-users.service: Deactivated successfully.1053machine # [ 25.459318] systemd[1]: Finished linger-users.service.1054machine # [ 25.715359] nixos[1162]: finished switching to system configuration /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test1055machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.05 seconds)1056machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/bin/switch-to-configuration test 2>&11057machine # [ 25.947704] nixos[1318]: switching to system configuration /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test1058machine # [ 25.953609] systemd[1]: Stopped target Remote File Systems.1059machine # [ 25.954563] systemd[1]: Stopped target Local File Systems.1060machine # [ 26.249412] systemd[1]: Reload requested from client PID 1318 ('.switch-to-conf') (unit backdoor.service)...1061machine # [ 26.251412] systemd[1]: Reloading...1062machine # [ 26.574065] systemd[1]: Reloading finished in 320 ms.1063machine # [ 26.667284] systemd[589]: Reexecution requested from client PID 1387 ('switch-to-confi')...1064machine # [ 26.669988] systemd[589]: Reexecuting.1065machine # [ 26.728387] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1066machine # [ 26.845467] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1067machine # [ 26.853730] systemd[589]: Reload requested from client PID 1387 ('switch-to-confi')...1068machine # [ 26.855189] systemd[589]: Reloading...1069machine # [ 26.963522] systemd[589]: Reloading finished in 107 ms.1070machine # [ 26.980198] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1071machine # [ 26.993257] systemd[589]: Stopped Run user-specific NixOS activation.1072machine # [ 26.995863] systemd[589]: Stopping Run user-specific NixOS activation...1073machine # [ 26.998423] systemd[589]: Starting Run user-specific NixOS activation...1074machine # [ 27.033757] systemd[589]: Finished Run user-specific NixOS activation.1075machine # [ 27.037717] systemd[1]: Stopped target Reactivate sysinit units.1076machine # [ 27.039944] systemd[1]: Stopping Reactivate sysinit units...1077machine # [ 27.042656] systemd[1]: Reached target Reactivate sysinit units.1078machine # [ 27.049617] systemd[1]: Reached target Local File Systems.1079machine # [ 27.053125] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1080machine # [ 27.060776] systemd[1]: Starting Create SUID/SGID Wrappers...1081machine # [ 27.061749] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1082machine # [ 27.063020] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671083machine # [ 27.075539] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1084machine # [ 27.077765] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1085machine # [ 27.079115] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1086machine # [ 27.080474] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1087machine # [ 27.081835] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1088machine # [ 27.083129] systemd[1]: Reached target Remote File Systems.1089machine # [ 27.249856] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1090machine # [ 27.255185] systemd[1]: Finished Create SUID/SGID Wrappers.1091machine # [ 27.257866] systemd[1]: Starting linger-users.service...1092machine # [ 27.299499] systemd[1]: linger-users.service: Deactivated successfully.1093machine # [ 27.302727] systemd[1]: Finished linger-users.service.1094machine # [ 27.558692] nixos[1318]: finished switching to system configuration /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test1095machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.84 seconds)1096machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11097machine # [ 27.809828] nixos[1458]: switching to system configuration /nix/store/dirqgdjyc79fsfw0gf7r88l24kbyz510-nixos-system-machine-test1098machine # [ 27.812753] systemd[1]: Stopped target Local File Systems.1099machine # [ 27.814983] systemd[1]: Stopped target Remote File Systems.1100machine # [ 28.107383] systemd[1]: Reload requested from client PID 1458 ('.switch-to-conf') (unit backdoor.service)...1101machine # [ 28.109669] systemd[1]: Reloading...1102machine # [ 28.427195] systemd[1]: Reloading finished in 315 ms.1103machine # [ 28.514050] systemd[589]: Reexecution requested from client PID 1528 ('switch-to-confi')...1104machine # [ 28.517727] systemd[589]: Reexecuting.1105machine # [ 28.575577] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1106machine # [ 28.686554] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1107machine # [ 28.693615] systemd[589]: Reload requested from client PID 1528 ('switch-to-confi')...1108machine # [ 28.696237] systemd[589]: Reloading...1109machine # [ 28.802130] systemd[589]: Reloading finished in 104 ms.1110machine # [ 28.820250] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1111machine # [ 28.830804] systemd[589]: Stopped Run user-specific NixOS activation.1112machine # [ 28.833375] systemd[589]: Stopping Run user-specific NixOS activation...1113machine # [ 28.835648] systemd[589]: Starting Run user-specific NixOS activation...1114machine # [ 28.869736] systemd[589]: Finished Run user-specific NixOS activation.1115machine # [ 28.874148] systemd[1]: Stopped target Reactivate sysinit units.1116machine # [ 28.878518] systemd[1]: Stopping Reactivate sysinit units...1117machine # [ 28.879476] systemd[1]: Reached target Reactivate sysinit units.1118machine # [ 28.881255] systemd[1]: Reached target Remote File Systems.1119machine # [ 28.882131] systemd[1]: Reached target Local File Systems.1120machine # [ 28.889559] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1121machine # [ 28.896911] systemd[1]: Starting Create SUID/SGID Wrappers...1122machine # [ 28.897877] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1123machine # [ 28.899179] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671124machine # [ 28.911077] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1125machine # [ 28.913094] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1126machine # [ 28.914431] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1127machine # [ 28.915680] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1128machine # [ 28.917265] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1129machine # [ 29.084239] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1130machine # [ 29.088595] systemd[1]: Finished Create SUID/SGID Wrappers.1131machine # [ 29.092334] systemd[1]: Starting linger-users.service...1132machine # [ 29.096510] systemd[1]: Starting test.service...1133machine # [ 29.138154] systemd[1]: Finished test.service.1134machine # [ 29.157206] systemd[1]: linger-users.service: Deactivated successfully.1135machine # [ 29.160713] systemd[1]: Finished linger-users.service.1136machine # [ 29.415630] nixos[1458]: finished switching to system configuration /nix/store/dirqgdjyc79fsfw0gf7r88l24kbyz510-nixos-system-machine-test1137machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.86 seconds)1138machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11139machine # [ 29.629108] nixos[1601]: switching to system configuration /nix/store/dirqgdjyc79fsfw0gf7r88l24kbyz510-nixos-system-machine-test1140machine # [ 29.631979] systemd[1]: Stopped target Local File Systems.1141machine # [ 29.634798] systemd[1]: Stopped target Remote File Systems.1142machine # [ 29.902960] systemd[1]: Reload requested from client PID 1601 ('.switch-to-conf') (unit backdoor.service)...1143machine # [ 29.905061] systemd[1]: Reloading...1144machine # [ 30.211727] systemd[1]: Reloading finished in 305 ms.1145machine # [ 30.300287] systemd[589]: Reexecution requested from client PID 1670 ('switch-to-confi')...1146machine # [ 30.301719] systemd[589]: Reexecuting.1147machine # [ 30.364140] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1148machine # [ 30.482557] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1149machine # [ 30.489148] systemd[589]: Reload requested from client PID 1670 ('switch-to-confi')...1150machine # [ 30.492081] systemd[589]: Reloading...1151machine # [ 30.598287] systemd[589]: Reloading finished in 106 ms.1152machine # [ 30.612176] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1153machine # [ 30.622508] systemd[589]: Stopped Run user-specific NixOS activation.1154machine # [ 30.624944] systemd[589]: Stopping Run user-specific NixOS activation...1155machine # [ 30.627026] systemd[589]: Starting Run user-specific NixOS activation...1156machine # [ 30.660544] systemd[589]: Finished Run user-specific NixOS activation.1157machine # [ 30.665241] systemd[1]: Stopped target Reactivate sysinit units.1158machine # [ 30.666238] systemd[1]: Stopping Reactivate sysinit units...1159machine # [ 30.667043] systemd[1]: Reached target Reactivate sysinit units.1160machine # [ 30.672710] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1161machine # [ 30.676895] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1162machine # [ 30.678647] systemd[1]: Reached target Remote File Systems.1163machine # [ 30.683028] systemd[1]: Starting linger-users.service...1164machine # [ 30.688833] systemd[1]: Reached target Local File Systems.1165machine # [ 30.696848] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1166machine # [ 30.701644] systemd[1]: Starting Create SUID/SGID Wrappers...1167machine # [ 30.702592] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1168machine # [ 30.703856] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671169machine # [ 30.713553] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1170machine # [ 30.719249] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1171machine # [ 30.725210] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1172machine # [ 30.769268] systemd[1]: linger-users.service: Deactivated successfully.1173machine # [ 30.773623] systemd[1]: Finished linger-users.service.1174machine # [ 30.905509] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1175machine # [ 30.908720] systemd[1]: Finished Create SUID/SGID Wrappers.1176machine # [ 31.164507] nixos[1601]: finished switching to system configuration /nix/store/dirqgdjyc79fsfw0gf7r88l24kbyz510-nixos-system-machine-test1177machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.75 seconds)1178machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&11179machine # [ 31.400517] nixos[1742]: switching to system configuration /nix/store/170zwzshxiqq37nakm0y7ibnrg6y1asz-nixos-system-machine-test1180machine # [ 31.403050] systemd[1]: Stopped target Local File Systems.1181machine # [ 31.405429] systemd[1]: Stopped target Remote File Systems.1182machine # [ 31.700617] systemd[1]: Reload requested from client PID 1742 ('.switch-to-conf') (unit backdoor.service)...1183machine # [ 31.702581] systemd[1]: Reloading...1184machine # [ 32.065818] systemd[1]: Reloading finished in 361 ms.1185machine # [ 32.160518] systemd[589]: Reexecution requested from client PID 1811 ('switch-to-confi')...1186machine # [ 32.163360] systemd[589]: Reexecuting.1187machine # [ 32.224160] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1188machine # [ 32.340990] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1189machine # [ 32.348326] systemd[589]: Reload requested from client PID 1811 ('switch-to-confi')...1190machine # [ 32.350835] systemd[589]: Reloading...1191machine # [ 32.462742] systemd[589]: Reloading finished in 110 ms.1192machine # [ 32.480214] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1193machine # [ 32.491369] systemd[589]: Stopped Run user-specific NixOS activation.1194machine # [ 32.494136] systemd[589]: Stopping Run user-specific NixOS activation...1195machine # [ 32.496434] systemd[589]: Starting Run user-specific NixOS activation...1196machine # [ 32.530994] systemd[589]: Finished Run user-specific NixOS activation.1197machine # [ 32.535198] systemd[1]: Stopped target Reactivate sysinit units.1198machine # [ 32.537691] systemd[1]: Stopping Reactivate sysinit units...1199machine # [ 32.538626] systemd[1]: Reached target Reactivate sysinit units.1200machine # [ 32.541371] systemd[1]: Reached target Local File Systems.1201machine # [ 32.546055] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1202machine # [ 32.550690] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1203machine # [ 32.560457] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1204machine # [ 32.562109] systemd[1]: Starting Create SUID/SGID Wrappers...1205machine # [ 32.562972] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1206machine # [ 32.572394] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671207machine # [ 32.574728] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1208machine # [ 32.576689] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1209machine # [ 32.578047] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1210machine # [ 32.579312] systemd[1]: Reached target Remote File Systems.1211machine # [ 32.747410] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1212machine # [ 32.752586] systemd[1]: Finished Create SUID/SGID Wrappers.1213machine # [ 32.755469] systemd[1]: Starting linger-users.service...1214machine # [ 32.806019] systemd[1]: linger-users.service: Deactivated successfully.1215machine # [ 32.808132] systemd[1]: Finished linger-users.service.1216machine # [ 33.066405] nixos[1742]: finished switching to system configuration /nix/store/170zwzshxiqq37nakm0y7ibnrg6y1asz-nixos-system-machine-test1217machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 1.90 seconds)1218machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11219machine # [ 33.312244] nixos[1882]: switching to system configuration /nix/store/00ix772xir8b6sdxk16yapmwqyinwzak-nixos-system-machine-test1220machine # [ 33.315247] systemd[1]: test.service: Deactivated successfully.1221machine # [ 33.318562] systemd[1]: Stopped Test unit.1222machine # [ 33.319261] systemd[1]: Stopped target Local File Systems.1223machine # [ 33.320185] systemd[1]: Stopped target Remote File Systems.1224machine # [ 33.623364] systemd[1]: Reload requested from client PID 1882 ('.switch-to-conf') (unit backdoor.service)...1225machine # [ 33.625564] systemd[1]: Reloading...1226machine # [ 33.955749] systemd[1]: Reloading finished in 328 ms.1227machine # [ 34.046637] systemd[589]: Reexecution requested from client PID 1951 ('switch-to-confi')...1228machine # [ 34.049637] systemd[589]: Reexecuting.1229machine # [ 34.107742] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1230machine # [ 34.226583] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1231machine # [ 34.234320] systemd[589]: Reload requested from client PID 1951 ('switch-to-confi')...1232machine # [ 34.235669] systemd[589]: Reloading...1233machine # [ 34.391733] systemd[589]: Reloading finished in 154 ms.1234machine # [ 34.408190] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1235machine # [ 34.419260] systemd[589]: Stopped Run user-specific NixOS activation.1236machine # [ 34.421753] systemd[589]: Stopping Run user-specific NixOS activation...1237machine # [ 34.424110] systemd[589]: Starting Run user-specific NixOS activation...1238machine # [ 34.458497] systemd[589]: Finished Run user-specific NixOS activation.1239machine # [ 34.462870] systemd[1]: Stopped target Reactivate sysinit units.1240machine # [ 34.467017] systemd[1]: Stopping Reactivate sysinit units...1241machine # [ 34.469662] systemd[1]: Reached target Reactivate sysinit units.1242machine # [ 34.470598] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1243machine # [ 34.471959] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1244machine # [ 34.475549] systemd[1]: Reached target Local File Systems.1245machine # [ 34.482302] systemd[1]: Reached target Remote File Systems.1246machine # [ 34.485971] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1247machine # [ 34.490064] systemd[1]: Starting Create SUID/SGID Wrappers...1248machine # [ 34.490994] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1249machine # [ 34.500212] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671250machine # [ 34.502509] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1251machine # [ 34.505016] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1252machine # [ 34.506338] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1253machine # [ 34.670798] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1254machine # [ 34.675714] systemd[1]: Finished Create SUID/SGID Wrappers.1255machine # [ 34.679957] systemd[1]: Starting linger-users.service...1256machine # [ 34.682486] systemd[1]: Starting test.service...1257machine # [ 34.721124] systemd[1]: Finished test.service.1258machine # [ 34.740322] systemd[1]: linger-users.service: Deactivated successfully.1259machine # [ 34.742983] systemd[1]: Finished linger-users.service.1260machine # [ 34.999047] nixos[1882]: finished switching to system configuration /nix/store/00ix772xir8b6sdxk16yapmwqyinwzak-nixos-system-machine-test1261machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.93 seconds)1262machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&11263machine # [ 35.237062] nixos[2025]: switching to system configuration /nix/store/5sfwvj46bvawa98krfx8m6gpmwdhxczn-nixos-system-machine-test1264machine # [ 35.240043] systemd[1]: Stopped target Local File Systems.1265machine # [ 35.242515] systemd[1]: Stopped target Remote File Systems.1266machine # [ 35.530150] systemd[1]: Reload requested from client PID 2025 ('.switch-to-conf') (unit backdoor.service)...1267machine # [ 35.532295] systemd[1]: Reloading...1268machine # [ 35.847903] systemd[1]: Reloading finished in 314 ms.1269machine # [ 35.936558] systemd[589]: Reexecution requested from client PID 2094 ('switch-to-confi')...1270machine # [ 35.940785] systemd[589]: Reexecuting.1271machine # [ 36.003520] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1272machine # [ 36.117980] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1273machine # [ 36.124395] systemd[589]: Reload requested from client PID 2094 ('switch-to-confi')...1274machine # [ 36.127772] systemd[589]: Reloading...1275machine # [ 36.230508] systemd[589]: Reloading finished in 103 ms.1276machine # [ 36.248179] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1277machine # [ 36.258920] systemd[589]: Stopped Run user-specific NixOS activation.1278machine # [ 36.260547] systemd[589]: Stopping Run user-specific NixOS activation...1279machine # [ 36.262543] systemd[589]: Starting Run user-specific NixOS activation...1280machine # [ 36.291186] systemd[589]: Finished Run user-specific NixOS activation.1281machine # [ 36.295662] systemd[1]: Stopped target Reactivate sysinit units.1282machine # [ 36.300612] systemd[1]: Stopping Reactivate sysinit units...1283machine # [ 36.301520] systemd[1]: Reached target Reactivate sysinit units.1284machine # [ 36.302374] systemd[1]: test.service: Deactivated successfully.1285machine # [ 36.303195] systemd[1]: Stopped test.service.1286machine # [ 36.303854] systemd[1]: Stopping test.service...1287machine # [ 36.305710] systemd[1]: Starting test.service...1288machine # [ 36.330317] systemd[1]: Finished test.service.1289machine # [ 36.333187] systemd[1]: Reached target Local File Systems.1290machine # [ 36.336803] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1291machine # [ 36.340516] systemd[1]: Starting Create SUID/SGID Wrappers...1292machine # [ 36.341411] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1293machine # [ 36.342656] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671294machine # [ 36.352243] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1295machine # [ 36.353903] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1296machine # [ 36.355170] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1297machine # [ 36.368124] systemd[1]: Reached target Remote File Systems.1298machine # [ 36.369351] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1299machine # [ 36.372311] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1300machine # [ 36.524224] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1301machine # [ 36.528247] systemd[1]: Finished Create SUID/SGID Wrappers.1302machine # [ 36.531256] systemd[1]: Starting linger-users.service...1303machine # [ 36.572348] systemd[1]: linger-users.service: Deactivated successfully.1304machine # [ 36.575320] systemd[1]: Finished linger-users.service.1305machine # [ 36.829804] nixos[2025]: finished switching to system configuration /nix/store/5sfwvj46bvawa98krfx8m6gpmwdhxczn-nixos-system-machine-test1306machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.83 seconds)1307machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&11308machine # [ 37.064620] nixos[2167]: switching to system configuration /nix/store/girydjvgyzvib4csclzqj1agvrcd9abm-nixos-system-machine-test1309machine # [ 37.067715] systemd[1]: Stopped target Local File Systems.1310machine # [ 37.071013] systemd[1]: Stopped target Remote File Systems.1311machine # [ 37.361987] systemd[1]: Reload requested from client PID 2167 ('.switch-to-conf') (unit backdoor.service)...1312machine # [ 37.364388] systemd[1]: Reloading...1313machine # [ 37.695945] systemd[1]: Reloading finished in 330 ms.1314machine # [ 37.823050] systemd[589]: Reexecution requested from client PID 2236 ('switch-to-confi')...1315machine # [ 37.828140] systemd[589]: Reexecuting.1316machine # [ 37.879283] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1317machine # [ 37.989846] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1318machine # [ 37.996873] systemd[589]: Reload requested from client PID 2236 ('switch-to-confi')...1319machine # [ 37.999416] systemd[589]: Reloading...1320machine # [ 38.105325] systemd[589]: Reloading finished in 104 ms.1321machine # [ 38.120205] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1322machine # [ 38.131574] systemd[589]: Stopped Run user-specific NixOS activation.1323machine # [ 38.134385] systemd[589]: Stopping Run user-specific NixOS activation...1324machine # [ 38.136735] systemd[589]: Starting Run user-specific NixOS activation...1325machine # [ 38.172577] systemd[589]: Finished Run user-specific NixOS activation.1326machine # [ 38.176619] systemd[1]: Stopped target Reactivate sysinit units.1327machine # [ 38.180431] systemd[1]: Stopping Reactivate sysinit units...1328machine # [ 38.181376] systemd[1]: Reached target Reactivate sysinit units.1329machine # [ 38.184442] systemd[1]: Reloading test.service...1330machine # [ 38.210786] systemd[1]: Reloaded test.service.1331machine # [ 38.215395] systemd[1]: Reached target Remote File Systems.1332machine # [ 38.221699] systemd[1]: Starting linger-users.service...1333machine # [ 38.236668] systemd[1]: Reached target Local File Systems.1334machine # [ 38.237692] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1335machine # [ 38.246664] systemd[1]: Starting Create SUID/SGID Wrappers...1336machine # [ 38.247747] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1337machine # [ 38.253297] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671338machine # [ 38.255736] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1339machine # [ 38.273342] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1340machine # [ 38.274806] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1341machine # [ 38.277856] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1342machine # [ 38.282167] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1343machine # [ 38.328842] systemd[1]: linger-users.service: Deactivated successfully.1344machine # [ 38.333556] systemd[1]: Finished linger-users.service.1345machine # [ 38.470525] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1346machine # [ 38.473733] systemd[1]: Finished Create SUID/SGID Wrappers.1347machine # [ 38.729729] nixos[2167]: finished switching to system configuration /nix/store/girydjvgyzvib4csclzqj1agvrcd9abm-nixos-system-machine-test1348machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 1.90 seconds)1349machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&11350machine # [ 38.977831] nixos[2310]: switching to system configuration /nix/store/gbzii7acndhl9mz38gzyd7ly15azvhxm-nixos-system-machine-test1351machine # [ 38.980855] systemd[1]: Stopped target Remote File Systems.1352machine # [ 38.983857] systemd[1]: Stopped target Local File Systems.1353machine # [ 39.286185] systemd[1]: Reload requested from client PID 2310 ('.switch-to-conf') (unit backdoor.service)...1354machine # [ 39.288369] systemd[1]: Reloading...1355machine # [ 39.623861] systemd[1]: Reloading finished in 333 ms.1356machine # [ 39.712768] systemd[589]: Reexecution requested from client PID 2379 ('switch-to-confi')...1357machine # [ 39.717445] systemd[589]: Reexecuting.1358machine # [ 39.771641] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1359machine # [ 39.882316] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1360machine # [ 39.889204] systemd[589]: Reload requested from client PID 2379 ('switch-to-confi')...1361machine # [ 39.891651] systemd[589]: Reloading...1362machine # [ 39.997785] systemd[589]: Reloading finished in 105 ms.1363machine # [ 40.012184] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1364machine # [ 40.023870] systemd[589]: Stopped Run user-specific NixOS activation.1365machine # [ 40.026315] systemd[589]: Stopping Run user-specific NixOS activation...1366machine # [ 40.028342] systemd[589]: Starting Run user-specific NixOS activation...1367machine # [ 40.060057] systemd[589]: Finished Run user-specific NixOS activation.1368machine # [ 40.063971] systemd[1]: Stopped target Reactivate sysinit units.1369machine # [ 40.065387] systemd[1]: Stopping Reactivate sysinit units...1370machine # [ 40.066212] systemd[1]: Reached target Reactivate sysinit units.1371machine # [ 40.069528] systemd[1]: Reached target Local File Systems.1372machine # [ 40.072961] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1373machine # [ 40.078051] systemd[1]: Starting Create SUID/SGID Wrappers...1374machine # [ 40.079040] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1375machine # [ 40.085557] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671376machine # [ 40.087892] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1377machine # [ 40.100874] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1378machine # [ 40.102191] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1379machine # [ 40.103446] systemd[1]: Reached target Remote File Systems.1380machine # [ 40.105194] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1381machine # [ 40.106577] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1382machine # [ 40.264387] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1383machine # [ 40.268389] systemd[1]: Finished Create SUID/SGID Wrappers.1384machine # [ 40.272480] systemd[1]: Starting linger-users.service...1385machine # [ 40.314159] systemd[1]: linger-users.service: Deactivated successfully.1386machine # [ 40.316120] systemd[1]: Finished linger-users.service.1387machine # [ 40.572699] nixos[2310]: finished switching to system configuration /nix/store/gbzii7acndhl9mz38gzyd7ly15azvhxm-nixos-system-machine-test1388machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.84 seconds)1389machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&11390machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.29 seconds)1391machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/bin/switch-to-configuration test 2>&11392machine # [ 41.105296] nixos[2460]: switching to system configuration /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test1393machine # [ 41.108664] systemd[1]: Stopped target Local File Systems.1394machine # [ 41.112644] systemd[1]: Stopped target Remote File Systems.1395machine # [ 41.113617] systemd[1]: test.service: Deactivated successfully.1396machine # [ 41.114493] systemd[1]: Stopped test.service.1397machine # [ 41.402959] systemd[1]: Reload requested from client PID 2460 ('.switch-to-conf') (unit backdoor.service)...1398machine # [ 41.405184] systemd[1]: Reloading...1399machine # [ 41.725625] systemd[1]: Reloading finished in 317 ms.1400machine # [ 41.812429] systemd[589]: Reexecution requested from client PID 2530 ('switch-to-confi')...1401machine # [ 41.815346] systemd[589]: Reexecuting.1402machine # [ 41.871400] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1403machine # [ 41.986568] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1404machine # [ 41.993549] systemd[589]: Reload requested from client PID 2530 ('switch-to-confi')...1405machine # [ 41.996208] systemd[589]: Reloading...1406machine # [ 42.104370] systemd[589]: Reloading finished in 106 ms.1407machine # [ 42.120189] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1408machine # [ 42.132611] systemd[589]: Stopped Run user-specific NixOS activation.1409machine # [ 42.134966] systemd[589]: Stopping Run user-specific NixOS activation...1410machine # [ 42.137151] systemd[589]: Starting Run user-specific NixOS activation...1411machine # [ 42.168405] systemd[589]: Finished Run user-specific NixOS activation.1412machine # [ 42.172963] systemd[1]: Stopped target Reactivate sysinit units.1413machine # [ 42.175881] systemd[1]: Stopping Reactivate sysinit units...1414machine # [ 42.180401] systemd[1]: Reached target Reactivate sysinit units.1415machine # [ 42.181354] systemd[1]: Reached target Remote File Systems.1416machine # [ 42.183249] systemd[1]: Starting linger-users.service...1417machine # [ 42.190585] systemd[1]: Reached target Local File Systems.1418machine # [ 42.191579] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1419machine # [ 42.204550] systemd[1]: Starting Create SUID/SGID Wrappers...1420machine # [ 42.205499] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1421machine # [ 42.206795] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671422machine # [ 42.220504] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1423machine # [ 42.222339] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1424machine # [ 42.223876] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1425machine # [ 42.230346] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1426machine # [ 42.231804] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1427machine # [ 42.285210] systemd[1]: linger-users.service: Deactivated successfully.1428machine # [ 42.290121] systemd[1]: Finished linger-users.service.1429machine # [ 42.418819] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1430machine # [ 42.422497] systemd[1]: Finished Create SUID/SGID Wrappers.1431machine # [ 42.676574] nixos[2460]: finished switching to system configuration /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test1432machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.81 seconds)1433machine: must succeed: /nix/store/xp3sybn14gl1vvz5vkbb5n078slvh70j-separate-activation-script/bin/switch-to-configuration test 2>&11434machine # [ 42.902172] nixos[2601]: switching to system configuration /nix/store/kq1jm0c6n8icxdmdd4k873jwmd9q2551-nixos-system-machine-test1435machine # [ 42.904853] systemd[1]: Stopped target Local File Systems.1436machine # [ 42.907469] systemd[1]: Stopped target Remote File Systems.1437machine # [ 43.201813] systemd[1]: Reload requested from client PID 2601 ('.switch-to-conf') (unit backdoor.service)...1438machine # [ 43.204206] systemd[1]: Reloading...1439machine # [ 43.520159] systemd[1]: Reloading finished in 314 ms.1440machine # [ 43.615224] systemd[589]: Stopped Run user-specific NixOS activation.1441machine # [ 43.619215] systemd[589]: Reexecution requested from client PID 2670 ('switch-to-confi')...1442machine # [ 43.621826] systemd[589]: Reexecuting.1443machine # [ 43.680145] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1444machine # [ 43.795371] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1445machine # [ 43.803715] systemd[589]: Reload requested from client PID 2670 ('switch-to-confi')...1446machine # [ 43.807211] systemd[589]: Reloading...1447machine # [ 43.913880] systemd[589]: Reloading finished in 108 ms.1448machine # [ 43.928193] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1449machine # [ 43.941300] systemd[1]: Stopped target Reactivate sysinit units.1450machine # [ 43.942382] systemd[1]: Stopping Reactivate sysinit units...1451machine # [ 43.943251] systemd[1]: Reached target Reactivate sysinit units.1452machine # [ 43.945881] systemd[1]: Reached target Remote File Systems.1453machine # [ 43.953326] systemd[1]: Starting linger-users.service...1454machine # [ 43.959221] systemd[1]: Starting test.service...1455machine # [ 43.970725] systemd[1]: Reached target Local File Systems.1456machine # [ 43.976362] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1457machine # [ 43.983306] systemd[1]: Starting Create SUID/SGID Wrappers...1458machine # [ 43.992673] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1459machine # [ 43.994050] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671460machine # [ 44.011349] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1461machine # [ 44.019104] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1462machine # [ 44.025634] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1463machine # [ 44.027010] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1464machine # [ 44.040176] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1465machine # [ 44.041673] systemd[1]: Finished test.service.1466machine # [ 44.073376] systemd[1]: linger-users.service: Deactivated successfully.1467machine # [ 44.077785] systemd[1]: Finished linger-users.service.1468machine # [ 44.220454] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1469machine # [ 44.222327] systemd[1]: Finished Create SUID/SGID Wrappers.1470machine # [ 44.480758] nixos[2601]: finished switching to system configuration /nix/store/kq1jm0c6n8icxdmdd4k873jwmd9q2551-nixos-system-machine-test1471machine: (finished: must succeed: /nix/store/xp3sybn14gl1vvz5vkbb5n078slvh70j-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.80 seconds)1472machine: must succeed: ! test -e /run/current-system/activate1473machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.02 seconds)1474machine: must succeed: ! test -e /run/current-system/dry-activate1475machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.02 seconds)1476machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration1477machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.02 seconds)1478machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&11479machine # [ 44.769230] nixos[2750]: switching to system configuration /nix/store/r1lxp7q15z0067dj653xq9ag1bcwf1nq-nixos-system-machine-test1480machine # [ 44.772212] systemd[1]: Stopped target Local File Systems.1481machine # [ 44.774985] systemd[1]: test.service: Deactivated successfully.1482machine # [ 44.778010] systemd[1]: Stopped test.service.1483machine # [ 44.778810] systemd[1]: Stopped target Remote File Systems.1484machine # [ 45.084807] systemd[1]: Reload requested from client PID 2750 ('.switch-to-conf') (unit backdoor.service)...1485machine # [ 45.086477] systemd[1]: Reloading...1486machine # [ 45.421885] systemd[1]: Reloading finished in 333 ms.1487machine # [ 45.510113] systemd[589]: Reexecution requested from client PID 2819 ('switch-to-confi')...1488machine # [ 45.514181] systemd[589]: Reexecuting.1489machine # [ 45.568131] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1490machine # [ 45.685136] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1491machine # [ 45.691936] systemd[589]: Reload requested from client PID 2819 ('switch-to-confi')...1492machine # [ 45.694632] systemd[589]: Reloading...1493machine # [ 45.805752] systemd[589]: Reloading finished in 110 ms.1494machine # [ 45.821768] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1495machine # [ 45.832886] systemd[589]: Starting Run user-specific NixOS activation...1496machine # [ 45.869006] systemd[589]: Finished Run user-specific NixOS activation.1497machine # [ 45.873244] systemd[589]: Stopped Run user-specific NixOS activation.1498machine # [ 45.874349] systemd[589]: Stopping Run user-specific NixOS activation...1499machine # [ 45.877061] systemd[589]: Starting Run user-specific NixOS activation...1500machine # [ 45.886700] systemd[1]: Stopped target Reactivate sysinit units.1501machine # [ 45.888931] systemd[1]: Stopping Reactivate sysinit units...1502machine # [ 45.889885] systemd[1]: Reached target Reactivate sysinit units.1503machine # [ 45.898446] systemd[1]: Reached target Local File Systems.1504machine # [ 45.906980] systemd[1]: Reached target Remote File Systems.1505machine # [ 45.915580] systemd[1]: Starting linger-users.service...1506machine # [ 45.933046] systemd[1]: Started test.service.1507machine # [ 45.950362] systemd[589]: Finished Run user-specific NixOS activation.1508machine # [ 45.962356] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1509machine # [ 45.976546] systemd[1]: Starting Create SUID/SGID Wrappers...1510machine # [ 45.977536] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1511machine # [ 45.978795] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671512machine # [ 45.994325] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1513machine # [ 46.004324] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1514machine # [ 46.005855] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1515machine # [ 46.012353] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1516machine # [ 46.013817] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1517machine # [ 46.015138] systemd[1]: test.service: Deactivated successfully.1518machine # [ 46.048684] systemd[1]: linger-users.service: Deactivated successfully.1519machine # [ 46.052873] systemd[1]: Finished linger-users.service.1520machine # [ 46.196496] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1521machine # [ 46.198454] systemd[1]: Finished Create SUID/SGID Wrappers.1522machine # [ 46.455309] nixos[2750]: finished switching to system configuration /nix/store/r1lxp7q15z0067dj653xq9ag1bcwf1nq-nixos-system-machine-test1523machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.91 seconds)1524machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&11525machine # [ 46.685258] nixos[2895]: switching to system configuration /nix/store/s2c811nl45jfn9g81ngw2gkc4fc7q0iq-nixos-system-machine-test1526machine # [ 46.688584] systemd[1]: Stopped target Local File Systems.1527machine # [ 46.691559] systemd[1]: Stopped target Remote File Systems.1528machine # [ 47.010336] systemd[1]: Reload requested from client PID 2895 ('.switch-to-conf') (unit backdoor.service)...1529machine # [ 47.012583] systemd[1]: Reloading...1530machine # [ 47.341021] systemd[1]: Reloading finished in 326 ms.1531machine # [ 47.430552] systemd[589]: Reexecution requested from client PID 2964 ('switch-to-confi')...1532machine # [ 47.433615] systemd[589]: Reexecuting.1533machine # [ 47.488835] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1534machine # [ 47.607873] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1535machine # [ 47.615976] systemd[589]: Reload requested from client PID 2964 ('switch-to-confi')...1536machine # [ 47.617635] systemd[589]: Reloading...1537machine # [ 47.744333] systemd[589]: Reloading finished in 124 ms.1538machine # [ 47.760384] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1539machine # [ 47.770708] systemd[589]: Stopped Run user-specific NixOS activation.1540machine # [ 47.773631] systemd[589]: Stopping Run user-specific NixOS activation...1541machine # [ 47.776079] systemd[589]: Starting Run user-specific NixOS activation...1542machine # [ 47.809687] systemd[589]: Finished Run user-specific NixOS activation.1543machine # [ 47.814578] systemd[1]: Stopped target Reactivate sysinit units.1544machine # [ 47.816899] systemd[1]: Stopping Reactivate sysinit units...1545machine # [ 47.817875] systemd[1]: Reached target Reactivate sysinit units.1546machine # [ 47.822885] systemd[1]: Reached target Local File Systems.1547machine # [ 47.826912] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1548machine # [ 47.831003] systemd[1]: Starting Create SUID/SGID Wrappers...1549machine # [ 47.832001] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1550machine # [ 47.837511] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671551machine # [ 47.839827] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1552machine # [ 47.853636] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1553machine # [ 47.855072] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1554machine # [ 47.856501] systemd[1]: Reached target Remote File Systems.1555machine # [ 47.857337] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1556machine # [ 47.858675] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1557machine # [ 48.039039] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1558machine # [ 48.044805] systemd[1]: Finished Create SUID/SGID Wrappers.1559machine # [ 48.048349] systemd[1]: Starting escaped\x2ddash.service...1560machine # [ 48.051907] systemd[1]: Starting linger-users.service...1561machine # [ 48.094458] systemd[1]: Finished escaped\x2ddash.service.1562machine # [ 48.117429] systemd[1]: linger-users.service: Deactivated successfully.1563machine # [ 48.120136] systemd[1]: Finished linger-users.service.1564machine # [ 48.377358] nixos[2895]: finished switching to system configuration /nix/store/s2c811nl45jfn9g81ngw2gkc4fc7q0iq-nixos-system-machine-test1565machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 1.92 seconds)1566machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&11567machine # [ 48.679957] nixos[3037]: switching to system configuration /nix/store/9v9fafbmf5kb62d4k3vbl0vq7s5m018k-nixos-system-machine-test1568machine # [ 48.682800] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1569machine # [ 48.685418] systemd[1]: Stopped escaped\x2ddash.service.1570machine # [ 48.687101] systemd[1]: Stopped target Local File Systems.1571machine # [ 48.689488] systemd[1]: Stopped target Remote File Systems.1572machine # [ 48.999654] systemd[1]: Reload requested from client PID 3037 ('.switch-to-conf') (unit backdoor.service)...1573machine # [ 49.001949] systemd[1]: Reloading...1574machine # [ 49.586167] systemd[1]: Reloading finished in 582 ms.1575machine # [ 49.684482] systemd[589]: Reexecution requested from client PID 3106 ('switch-to-confi')...1576machine # [ 49.687533] systemd[589]: Reexecuting.1577machine # [ 49.743651] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1578machine # [ 49.858739] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1579machine # [ 49.866101] systemd[589]: Reload requested from client PID 3106 ('switch-to-confi')...1580machine # [ 49.868750] systemd[589]: Reloading...1581machine # [ 49.979222] systemd[589]: Reloading finished in 109 ms.1582machine # [ 49.996395] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1583machine # [ 50.008939] systemd[589]: Stopped Run user-specific NixOS activation.1584machine # [ 50.011793] systemd[589]: Stopping Run user-specific NixOS activation...1585machine # [ 50.014462] systemd[589]: Starting Run user-specific NixOS activation...1586machine # [ 50.051602] systemd[589]: Finished Run user-specific NixOS activation.1587machine # [ 50.057548] systemd[1]: Stopped target Reactivate sysinit units.1588machine # [ 50.060974] systemd[1]: Stopping Reactivate sysinit units...1589machine # [ 50.061954] systemd[1]: Reached target Reactivate sysinit units.1590machine # [ 50.066685] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1591machine # [ 50.070159] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1592machine # [ 50.071622] systemd[1]: Reached target Remote File Systems.1593machine # [ 50.078031] systemd[1]: Reached target Local File Systems.1594machine # [ 50.079014] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1595machine # [ 50.093098] systemd[1]: Starting Create SUID/SGID Wrappers...1596machine # [ 50.094111] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1597machine # [ 50.095411] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671598machine # [ 50.102870] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1599machine # [ 50.104804] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1600machine # [ 50.106203] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1601machine # [ 50.302179] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1602machine # [ 50.304371] systemd[1]: Finished Create SUID/SGID Wrappers.1603machine # [ 50.310546] systemd[1]: Starting escaped\x2ddash.service...1604machine # [ 50.315947] systemd[1]: Starting linger-users.service...1605machine # [ 50.362330] systemd[1]: Finished escaped\x2ddash.service.1606machine # [ 50.382907] systemd[1]: linger-users.service: Deactivated successfully.1607machine # [ 50.385313] systemd[1]: Finished linger-users.service.1608machine # [ 50.642433] nixos[3037]: finished switching to system configuration /nix/store/9v9fafbmf5kb62d4k3vbl0vq7s5m018k-nixos-system-machine-test1609machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 2.27 seconds)1610machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&11611machine # [ 50.934481] nixos[3179]: switching to system configuration /nix/store/5ablawqmyfdjjb2clwnv8xwv2a5si6i0-nixos-system-machine-test1612machine # [ 50.937307] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1613machine # [ 50.941912] systemd[1]: Stopped escaped\x2ddash.service.1614machine # [ 50.942820] systemd[1]: Stopped target Remote File Systems.1615machine # [ 50.943641] systemd[1]: Stopped target Local File Systems.1616machine # [ 51.246328] systemd[1]: Reload requested from client PID 3179 ('.switch-to-conf') (unit backdoor.service)...1617machine # [ 51.248484] systemd[1]: Reloading...1618machine # [ 51.572777] systemd[1]: Reloading finished in 322 ms.1619machine # [ 51.664466] systemd[589]: Reexecution requested from client PID 3248 ('switch-to-confi')...1620machine # [ 51.665978] systemd[589]: Reexecuting.1621machine # [ 51.723625] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1622machine # [ 51.837066] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1623machine # [ 51.844247] systemd[589]: Reload requested from client PID 3248 ('switch-to-confi')...1624machine # [ 51.848217] systemd[589]: Reloading...1625machine # [ 51.958673] systemd[589]: Reloading finished in 111 ms.1626machine # [ 51.976210] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1627machine # [ 51.988480] systemd[589]: Stopped Run user-specific NixOS activation.1628machine # [ 51.991072] systemd[589]: Stopping Run user-specific NixOS activation...1629machine # [ 51.993637] systemd[589]: Starting Run user-specific NixOS activation...1630machine # [ 52.030574] systemd[589]: Finished Run user-specific NixOS activation.1631machine # [ 52.034983] systemd[1]: Stopped target Reactivate sysinit units.1632machine # [ 52.038096] systemd[1]: Stopping Reactivate sysinit units...1633machine # [ 52.039020] systemd[1]: Reached target Reactivate sysinit units.1634machine # [ 52.042806] systemd[1]: Reached target Local File Systems.1635machine # [ 52.046246] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1636machine # [ 52.052240] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1637machine # [ 52.053727] systemd[1]: Reached target Remote File Systems.1638machine # [ 52.056188] systemd[1]: Starting -.service...1639machine # [ 52.061394] systemd[1]: Starting linger-users.service...1640machine # [ 52.082330] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1641machine # [ 52.087850] systemd[1]: Starting Create SUID/SGID Wrappers...1642machine # [ 52.092293] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1643machine # [ 52.093736] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671644machine # [ 52.095999] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1645machine # [ 52.105983] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1646machine # [ 52.107371] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1647machine # [ 52.136906] systemd[1]: Finished -.service.1648machine # [ 52.177875] systemd[1]: linger-users.service: Deactivated successfully.1649machine # [ 52.181503] systemd[1]: Finished linger-users.service.1650machine # [ 52.317850] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1651machine # [ 52.319787] systemd[1]: Finished Create SUID/SGID Wrappers.1652machine # [ 52.577473] nixos[3179]: finished switching to system configuration /nix/store/5ablawqmyfdjjb2clwnv8xwv2a5si6i0-nixos-system-machine-test1653machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.93 seconds)1654machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&11655machine # [ 52.862221] nixos[3321]: switching to system configuration /nix/store/3zfy9rb9w9y6rk2izcya11532w12sl6w-nixos-system-machine-test1656machine # [ 52.864973] systemd[1]: Stopped target Remote File Systems.1657machine # [ 52.867557] systemd[1]: Stopped target Local File Systems.1658machine # [ 53.190117] systemd[1]: Reload requested from client PID 3321 ('.switch-to-conf') (unit backdoor.service)...1659machine # [ 53.192327] systemd[1]: Reloading...1660machine # [ 53.555878] systemd[1]: Reloading finished in 361 ms.1661machine # [ 53.648446] systemd[589]: Reexecution requested from client PID 3390 ('switch-to-confi')...1662machine # [ 53.652516] systemd[589]: Reexecuting.1663machine # [ 53.711824] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1664machine # [ 53.830355] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1665machine # [ 53.838059] systemd[589]: Reload requested from client PID 3390 ('switch-to-confi')...1666machine # [ 53.839498] systemd[589]: Reloading...1667machine # [ 53.950982] systemd[589]: Reloading finished in 109 ms.1668machine # [ 53.968191] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1669machine # [ 53.978062] systemd[589]: Stopped Run user-specific NixOS activation.1670machine # [ 53.980818] systemd[589]: Stopping Run user-specific NixOS activation...1671machine # [ 53.983115] systemd[589]: Starting Run user-specific NixOS activation...1672machine # [ 54.017968] systemd[589]: Finished Run user-specific NixOS activation.1673machine # [ 54.022922] systemd[1]: Stopped target Reactivate sysinit units.1674machine # [ 54.025022] systemd[1]: Stopping Reactivate sysinit units...1675machine # [ 54.025971] systemd[1]: Reached target Reactivate sysinit units.1676machine # [ 54.031933] systemd[1]: Reloading -.service...1677machine # [ 54.059342] systemd[1]: Reloaded -.service.1678machine # [ 54.063583] systemd[1]: Reached target Local File Systems.1679machine # [ 54.069069] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1680machine # [ 54.072111] systemd[1]: Starting Create SUID/SGID Wrappers...1681machine # [ 54.076951] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1682machine # [ 54.078343] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671683machine # [ 54.092986] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1684machine # [ 54.094736] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1685machine # [ 54.098979] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1686machine # [ 54.100523] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1687machine # [ 54.101853] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1688machine # [ 54.103247] systemd[1]: Reached target Remote File Systems.1689machine # [ 54.281628] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1690machine # [ 54.285440] systemd[1]: Finished Create SUID/SGID Wrappers.1691machine # [ 54.290371] systemd[1]: Starting linger-users.service...1692machine # [ 54.336406] systemd[1]: linger-users.service: Deactivated successfully.1693machine # [ 54.339402] systemd[1]: Finished linger-users.service.1694machine # [ 54.595401] nixos[3321]: finished switching to system configuration /nix/store/3zfy9rb9w9y6rk2izcya11532w12sl6w-nixos-system-machine-test1695machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 2.02 seconds)1696machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&11697machine # [ 54.823530] nixos[3463]: switching to system configuration /nix/store/hrm6i1r7yvkn88mxdz3wnxq55czi1ji7-nixos-system-machine-test1698machine # [ 54.826809] systemd[1]: -.service: Deactivated successfully.1699machine # [ 54.830817] systemd[1]: Stopped -.service.1700machine # [ 54.832356] systemd[1]: Stopped target Local File Systems.1701machine # [ 54.833256] systemd[1]: Stopped target Remote File Systems.1702machine # [ 55.139189] systemd[1]: Reload requested from client PID 3463 ('.switch-to-conf') (unit backdoor.service)...1703machine # [ 55.141753] systemd[1]: Reloading...1704machine # [ 55.470236] systemd[1]: Reloading finished in 327 ms.1705machine # [ 55.558401] systemd[589]: Reexecution requested from client PID 3532 ('switch-to-confi')...1706machine # [ 55.563152] systemd[589]: Reexecuting.1707machine # [ 55.619902] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1708machine # [ 55.733947] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1709machine # [ 55.740739] systemd[589]: Reload requested from client PID 3532 ('switch-to-confi')...1710machine # [ 55.744136] systemd[589]: Reloading...1711machine # [ 55.850046] systemd[589]: Reloading finished in 106 ms.1712machine # [ 55.864177] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1713machine # [ 55.874726] systemd[589]: Stopped Run user-specific NixOS activation.1714machine # [ 55.877332] systemd[589]: Stopping Run user-specific NixOS activation...1715machine # [ 55.880886] systemd[589]: Starting Run user-specific NixOS activation...1716machine # [ 55.911817] systemd[589]: Finished Run user-specific NixOS activation.1717machine # [ 55.916516] systemd[1]: Stopped target Reactivate sysinit units.1718machine # [ 55.920506] systemd[1]: Stopping Reactivate sysinit units...1719machine # [ 55.921432] systemd[1]: Reached target Reactivate sysinit units.1720machine # [ 55.922301] systemd[1]: Reached target Remote File Systems.1721machine # [ 55.926175] systemd[1]: Reached target Local File Systems.1722machine # [ 55.927070] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1723machine # [ 55.936425] systemd[1]: Starting Create SUID/SGID Wrappers...1724machine # [ 55.937336] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1725machine # [ 55.938592] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671726machine # [ 55.947348] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1727machine # [ 55.954471] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1728machine # [ 55.956086] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1729machine # [ 55.959852] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1730machine # [ 55.964064] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1731machine # [ 56.115556] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1732machine # [ 56.118886] systemd[1]: Finished Create SUID/SGID Wrappers.1733machine # [ 56.124300] systemd[1]: Starting linger-users.service...1734machine # [ 56.128759] systemd[1]: Starting required-service.service...1735machine # [ 56.140136] systemd[1]: Starting test-service.service...1736machine # [ 56.185795] systemd[1]: Finished required-service.service.1737machine # [ 56.191501] systemd[1]: Finished test-service.service.1738machine # [ 56.211504] systemd[1]: linger-users.service: Deactivated successfully.1739machine # [ 56.215090] systemd[1]: Finished linger-users.service.1740machine # [ 56.470236] nixos[3463]: finished switching to system configuration /nix/store/hrm6i1r7yvkn88mxdz3wnxq55czi1ji7-nixos-system-machine-test1741machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.87 seconds)1742machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&11743machine # [ 56.707382] nixos[3607]: switching to system configuration /nix/store/4d21hblrh7vnzb356nz2ab6jpjmm092k-nixos-system-machine-test1744machine # [ 56.710292] systemd[1]: Stopped target Remote File Systems.1745machine # [ 56.714961] systemd[1]: Stopped target Local File Systems.1746machine # [ 56.716304] systemd[1]: required-service.service: Deactivated successfully.1747machine # [ 56.718436] systemd[1]: Stopped required-service.service.1748machine # [ 56.719268] systemd[1]: test-service.service: Deactivated successfully.1749machine # [ 56.722421] systemd[1]: Stopped test-service.service.1750machine # [ 57.020412] systemd[1]: Reload requested from client PID 3607 ('.switch-to-conf') (unit backdoor.service)...1751machine # [ 57.022423] systemd[1]: Reloading...1752machine # [ 57.358689] systemd[1]: Reloading finished in 334 ms.1753machine # [ 57.455897] systemd[589]: Reexecution requested from client PID 3676 ('switch-to-confi')...1754machine # [ 57.458622] systemd[589]: Reexecuting.1755machine # [ 57.524200] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1756machine # [ 57.641366] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1757machine # [ 57.648113] systemd[589]: Reload requested from client PID 3676 ('switch-to-confi')...1758machine # [ 57.650313] systemd[589]: Reloading...1759machine # [ 57.757283] systemd[589]: Reloading finished in 105 ms.1760machine # [ 57.772206] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1761machine # [ 57.782306] systemd[589]: Stopped Run user-specific NixOS activation.1762machine # [ 57.784838] systemd[589]: Stopping Run user-specific NixOS activation...1763machine # [ 57.787074] systemd[589]: Starting Run user-specific NixOS activation...1764machine # [ 57.820421] systemd[589]: Finished Run user-specific NixOS activation.1765machine # [ 57.824711] systemd[1]: Stopped target Reactivate sysinit units.1766machine # [ 57.826685] systemd[1]: Stopping Reactivate sysinit units...1767machine # [ 57.827611] systemd[1]: Reached target Reactivate sysinit units.1768machine # [ 57.833253] systemd[1]: Reached target Remote File Systems.1769machine # [ 57.836856] systemd[1]: Reached target Local File Systems.1770machine # [ 57.840126] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1771machine # [ 57.844516] systemd[1]: Starting Create SUID/SGID Wrappers...1772machine # [ 57.845415] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1773machine # [ 57.846719] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671774machine # [ 57.860984] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1775machine # [ 57.862692] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1776machine # [ 57.863999] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1777machine # [ 57.869629] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1778machine # [ 57.870966] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1779machine # [ 58.024820] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1780machine # [ 58.029978] systemd[1]: Finished Create SUID/SGID Wrappers.1781machine # [ 58.032339] systemd[1]: Starting linger-users.service...1782machine # [ 58.038333] systemd[1]: Starting required-service.service...1783machine # [ 58.048145] systemd[1]: Starting test-service.service...1784machine # [ 58.095037] systemd[1]: Finished test-service.service.1785machine # [ 58.101179] systemd[1]: Finished required-service.service.1786machine # [ 58.120631] systemd[1]: linger-users.service: Deactivated successfully.1787machine # [ 58.124243] systemd[1]: Finished linger-users.service.1788machine # [ 58.380718] nixos[3607]: finished switching to system configuration /nix/store/4d21hblrh7vnzb356nz2ab6jpjmm092k-nixos-system-machine-test1789machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.91 seconds)1790machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&11791machine # [ 58.611737] nixos[3751]: switching to system configuration /nix/store/dnkn3mks6yi57vi1zi2r4aiv49ks2xsj-nixos-system-machine-test1792machine # [ 58.614631] systemd[1]: Stopped target Local File Systems.1793machine # [ 58.619367] systemd[1]: required-service.service: Deactivated successfully.1794machine # [ 58.622173] systemd[1]: Stopped required-service.service.1795machine # [ 58.623017] systemd[1]: test-service.service: Deactivated successfully.1796machine # [ 58.623950] systemd[1]: Stopped test-service.service.1797machine # [ 58.625646] systemd[1]: Stopped target Remote File Systems.1798machine # [ 58.925945] systemd[1]: Reload requested from client PID 3751 ('.switch-to-conf') (unit backdoor.service)...1799machine # [ 58.927978] systemd[1]: Reloading...1800machine # [ 59.307930] systemd[1]: Reloading finished in 377 ms.1801machine # [ 59.392550] systemd[589]: Reexecution requested from client PID 3820 ('switch-to-confi')...1802machine # [ 59.395759] systemd[589]: Reexecuting.1803machine # [ 59.452171] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1804machine # [ 59.565037] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1805machine # [ 59.571913] systemd[589]: Reload requested from client PID 3820 ('switch-to-confi')...1806machine # [ 59.575595] systemd[589]: Reloading...1807machine # [ 59.682330] systemd[589]: Reloading finished in 108 ms.1808machine # [ 59.700255] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1809machine # [ 59.710212] systemd[589]: Stopped Run user-specific NixOS activation.1810machine # [ 59.713058] systemd[589]: Stopping Run user-specific NixOS activation...1811machine # [ 59.715380] systemd[589]: Starting Run user-specific NixOS activation...1812machine # [ 59.753399] systemd[589]: Finished Run user-specific NixOS activation.1813machine # [ 59.760219] systemd[1]: Stopped target Reactivate sysinit units.1814machine # [ 59.761667] systemd[1]: Stopping Reactivate sysinit units...1815machine # [ 59.762551] systemd[1]: Reached target Reactivate sysinit units.1816machine # [ 59.770072] systemd[1]: Starting required-service.service...1817machine # [ 59.780707] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1818machine # [ 59.782212] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1819machine # [ 59.788904] systemd[1]: Reached target Local File Systems.1820machine # [ 59.789886] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1821machine # [ 59.795333] systemd[1]: Starting Create SUID/SGID Wrappers...1822machine # [ 59.803578] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1823machine # [ 59.811178] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671824machine # [ 59.819286] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1825machine # [ 59.824549] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1826machine # [ 59.825946] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1827machine # [ 59.827170] systemd[1]: Reached target Remote File Systems.1828machine # [ 59.836231] systemd[1]: Finished required-service.service.1829machine # [ 59.991437] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1830machine # [ 59.994672] systemd[1]: Finished Create SUID/SGID Wrappers.1831machine # [ 59.998705] systemd[1]: Starting linger-users.service...1832machine # [ 60.004481] systemd[1]: Starting test-service.service...1833machine # [ 60.040647] systemd[1]: Finished test-service.service.1834machine # [ 60.060453] systemd[1]: linger-users.service: Deactivated successfully.1835machine # [ 60.062941] systemd[1]: Finished linger-users.service.1836machine # [ 60.318821] nixos[3751]: finished switching to system configuration /nix/store/dnkn3mks6yi57vi1zi2r4aiv49ks2xsj-nixos-system-machine-test1837machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.94 seconds)1838machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&11839machine # [ 60.550019] nixos[3895]: switching to system configuration /nix/store/vkzimcxcgzzcs375hgh1dqhmhjjq279w-nixos-system-machine-test1840machine # [ 60.552919] systemd[1]: test-service.service: Deactivated successfully.1841machine # [ 60.556467] systemd[1]: Stopped test-service.service.1842machine # [ 60.557300] systemd[1]: Stopped target Local File Systems.1843machine # [ 60.558088] systemd[1]: Stopped target Remote File Systems.1844machine # [ 60.559696] systemd[1]: required-service.service: Deactivated successfully.1845machine # [ 60.562387] systemd[1]: Stopped required-service.service.1846machine # [ 60.862186] systemd[1]: Reload requested from client PID 3895 ('.switch-to-conf') (unit backdoor.service)...1847machine # [ 60.864305] systemd[1]: Reloading...1848machine # [ 61.556052] systemd[1]: Reloading finished in 689 ms.1849machine # [ 61.644845] systemd[589]: Reexecution requested from client PID 3963 ('switch-to-confi')...1850machine # [ 61.649189] systemd[589]: Reexecuting.1851machine # [ 61.694963] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1852machine # [ 61.805023] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1853machine # [ 61.812183] systemd[589]: Reload requested from client PID 3963 ('switch-to-confi')...1854machine # [ 61.814459] systemd[589]: Reloading...1855machine # [ 61.917724] systemd[589]: Reloading finished in 102 ms.1856machine # [ 61.932188] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1857machine # [ 61.943653] systemd[589]: Stopped Run user-specific NixOS activation.1858machine # [ 61.946131] systemd[589]: Stopping Run user-specific NixOS activation...1859machine # [ 61.948564] systemd[589]: Starting Run user-specific NixOS activation...1860machine # [ 61.980184] systemd[589]: Finished Run user-specific NixOS activation.1861machine # [ 61.984101] systemd[1]: Stopped target Reactivate sysinit units.1862machine # [ 61.986091] systemd[1]: Stopping Reactivate sysinit units...1863machine # [ 61.986962] systemd[1]: Reached target Reactivate sysinit units.1864machine # [ 61.989949] systemd[1]: Reached target Remote File Systems.1865machine # [ 61.993980] systemd[1]: Created slice Slice /system/instantiated.1866machine # [ 61.999734] systemd[1]: Starting instantiated@one.service...1867machine # [ 62.003326] systemd[1]: Starting instantiated@two.service...1868machine # [ 62.008846] systemd[1]: Starting linger-users.service...1869machine # [ 62.027245] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1870machine # [ 62.040254] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1871machine # [ 62.041732] systemd[1]: Reached target Local File Systems.1872machine # [ 62.042757] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1873machine # [ 62.070508] systemd[1]: Starting Create SUID/SGID Wrappers...1874machine # [ 62.071636] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1875machine # [ 62.080878] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671876machine # [ 62.083230] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1877machine # [ 62.103454] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1878machine # [ 62.108946] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1879machine # [ 62.113549] systemd[1]: Finished instantiated@two.service.1880machine # [ 62.114465] systemd[1]: Finished instantiated@one.service.1881machine # [ 62.144897] systemd[1]: linger-users.service: Deactivated successfully.1882machine # [ 62.149591] systemd[1]: Finished linger-users.service.1883machine # [ 62.283308] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1884machine # [ 62.286577] systemd[1]: Finished Create SUID/SGID Wrappers.1885machine # [ 62.543027] nixos[3895]: finished switching to system configuration /nix/store/vkzimcxcgzzcs375hgh1dqhmhjjq279w-nixos-system-machine-test1886machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 2.22 seconds)1887machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&11888machine # [ 62.776302] nixos[4039]: switching to system configuration /nix/store/3fs1414m86460p9wdls39cqbrky55pg9-nixos-system-machine-test1889machine # [ 62.779199] systemd[1]: Stopped target Local File Systems.1890machine # [ 62.782536] systemd[1]: instantiated@two.service: Deactivated successfully.1891machine # [ 62.783628] systemd[1]: Stopped instantiated@two.service.1892machine # [ 62.786474] systemd[1]: Stopped target Remote File Systems.1893machine # [ 62.787362] systemd[1]: instantiated@one.service: Deactivated successfully.1894machine # [ 62.788556] systemd[1]: Stopped instantiated@one.service.1895machine # [ 63.091948] systemd[1]: Reload requested from client PID 4039 ('.switch-to-conf') (unit backdoor.service)...1896machine # [ 63.094126] systemd[1]: Reloading...1897machine # [ 63.431637] systemd[1]: Reloading finished in 336 ms.1898machine # [ 63.524077] systemd[589]: Reexecution requested from client PID 4108 ('switch-to-confi')...1899machine # [ 63.528794] systemd[589]: Reexecuting.1900machine # [ 63.583446] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1901machine # [ 63.696145] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1902machine # [ 63.702694] systemd[589]: Reload requested from client PID 4108 ('switch-to-confi')...1903machine # [ 63.705331] systemd[589]: Reloading...1904machine # [ 63.812059] systemd[589]: Reloading finished in 105 ms.1905machine # [ 63.828186] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1906machine # [ 63.838334] systemd[589]: Stopped Run user-specific NixOS activation.1907machine # [ 63.840797] systemd[589]: Stopping Run user-specific NixOS activation...1908machine # [ 63.842926] systemd[589]: Starting Run user-specific NixOS activation...1909machine # [ 63.876323] systemd[589]: Finished Run user-specific NixOS activation.1910machine # [ 63.880710] systemd[1]: Stopped target Reactivate sysinit units.1911machine # [ 63.883749] systemd[1]: Stopping Reactivate sysinit units...1912machine # [ 63.885904] systemd[1]: Reached target Reactivate sysinit units.1913machine # [ 63.890816] systemd[1]: Starting instantiated@two.service...1914machine # [ 63.900949] systemd[1]: Reached target Remote File Systems.1915machine # [ 63.904668] systemd[1]: Starting instantiated@one.service...1916machine # [ 63.907148] systemd[1]: Starting linger-users.service...1917machine # [ 63.921154] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1918machine # [ 63.922679] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1919machine # [ 63.940820] systemd[1]: Reached target Local File Systems.1920machine # [ 63.941741] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1921machine # [ 63.943256] systemd[1]: Starting Create SUID/SGID Wrappers...1922machine # [ 63.960335] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1923machine # [ 63.961634] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671924machine # [ 63.981663] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1925machine # [ 63.991811] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1926machine # [ 64.003881] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1927machine # [ 64.008879] systemd[1]: Finished instantiated@two.service.1928machine # [ 64.009749] systemd[1]: Finished instantiated@one.service.1929machine # [ 64.041255] systemd[1]: linger-users.service: Deactivated successfully.1930machine # [ 64.044694] systemd[1]: Finished linger-users.service.1931machine # [ 64.181144] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1932machine # [ 64.184330] systemd[1]: Finished Create SUID/SGID Wrappers.1933machine # [ 64.441407] nixos[4039]: finished switching to system configuration /nix/store/3fs1414m86460p9wdls39cqbrky55pg9-nixos-system-machine-test1934machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.90 seconds)1935(finished: subtest: services, in 40.77 seconds)1936subtest: failing units1937machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11938machine # [ 64.668268] nixos[4183]: switching to system configuration /nix/store/00ix772xir8b6sdxk16yapmwqyinwzak-nixos-system-machine-test1939machine # [ 64.670964] systemd[1]: Stopped target Remote File Systems.1940machine # [ 64.674461] systemd[1]: Stopped target Local File Systems.1941machine # [ 64.675383] systemd[1]: instantiated@one.service: Deactivated successfully.1942machine # [ 64.677674] systemd[1]: Stopped instantiated@one.service.1943machine # [ 64.678537] systemd[1]: instantiated@two.service: Deactivated successfully.1944machine # [ 64.679544] systemd[1]: Stopped instantiated@two.service.1945machine # [ 64.964313] systemd[1]: Reload requested from client PID 4183 ('.switch-to-conf') (unit backdoor.service)...1946machine # [ 64.966292] systemd[1]: Reloading...1947machine # [ 65.475088] systemd[1]: Reloading finished in 507 ms.1948machine # [ 65.562673] systemd[589]: Reexecution requested from client PID 4252 ('switch-to-confi')...1949machine # [ 65.566936] systemd[589]: Reexecuting.1950machine # [ 65.627805] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1951machine # [ 65.744487] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1952machine # [ 65.752120] systemd[589]: Reload requested from client PID 4252 ('switch-to-confi')...1953machine # [ 65.753574] systemd[589]: Reloading...1954machine # [ 65.861960] systemd[589]: Reloading finished in 106 ms.1955machine # [ 65.876192] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1956machine # [ 65.886570] systemd[589]: Stopped Run user-specific NixOS activation.1957machine # [ 65.889097] systemd[589]: Stopping Run user-specific NixOS activation...1958machine # [ 65.891330] systemd[589]: Starting Run user-specific NixOS activation...1959machine # [ 65.923885] systemd[589]: Finished Run user-specific NixOS activation.1960machine # [ 65.927893] systemd[1]: Stopped target Reactivate sysinit units.1961machine # [ 65.930737] systemd[1]: Stopping Reactivate sysinit units...1962machine # [ 65.931685] systemd[1]: Reached target Reactivate sysinit units.1963machine # [ 65.935014] systemd[1]: Reached target Remote File Systems.1964machine # [ 65.939167] systemd[1]: Reached target Local File Systems.1965machine # [ 65.944275] systemd[1]: Starting linger-users.service...1966machine # [ 65.948364] systemd[1]: Starting test.service...1967machine # [ 65.964631] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1968machine # [ 65.966289] systemd[1]: Starting Create SUID/SGID Wrappers...1969machine # [ 65.967113] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1970machine # [ 65.980900] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671971machine # [ 65.983282] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1972machine # [ 65.999341] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1973machine # [ 66.008167] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1974machine # [ 66.014615] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1975machine # [ 66.023321] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1976machine # [ 66.027842] systemd[1]: Finished test.service.1977machine # [ 66.057697] systemd[1]: linger-users.service: Deactivated successfully.1978machine # [ 66.062427] systemd[1]: Finished linger-users.service.1979machine # [ 66.196818] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1980machine # [ 66.199818] systemd[1]: Finished Create SUID/SGID Wrappers.1981machine # [ 66.456701] nixos[4183]: finished switching to system configuration /nix/store/00ix772xir8b6sdxk16yapmwqyinwzak-nixos-system-machine-test1982machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 2.02 seconds)1983machine: must fail: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&11984machine # [ 66.705166] nixos[4325]: switching to system configuration /nix/store/bb15izfhgryn7nnfffyb560df1iywqfj-nixos-system-machine-test1985machine # [ 66.708180] systemd[1]: Stopped target Remote File Systems.1986machine # [ 66.711295] systemd[1]: test.service: Deactivated successfully.1987machine # [ 66.714256] systemd[1]: Stopped test.service.1988machine # [ 66.715007] systemd[1]: Stopped target Local File Systems.1989machine # [ 67.014594] systemd[1]: Reload requested from client PID 4325 ('.switch-to-conf') (unit backdoor.service)...1990machine # [ 67.016705] systemd[1]: Reloading...1991machine # [ 67.338120] systemd[1]: Reloading finished in 320 ms.1992machine # [ 67.429905] systemd[589]: Reexecution requested from client PID 4394 ('switch-to-confi')...1993machine # [ 67.433537] systemd[589]: Reexecuting.1994machine # [ 67.491005] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1995machine # [ 67.599363] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1996machine # [ 67.607117] systemd[589]: Reload requested from client PID 4394 ('switch-to-confi')...1997machine # [ 67.610639] systemd[589]: Reloading...1998machine # [ 67.716437] systemd[589]: Reloading finished in 106 ms.1999machine # [ 67.732209] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2000machine # [ 67.742741] systemd[589]: Stopped Run user-specific NixOS activation.2001machine # [ 67.745359] systemd[589]: Stopping Run user-specific NixOS activation...2002machine # [ 67.747664] systemd[589]: Starting Run user-specific NixOS activation...2003machine # [ 67.781303] systemd[589]: Finished Run user-specific NixOS activation.2004machine # [ 67.785618] systemd[1]: Stopped target Reactivate sysinit units.2005machine # [ 67.788901] systemd[1]: Stopping Reactivate sysinit units...2006machine # [ 67.789807] systemd[1]: Reached target Reactivate sysinit units.2007machine # [ 67.792793] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2008machine # [ 67.794176] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2009machine # [ 67.797707] systemd[1]: Reached target Local File Systems.2010machine # [ 67.800509] systemd[1]: Reached target Remote File Systems.2011machine # [ 67.807178] systemd[1]: Starting linger-users.service...2012machine # [ 67.811404] systemd[1]: Starting test.service...2013machine # [ 67.823622] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2014machine # [ 67.833677] systemd[1]: Starting Create SUID/SGID Wrappers...2015machine # [ 67.834616] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2016machine # [ 67.836001] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672017machine # [ 67.847080] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2018machine # [ 67.853367] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2019machine # [ 67.854889] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2020machine # [ 67.888897] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE2021machine # [ 67.890364] systemd[1]: test.service: Failed with result 'exit-code'.2022machine # [ 67.891659] systemd[1]: Failed to start test.service.2023machine # [ 67.925719] systemd[1]: linger-users.service: Deactivated successfully.2024machine # [ 67.929285] systemd[1]: Finished linger-users.service.2025machine # [ 68.068181] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2026machine # [ 68.071258] systemd[1]: Finished Create SUID/SGID Wrappers.2027machine # [ 68.345059] nixos[4325]: switching to system configuration /nix/store/bb15izfhgryn7nnfffyb560df1iywqfj-nixos-system-machine-test failed (status 4)2028machine: (finished: must fail: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.89 seconds)2029machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12030machine # [ 68.559301] nixos[4468]: switching to system configuration /nix/store/3aphsxk706ykimp52m3l2nnz5i7n1n99-nixos-system-machine-test2031machine # [ 68.562039] systemd[1]: Stopped target Local File Systems.2032machine # [ 68.564610] systemd[1]: Stopped target Remote File Systems.2033machine # [ 68.873799] systemd[1]: Reload requested from client PID 4468 ('.switch-to-conf') (unit backdoor.service)...2034machine # [ 68.875895] systemd[1]: Reloading...2035machine # [ 69.203427] systemd[1]: Reloading finished in 325 ms.2036machine # [ 69.285657] systemd[589]: Reexecution requested from client PID 4537 ('switch-to-confi')...2037machine # [ 69.289358] systemd[589]: Reexecuting.2038machine # [ 69.339118] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2039machine # [ 69.448677] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2040machine # [ 69.455902] systemd[589]: Reload requested from client PID 4537 ('switch-to-confi')...2041machine # [ 69.459831] systemd[589]: Reloading...2042machine # [ 69.565210] systemd[589]: Reloading finished in 106 ms.2043machine # [ 69.580180] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2044machine # [ 69.591944] systemd[589]: Stopped Run user-specific NixOS activation.2045machine # [ 69.594389] systemd[589]: Stopping Run user-specific NixOS activation...2046machine # [ 69.596654] systemd[589]: Starting Run user-specific NixOS activation...2047machine # [ 69.628074] systemd[589]: Finished Run user-specific NixOS activation.2048machine # [ 69.631985] systemd[1]: Stopped target Reactivate sysinit units.2049machine # [ 69.633567] systemd[1]: Stopping Reactivate sysinit units...2050machine # [ 69.634407] systemd[1]: Reached target Reactivate sysinit units.2051machine # [ 69.638012] systemd[1]: Reached target Local File Systems.2052machine # [ 69.641285] systemd[1]: Reached target Remote File Systems.2053machine # [ 69.649337] systemd[1]: Started autorestart.service.2054machine # [ 69.654249] systemd[1]: Starting linger-users.service...2055machine # [ 69.668075] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2056machine # [ 69.669857] systemd[1]: Starting Create SUID/SGID Wrappers...2057machine # [ 69.670710] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2058machine # [ 69.671995] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672059machine # [ 69.686462] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2060machine # [ 69.696551] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2061machine # [ 69.698000] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2062machine # [ 69.710019] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2063machine # [ 69.718868] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2064machine # [ 69.731952] systemd[1]: autorestart.service: Deactivated successfully.2065machine # [ 69.769015] systemd[1]: linger-users.service: Deactivated successfully.2066machine # [ 69.772496] systemd[1]: Finished linger-users.service.2067machine # [ 69.898931] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2068machine # [ 69.901951] systemd[1]: Finished Create SUID/SGID Wrappers.2069machine # [ 70.159473] nixos[4468]: finished switching to system configuration /nix/store/3aphsxk706ykimp52m3l2nnz5i7n1n99-nixos-system-machine-test2070machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.81 seconds)2071machine # [ 70.202069] systemd[1]: Stopped autorestart.service.2072machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12073machine # [ 70.407221] nixos[4615]: switching to system configuration /nix/store/3aphsxk706ykimp52m3l2nnz5i7n1n99-nixos-system-machine-test2074machine # [ 70.410400] systemd[1]: Stopped target Remote File Systems.2075machine # [ 70.413469] systemd[1]: Stopped target Local File Systems.2076machine # [ 70.701284] systemd[1]: Reload requested from client PID 4615 ('.switch-to-conf') (unit backdoor.service)...2077machine # [ 70.703368] systemd[1]: Reloading...2078machine # [ 71.036434] systemd[1]: Reloading finished in 331 ms.2079machine # [ 71.127435] systemd[589]: Reexecution requested from client PID 4684 ('switch-to-confi')...2080machine # [ 71.131769] systemd[589]: Reexecuting.2081machine # [ 71.179682] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2082machine # [ 71.289734] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2083machine # [ 71.296664] systemd[589]: Reload requested from client PID 4684 ('switch-to-confi')...2084machine # [ 71.299208] systemd[589]: Reloading...2085machine # [ 71.406398] systemd[589]: Reloading finished in 106 ms.2086machine # [ 71.424189] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2087machine # [ 71.433898] systemd[589]: Stopped Run user-specific NixOS activation.2088machine # [ 71.436071] systemd[589]: Stopping Run user-specific NixOS activation...2089machine # [ 71.438641] systemd[589]: Starting Run user-specific NixOS activation...2090machine # [ 71.472590] systemd[589]: Finished Run user-specific NixOS activation.2091machine # [ 71.477003] systemd[1]: Stopped target Reactivate sysinit units.2092machine # [ 71.478001] systemd[1]: Stopping Reactivate sysinit units...2093machine # [ 71.478825] systemd[1]: Reached target Reactivate sysinit units.2094machine # [ 71.485196] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2095machine # [ 71.488534] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2096machine # [ 71.492959] systemd[1]: Reached target Local File Systems.2097machine # [ 71.496692] systemd[1]: Reached target Remote File Systems.2098machine # [ 71.504523] systemd[1]: Started autorestart.service.2099machine # [ 71.505351] systemd[1]: Starting linger-users.service...2100machine # [ 71.524481] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2101machine # [ 71.526210] systemd[1]: Starting Create SUID/SGID Wrappers...2102machine # [ 71.527046] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2103machine # [ 71.531368] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672104machine # [ 71.536842] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2105machine # [ 71.538552] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2106machine # [ 71.553849] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2107machine # [ 71.577411] systemd[1]: autorestart.service: Deactivated successfully.2108machine # [ 71.612836] systemd[1]: linger-users.service: Deactivated successfully.2109machine # [ 71.615447] systemd[1]: Finished linger-users.service.2110machine # [ 71.744729] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2111machine # [ 71.748399] systemd[1]: Finished Create SUID/SGID Wrappers.2112machine # [ 72.003696] nixos[4615]: finished switching to system configuration /nix/store/3aphsxk706ykimp52m3l2nnz5i7n1n99-nixos-system-machine-test2113machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.80 seconds)2114machine # [ 72.045266] systemd[1]: Stopped autorestart.service.2115machine: must fail: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&12116machine # [ 72.260936] nixos[4762]: switching to system configuration /nix/store/w50a3bypllc1h0iz4yvcvfdn1cwa3ii9-nixos-system-machine-test2117machine # [ 72.263489] systemd[1]: Stopped target Local File Systems.2118machine # [ 72.266389] systemd[1]: Stopped target Remote File Systems.2119machine # [ 72.550993] systemd[1]: Reload requested from client PID 4762 ('.switch-to-conf') (unit backdoor.service)...2120machine # [ 72.553070] systemd[1]: Reloading...2121machine # [ 72.880782] systemd[1]: Reloading finished in 326 ms.2122machine # [ 72.970866] systemd[589]: Reexecution requested from client PID 4831 ('switch-to-confi')...2123machine # [ 72.973174] systemd[589]: Reexecuting.2124machine # [ 73.036124] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2125machine # [ 73.154335] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2126machine # [ 73.161093] systemd[589]: Reload requested from client PID 4831 ('switch-to-confi')...2127machine # [ 73.165074] systemd[589]: Reloading...2128machine # [ 73.270965] systemd[589]: Reloading finished in 106 ms.2129machine # [ 73.288183] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2130machine # [ 73.299111] systemd[589]: Stopped Run user-specific NixOS activation.2131machine # [ 73.300520] systemd[589]: Stopping Run user-specific NixOS activation...2132machine # [ 73.303135] systemd[589]: Starting Run user-specific NixOS activation...2133machine # [ 73.336300] systemd[589]: Finished Run user-specific NixOS activation.2134machine # [ 73.340671] systemd[1]: Stopped target Reactivate sysinit units.2135machine # [ 73.341710] systemd[1]: Stopping Reactivate sysinit units...2136machine # [ 73.342526] systemd[1]: Reached target Reactivate sysinit units.2137machine # [ 73.345213] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2138machine # [ 73.352405] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2139machine # [ 73.353814] systemd[1]: Reached target Remote File Systems.2140machine # [ 73.356325] systemd[1]: Started autorestart.service.2141machine # [ 73.361670] systemd[1]: Starting linger-users.service...2142machine # [ 73.362533] systemd[1]: Reached target Local File Systems.2143machine # [ 73.376398] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2144machine # [ 73.382113] systemd[1]: Starting Create SUID/SGID Wrappers...2145machine # [ 73.383102] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2146machine # [ 73.392639] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672147machine # [ 73.395083] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2148machine # [ 73.410609] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2149machine # [ 73.416397] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2150machine # [ 73.434441] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE2151machine # [ 73.439842] systemd[1]: autorestart.service: Failed with result 'exit-code'.2152machine # [ 73.469145] systemd[1]: linger-users.service: Deactivated successfully.2153machine # [ 73.473776] systemd[1]: Finished linger-users.service.2154machine # [ 73.608189] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2155machine # [ 73.611700] systemd[1]: Finished Create SUID/SGID Wrappers.2156machine # [ 73.887354] nixos[4762]: switching to system configuration /nix/store/w50a3bypllc1h0iz4yvcvfdn1cwa3ii9-nixos-system-machine-test failed (status 4)2157machine: (finished: must fail: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.84 seconds)2158(finished: subtest: failing units, in 9.45 seconds)2159subtest: unit file parser2160machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12161machine # [ 74.089013] nixos[4905]: switching to system configuration /nix/store/5sfwvj46bvawa98krfx8m6gpmwdhxczn-nixos-system-machine-test2162machine # [ 74.091839] systemd[1]: Stopped autorestart.service.2163machine # [ 74.094356] systemd[1]: Stopped target Local File Systems.2164machine # [ 74.095725] systemd[1]: Stopped target Remote File Systems.2165machine # [ 74.367732] systemd[1]: Reload requested from client PID 4905 ('.switch-to-conf') (unit backdoor.service)...2166machine # [ 74.369843] systemd[1]: Reloading...2167machine # [ 74.686859] systemd[1]: Reloading finished in 315 ms.2168machine # [ 74.774319] systemd[589]: Reexecution requested from client PID 4974 ('switch-to-confi')...2169machine # [ 74.779344] systemd[589]: Reexecuting.2170machine # [ 74.835901] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2171machine # [ 74.952164] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2172machine # [ 74.959106] systemd[589]: Reload requested from client PID 4974 ('switch-to-confi')...2173machine # [ 74.961808] systemd[589]: Reloading...2174machine # [ 75.073324] systemd[589]: Reloading finished in 110 ms.2175machine # [ 75.088223] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2176machine # [ 75.097847] systemd[589]: Stopped Run user-specific NixOS activation.2177machine # [ 75.100762] systemd[589]: Stopping Run user-specific NixOS activation...2178machine # [ 75.102983] systemd[589]: Starting Run user-specific NixOS activation...2179machine # [ 75.138444] systemd[589]: Finished Run user-specific NixOS activation.2180machine # [ 75.143111] systemd[1]: Stopped target Reactivate sysinit units.2181machine # [ 75.149455] systemd[1]: Stopping Reactivate sysinit units...2182machine # [ 75.150447] systemd[1]: Reached target Reactivate sysinit units.2183machine # [ 75.151351] systemd[1]: Reached target Local File Systems.2184machine # [ 75.153049] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2185machine # [ 75.156466] systemd[1]: Starting Create SUID/SGID Wrappers...2186machine # [ 75.157443] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2187machine # [ 75.158743] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672188machine # [ 75.169266] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2189machine # [ 75.171017] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2190machine # [ 75.179607] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2191machine # [ 75.187917] systemd[1]: Reached target Remote File Systems.2192machine # [ 75.189900] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2193machine # [ 75.192238] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2194machine # [ 75.348988] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2195machine # [ 75.351335] systemd[1]: Finished Create SUID/SGID Wrappers.2196machine # [ 75.358081] systemd[1]: Starting linger-users.service...2197machine # [ 75.361387] systemd[1]: Starting test.service...2198machine # [ 75.402128] systemd[1]: Finished test.service.2199machine # [ 75.425524] systemd[1]: linger-users.service: Deactivated successfully.2200machine # [ 75.427307] systemd[1]: Finished linger-users.service.2201machine # [ 75.685013] nixos[4905]: finished switching to system configuration /nix/store/5sfwvj46bvawa98krfx8m6gpmwdhxczn-nixos-system-machine-test2202machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.80 seconds)2203machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&12204machine # [ 75.915050] nixos[5047]: switching to system configuration /nix/store/pymc084x8i03dp4nd3bynbjhjx9k8xsp-nixos-system-machine-test2205machine # [ 75.920773] systemd[1]: Stopped target Remote File Systems.2206machine # [ 75.921723] systemd[1]: Stopped target Local File Systems.2207machine # [ 76.213196] systemd[1]: Reload requested from client PID 5047 ('.switch-to-conf') (unit backdoor.service)...2208machine # [ 76.215204] systemd[1]: Reloading...2209machine # [ 76.537791] systemd[1]: Reloading finished in 321 ms.2210machine # [ 76.627178] systemd[589]: Reexecution requested from client PID 5116 ('switch-to-confi')...2211machine # [ 76.631736] systemd[589]: Reexecuting.2212machine # [ 76.688377] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2213machine # [ 76.803958] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2214machine # [ 76.810553] systemd[589]: Reload requested from client PID 5116 ('switch-to-confi')...2215machine # [ 76.814519] systemd[589]: Reloading...2216machine # [ 76.919444] systemd[589]: Reloading finished in 106 ms.2217machine # [ 76.936182] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2218machine # [ 76.945973] systemd[589]: Stopped Run user-specific NixOS activation.2219machine # [ 76.948524] systemd[589]: Stopping Run user-specific NixOS activation...2220machine # [ 76.950669] systemd[589]: Starting Run user-specific NixOS activation...2221machine # [ 76.985618] systemd[589]: Finished Run user-specific NixOS activation.2222machine # [ 76.990066] systemd[1]: Stopped target Reactivate sysinit units.2223machine # [ 76.992830] systemd[1]: Stopping Reactivate sysinit units...2224machine # [ 76.993797] systemd[1]: Reached target Reactivate sysinit units.2225machine # [ 76.997562] systemd[1]: test.service: Deactivated successfully.2226machine # [ 76.998569] systemd[1]: Stopped test.service.2227machine # [ 76.999238] systemd[1]: Stopping test.service...2228machine # [ 77.004260] systemd[1]: Starting test.service...2229machine # [ 77.030352] systemd[1]: Finished test.service.2230machine # [ 77.036452] systemd[1]: Reached target Remote File Systems.2231machine # [ 77.041373] systemd[1]: Starting linger-users.service...2232machine # [ 77.048624] systemd[1]: Reached target Local File Systems.2233machine # [ 77.056279] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2234machine # [ 77.060599] systemd[1]: Starting Create SUID/SGID Wrappers...2235machine # [ 77.061590] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2236machine # [ 77.074319] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672237machine # [ 77.080976] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2238machine # [ 77.085769] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2239machine # [ 77.088276] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2240machine # [ 77.089546] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2241machine # [ 77.090829] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2242machine # [ 77.142852] systemd[1]: linger-users.service: Deactivated successfully.2243machine # [ 77.146850] systemd[1]: Finished linger-users.service.2244machine # [ 77.294625] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2245machine # [ 77.298532] systemd[1]: Finished Create SUID/SGID Wrappers.2246machine # [ 77.552510] nixos[5047]: finished switching to system configuration /nix/store/pymc084x8i03dp4nd3bynbjhjx9k8xsp-nixos-system-machine-test2247machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.87 seconds)2248machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&12249machine # [ 77.784541] nixos[5189]: switching to system configuration /nix/store/5rywmxck83fw59fcyn0m0lgqkbghvbwi-nixos-system-machine-test2250machine # [ 77.786924] systemd[1]: Stopped target Remote File Systems.2251machine # [ 77.789159] systemd[1]: Stopped target Local File Systems.2252machine # [ 78.082869] systemd[1]: Reload requested from client PID 5189 ('.switch-to-conf') (unit backdoor.service)...2253machine # [ 78.085124] systemd[1]: Reloading...2254machine # [ 78.408068] systemd[1]: Reloading finished in 321 ms.2255machine # [ 78.496929] systemd[589]: Reexecution requested from client PID 5258 ('switch-to-confi')...2256machine # [ 78.500278] systemd[589]: Reexecuting.2257machine # [ 78.560087] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2258machine # [ 78.676149] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2259machine # [ 78.683169] systemd[589]: Reload requested from client PID 5258 ('switch-to-confi')...2260machine # [ 78.686906] systemd[589]: Reloading...2261machine # [ 78.790871] systemd[589]: Reloading finished in 105 ms.2262machine # [ 78.808179] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2263machine # [ 78.818835] systemd[589]: Stopped Run user-specific NixOS activation.2264machine # [ 78.821341] systemd[589]: Stopping Run user-specific NixOS activation...2265machine # [ 78.823724] systemd[589]: Starting Run user-specific NixOS activation...2266machine # [ 78.855840] systemd[589]: Finished Run user-specific NixOS activation.2267machine # [ 78.859354] systemd[1]: Stopped target Reactivate sysinit units.2268machine # [ 78.861460] systemd[1]: Stopping Reactivate sysinit units...2269machine # [ 78.862346] systemd[1]: Reached target Reactivate sysinit units.2270machine # [ 78.867547] systemd[1]: test.service: Deactivated successfully.2271machine # [ 78.872219] systemd[1]: Stopped test.service.2272machine # [ 78.872958] systemd[1]: Stopping test.service...2273machine # [ 78.873624] systemd[1]: Starting test.service...2274machine # [ 78.893061] systemd[1]: Finished test.service.2275machine # [ 78.898478] systemd[1]: Reached target Remote File Systems.2276machine # [ 78.902574] systemd[1]: Starting linger-users.service...2277machine # [ 78.910377] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2278machine # [ 78.911847] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2279machine # [ 78.918940] systemd[1]: Reached target Local File Systems.2280machine # [ 78.923428] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2281machine # [ 78.931897] systemd[1]: Starting Create SUID/SGID Wrappers...2282machine # [ 78.936382] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2283machine # [ 78.942586] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672284machine # [ 78.947808] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2285machine # [ 78.952675] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2286machine # [ 78.954036] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2287machine # [ 78.993392] systemd[1]: linger-users.service: Deactivated successfully.2288machine # [ 78.996393] systemd[1]: Finished linger-users.service.2289machine # [ 79.130106] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2290machine # [ 79.133562] systemd[1]: Finished Create SUID/SGID Wrappers.2291machine # [ 79.387588] nixos[5189]: finished switching to system configuration /nix/store/5rywmxck83fw59fcyn0m0lgqkbghvbwi-nixos-system-machine-test2292machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.84 seconds)2293machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12294machine # [ 79.596709] nixos[5331]: switching to system configuration /nix/store/5sfwvj46bvawa98krfx8m6gpmwdhxczn-nixos-system-machine-test2295machine # [ 79.599137] systemd[1]: Stopped target Remote File Systems.2296machine # [ 79.601925] systemd[1]: Stopped target Local File Systems.2297machine # [ 79.867011] systemd[1]: Reload requested from client PID 5331 ('.switch-to-conf') (unit backdoor.service)...2298machine # [ 79.869200] systemd[1]: Reloading...2299machine # [ 80.245739] systemd[1]: Reloading finished in 374 ms.2300machine # [ 80.329128] systemd[589]: Reexecution requested from client PID 5400 ('switch-to-confi')...2301machine # [ 80.333409] systemd[589]: Reexecuting.2302machine # [ 80.375030] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2303machine # [ 80.482006] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2304machine # [ 80.488643] systemd[589]: Reload requested from client PID 5400 ('switch-to-confi')...2305machine # [ 80.491053] systemd[589]: Reloading...2306machine # [ 80.596300] systemd[589]: Reloading finished in 104 ms.2307machine # [ 80.612170] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2308machine # [ 80.625368] systemd[589]: Stopped Run user-specific NixOS activation.2309machine # [ 80.626415] systemd[589]: Stopping Run user-specific NixOS activation...2310machine # [ 80.628558] systemd[589]: Starting Run user-specific NixOS activation...2311machine # [ 80.658675] systemd[589]: Finished Run user-specific NixOS activation.2312machine # [ 80.662858] systemd[1]: Stopped target Reactivate sysinit units.2313machine # [ 80.663860] systemd[1]: Stopping Reactivate sysinit units...2314machine # [ 80.668852] systemd[1]: Reached target Reactivate sysinit units.2315machine # [ 80.669751] systemd[1]: test.service: Deactivated successfully.2316machine # [ 80.670577] systemd[1]: Stopped test.service.2317machine # [ 80.671209] systemd[1]: Stopping test.service...2318machine # [ 80.672887] systemd[1]: Starting test.service...2319machine # [ 80.696386] systemd[1]: Finished test.service.2320machine # [ 80.699061] systemd[1]: Reached target Remote File Systems.2321machine # [ 80.704405] systemd[1]: Reached target Local File Systems.2322machine # [ 80.705300] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2323machine # [ 80.707726] systemd[1]: Starting Create SUID/SGID Wrappers...2324machine # [ 80.713594] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2325machine # [ 80.714833] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672326machine # [ 80.728271] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2327machine # [ 80.729935] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2328machine # [ 80.731218] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2329machine # [ 80.733187] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2330machine # [ 80.734479] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2331machine # [ 80.889982] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2332machine # [ 80.894950] systemd[1]: Finished Create SUID/SGID Wrappers.2333machine # [ 80.897526] systemd[1]: Starting linger-users.service...2334machine # [ 80.937275] systemd[1]: linger-users.service: Deactivated successfully.2335machine # [ 80.940344] systemd[1]: Finished linger-users.service.2336machine # [ 81.197640] nixos[5331]: finished switching to system configuration /nix/store/5sfwvj46bvawa98krfx8m6gpmwdhxczn-nixos-system-machine-test2337machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.81 seconds)2338machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&12339machine # [ 81.427039] nixos[5473]: switching to system configuration /nix/store/7k3k0w111mgnv89p2r01pdqbshn8k3yp-nixos-system-machine-test2340machine # [ 81.430529] systemd[1]: Stopped target Local File Systems.2341machine # [ 81.432341] systemd[1]: Stopped target Remote File Systems.2342machine # [ 81.726855] systemd[1]: Reload requested from client PID 5473 ('.switch-to-conf') (unit backdoor.service)...2343machine # [ 81.729318] systemd[1]: Reloading...2344machine # [ 82.051274] systemd[1]: Reloading finished in 320 ms.2345machine # [ 82.144467] systemd[589]: Reexecution requested from client PID 5542 ('switch-to-confi')...2346machine # [ 82.145947] systemd[589]: Reexecuting.2347machine # [ 82.203370] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2348machine # [ 82.320708] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2349machine # [ 82.327660] systemd[589]: Reload requested from client PID 5542 ('switch-to-confi')...2350machine # [ 82.330043] systemd[589]: Reloading...2351machine # [ 82.434853] systemd[589]: Reloading finished in 103 ms.2352machine # [ 82.452167] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2353machine # [ 82.462035] systemd[589]: Stopped Run user-specific NixOS activation.2354machine # [ 82.464514] systemd[589]: Stopping Run user-specific NixOS activation...2355machine # [ 82.466602] systemd[589]: Starting Run user-specific NixOS activation...2356machine # [ 82.499331] systemd[589]: Finished Run user-specific NixOS activation.2357machine # [ 82.503711] systemd[1]: Stopped target Reactivate sysinit units.2358machine # [ 82.507768] systemd[1]: Stopping Reactivate sysinit units...2359machine # [ 82.512787] systemd[1]: Reached target Reactivate sysinit units.2360machine # [ 82.513703] systemd[1]: Reached target Local File Systems.2361machine # [ 82.514473] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2362machine # [ 82.516923] systemd[1]: Starting Create SUID/SGID Wrappers...2363machine # [ 82.517834] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2364machine # [ 82.529502] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672365machine # [ 82.531889] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2366machine # [ 82.538093] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2367machine # [ 82.539548] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2368machine # [ 82.540930] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2369machine # [ 82.542216] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2370machine # [ 82.543497] systemd[1]: Reached target Remote File Systems.2371machine # [ 82.693421] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2372machine # [ 82.695325] systemd[1]: Finished Create SUID/SGID Wrappers.2373machine # [ 82.700343] systemd[1]: Starting linger-users.service...2374machine # [ 82.740666] systemd[1]: linger-users.service: Deactivated successfully.2375machine # [ 82.743467] systemd[1]: Finished linger-users.service.2376machine # [ 82.998767] nixos[5473]: finished switching to system configuration /nix/store/7k3k0w111mgnv89p2r01pdqbshn8k3yp-nixos-system-machine-test2377machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.80 seconds)2378machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&12379machine # [ 83.220842] nixos[5613]: switching to system configuration /nix/store/ha9xbsxa2rlcsk3y16bgpf9yzsrw7zhp-nixos-system-machine-test2380machine # [ 83.224782] systemd[1]: Stopped target Remote File Systems.2381machine # [ 83.225668] systemd[1]: Stopped target Local File Systems.2382machine # [ 83.506745] systemd[1]: Reload requested from client PID 5613 ('.switch-to-conf') (unit backdoor.service)...2383machine # [ 83.508883] systemd[1]: Reloading...2384machine # [ 83.818576] systemd[1]: Reloading finished in 308 ms.2385machine # [ 83.907477] systemd[589]: Reexecution requested from client PID 5682 ('switch-to-confi')...2386machine # [ 83.910431] systemd[589]: Reexecuting.2387machine # [ 83.972147] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2388machine # [ 84.087423] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2389machine # [ 84.094022] systemd[589]: Reload requested from client PID 5682 ('switch-to-confi')...2390machine # [ 84.097966] systemd[589]: Reloading...2391machine # [ 84.200654] systemd[589]: Reloading finished in 103 ms.2392machine # [ 84.216178] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2393machine # [ 84.226340] systemd[589]: Stopped Run user-specific NixOS activation.2394machine # [ 84.228935] systemd[589]: Stopping Run user-specific NixOS activation...2395machine # [ 84.231144] systemd[589]: Starting Run user-specific NixOS activation...2396machine # [ 84.264124] systemd[589]: Finished Run user-specific NixOS activation.2397machine # [ 84.268120] systemd[1]: Stopped target Reactivate sysinit units.2398machine # [ 84.272519] systemd[1]: Stopping Reactivate sysinit units...2399machine # [ 84.273468] systemd[1]: Reached target Reactivate sysinit units.2400machine # [ 84.274381] systemd[1]: test.service: Deactivated successfully.2401machine # [ 84.275230] systemd[1]: Stopped test.service.2402machine # [ 84.275894] systemd[1]: Stopping test.service...2403machine # [ 84.278396] systemd[1]: Starting test.service...2404machine # [ 84.305313] systemd[1]: Finished test.service.2405machine # [ 84.310419] systemd[1]: Reached target Local File Systems.2406machine # [ 84.314164] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2407machine # [ 84.318567] systemd[1]: Starting Create SUID/SGID Wrappers...2408machine # [ 84.319629] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2409machine # [ 84.328408] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672410machine # [ 84.330756] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2411machine # [ 84.334126] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2412machine # [ 84.335507] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2413machine # [ 84.348135] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2414machine # [ 84.349604] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2415machine # [ 84.351788] systemd[1]: Reached target Remote File Systems.2416machine # [ 84.520774] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2417machine # [ 84.525807] systemd[1]: Finished Create SUID/SGID Wrappers.2418machine # [ 84.528407] systemd[1]: Starting linger-users.service...2419machine # [ 84.568439] systemd[1]: linger-users.service: Deactivated successfully.2420machine # [ 84.571629] systemd[1]: Finished linger-users.service.2421machine # [ 84.825602] nixos[5613]: finished switching to system configuration /nix/store/ha9xbsxa2rlcsk3y16bgpf9yzsrw7zhp-nixos-system-machine-test2422machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.83 seconds)2423machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&12424machine # [ 85.047272] nixos[5755]: switching to system configuration /nix/store/r98v1gxb34fn1a91wp3rikv857jj70xv-nixos-system-machine-test2425machine # [ 85.052206] systemd[1]: Stopped target Local File Systems.2426machine # [ 85.053092] systemd[1]: Stopped target Remote File Systems.2427machine # [ 85.332884] systemd[1]: Reload requested from client PID 5755 ('.switch-to-conf') (unit backdoor.service)...2428machine # [ 85.335022] systemd[1]: Reloading...2429machine # [ 85.655221] systemd[1]: Reloading finished in 318 ms.2430machine # [ 85.738940] systemd[589]: Reexecution requested from client PID 5824 ('switch-to-confi')...2431machine # [ 85.743053] systemd[589]: Reexecuting.2432machine # [ 85.795516] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2433machine # [ 85.906453] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2434machine # [ 85.912937] systemd[589]: Reload requested from client PID 5824 ('switch-to-confi')...2435machine # [ 85.916057] systemd[589]: Reloading...2436machine # [ 86.019643] systemd[589]: Reloading finished in 103 ms.2437machine # [ 86.036160] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2438machine # [ 86.045429] systemd[589]: Stopped Run user-specific NixOS activation.2439machine # [ 86.047652] systemd[589]: Stopping Run user-specific NixOS activation...2440machine # [ 86.049744] systemd[589]: Starting Run user-specific NixOS activation...2441machine # [ 86.079254] systemd[589]: Finished Run user-specific NixOS activation.2442machine # [ 86.083218] systemd[1]: Stopped target Reactivate sysinit units.2443machine # [ 86.085136] systemd[1]: Stopping Reactivate sysinit units...2444machine # [ 86.085974] systemd[1]: Reached target Reactivate sysinit units.2445machine # [ 86.089811] systemd[1]: test.service: Deactivated successfully.2446machine # [ 86.090733] systemd[1]: Stopped test.service.2447machine # [ 86.091484] systemd[1]: Stopping test.service...2448machine # [ 86.096213] systemd[1]: Starting test.service...2449machine # [ 86.117012] systemd[1]: Finished test.service.2450machine # [ 86.121892] systemd[1]: Reached target Local File Systems.2451machine # [ 86.124644] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2452machine # [ 86.130062] systemd[1]: Starting Create SUID/SGID Wrappers...2453machine # [ 86.131029] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2454machine # [ 86.140533] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672455machine # [ 86.142808] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2456machine # [ 86.151672] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2457machine # [ 86.153121] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2458machine # [ 86.154330] systemd[1]: Reached target Remote File Systems.2459machine # [ 86.155157] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2460machine # [ 86.157251] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2461machine # [ 86.304587] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2462machine # [ 86.306446] systemd[1]: Finished Create SUID/SGID Wrappers.2463machine # [ 86.311739] systemd[1]: Starting linger-users.service...2464machine # [ 86.351623] systemd[1]: linger-users.service: Deactivated successfully.2465machine # [ 86.354487] systemd[1]: Finished linger-users.service.2466machine # [ 86.609859] nixos[5755]: finished switching to system configuration /nix/store/r98v1gxb34fn1a91wp3rikv857jj70xv-nixos-system-machine-test2467machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.78 seconds)2468machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&12469machine # [ 86.884876] nixos[5897]: switching to system configuration /nix/store/1q78rcbk2ckw3lrdh1c4c5yx3zlh63df-nixos-system-machine-test2470machine # [ 86.888437] systemd[1]: Stopped target Remote File Systems.2471machine # [ 86.891613] systemd[1]: Stopped target Local File Systems.2472machine # [ 87.168919] systemd[1]: Reload requested from client PID 5897 ('.switch-to-conf') (unit backdoor.service)...2473machine # [ 87.170878] systemd[1]: Reloading...2474machine # [ 87.477637] systemd[1]: Reloading finished in 305 ms.2475machine # [ 87.560576] systemd[589]: Reexecution requested from client PID 5966 ('switch-to-confi')...2476machine # [ 87.564272] systemd[589]: Reexecuting.2477machine # [ 87.623619] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2478machine # [ 87.733887] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2479machine # [ 87.740281] systemd[589]: Reload requested from client PID 5966 ('switch-to-confi')...2480machine # [ 87.742601] systemd[589]: Reloading...2481machine # [ 87.844518] systemd[589]: Reloading finished in 100 ms.2482machine # [ 87.860152] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2483machine # [ 87.869298] systemd[589]: Stopped Run user-specific NixOS activation.2484machine # [ 87.871576] systemd[589]: Stopping Run user-specific NixOS activation...2485machine # [ 87.873667] systemd[589]: Starting Run user-specific NixOS activation...2486machine # [ 87.902087] systemd[589]: Finished Run user-specific NixOS activation.2487machine # [ 87.906165] systemd[1]: Stopped target Reactivate sysinit units.2488machine # [ 87.910980] systemd[1]: Stopping Reactivate sysinit units...2489machine # [ 87.911902] systemd[1]: Reached target Reactivate sysinit units.2490machine # [ 87.914017] systemd[1]: test.service: Deactivated successfully.2491machine # [ 87.914883] systemd[1]: Stopped test.service.2492machine # [ 87.915650] systemd[1]: Stopping test.service...2493machine # [ 87.920258] systemd[1]: Starting test.service...2494machine # [ 87.939952] systemd[1]: Finished test.service.2495machine # [ 87.943325] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2496machine # [ 87.946293] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2497machine # [ 87.949763] systemd[1]: Reached target Remote File Systems.2498machine # [ 87.953980] systemd[1]: Reached target Local File Systems.2499machine # [ 87.957501] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2500machine # [ 87.963910] systemd[1]: Starting Create SUID/SGID Wrappers...2501machine # [ 87.966469] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2502machine # [ 87.967772] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672503machine # [ 87.971210] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2504machine # [ 87.976152] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2505machine # [ 87.977490] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2506machine # [ 88.129186] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2507machine # [ 88.132845] systemd[1]: Finished Create SUID/SGID Wrappers.2508machine # [ 88.135433] systemd[1]: Starting linger-users.service...2509machine # [ 88.175428] systemd[1]: linger-users.service: Deactivated successfully.2510machine # [ 88.177942] systemd[1]: Finished linger-users.service.2511machine # [ 88.433443] nixos[5897]: finished switching to system configuration /nix/store/1q78rcbk2ckw3lrdh1c4c5yx3zlh63df-nixos-system-machine-test2512machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 1.82 seconds)2513machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12514machine # [ 88.641427] nixos[6039]: switching to system configuration /nix/store/5sfwvj46bvawa98krfx8m6gpmwdhxczn-nixos-system-machine-test2515machine # [ 88.643923] systemd[1]: Stopped target Remote File Systems.2516machine # [ 88.646181] systemd[1]: Stopped target Local File Systems.2517machine # [ 88.897429] systemd[1]: Reload requested from client PID 6039 ('.switch-to-conf') (unit backdoor.service)...2518machine # [ 88.899020] systemd[1]: Reloading...2519machine # [ 89.192494] systemd[1]: Reloading finished in 291 ms.2520machine # [ 89.275946] systemd[589]: Reexecution requested from client PID 6108 ('switch-to-confi')...2521machine # [ 89.280213] systemd[589]: Reexecuting.2522machine # [ 89.335607] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2523machine # [ 89.443114] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2524machine # [ 89.450024] systemd[589]: Reload requested from client PID 6108 ('switch-to-confi')...2525machine # [ 89.451317] systemd[589]: Reloading...2526machine # [ 89.551764] systemd[589]: Reloading finished in 99 ms.2527machine # [ 89.569532] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2528machine # [ 89.578244] systemd[589]: Stopped Run user-specific NixOS activation.2529machine # [ 89.579213] systemd[589]: Stopping Run user-specific NixOS activation...2530machine # [ 89.582011] systemd[589]: Starting Run user-specific NixOS activation...2531machine # [ 89.609409] systemd[589]: Finished Run user-specific NixOS activation.2532machine # [ 89.613165] systemd[1]: Stopped target Reactivate sysinit units.2533machine # [ 89.614376] systemd[1]: Stopping Reactivate sysinit units...2534machine # [ 89.615198] systemd[1]: Reached target Reactivate sysinit units.2535machine # [ 89.617452] systemd[1]: test.service: Deactivated successfully.2536machine # [ 89.620548] systemd[1]: Stopped test.service.2537machine # [ 89.621243] systemd[1]: Stopping test.service...2538machine # [ 89.622802] systemd[1]: Starting test.service...2539machine # [ 89.643171] systemd[1]: Finished test.service.2540machine # [ 89.645754] systemd[1]: Reached target Local File Systems.2541machine # [ 89.648439] systemd[1]: Reached target Remote File Systems.2542machine # [ 89.650620] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2543machine # [ 89.651999] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2544machine # [ 89.657104] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2545machine # [ 89.663239] systemd[1]: Starting Create SUID/SGID Wrappers...2546machine # [ 89.666404] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2547machine # [ 89.667737] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672548machine # [ 89.675676] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2549machine # [ 89.678819] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2550machine # [ 89.680181] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2551machine # [ 89.827826] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2552machine # [ 89.832722] systemd[1]: Finished Create SUID/SGID Wrappers.2553machine # [ 89.834736] systemd[1]: Starting linger-users.service...2554machine # [ 89.874461] systemd[1]: linger-users.service: Deactivated successfully.2555machine # [ 89.877455] systemd[1]: Finished linger-users.service.2556machine # [ 90.131488] nixos[6039]: finished switching to system configuration /nix/store/5sfwvj46bvawa98krfx8m6gpmwdhxczn-nixos-system-machine-test2557machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.70 seconds)2558machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&12559machine # [ 90.351152] nixos[6181]: switching to system configuration /nix/store/qr9cfi7jniiibz56zsxn6c4f8lvg1cb5-nixos-system-machine-test2560machine # [ 90.354417] systemd[1]: Stopped target Local File Systems.2561machine # [ 90.355914] systemd[1]: Stopped target Remote File Systems.2562machine # [ 90.619522] systemd[1]: Reload requested from client PID 6181 ('.switch-to-conf') (unit backdoor.service)...2563machine # [ 90.621596] systemd[1]: Reloading...2564machine # [ 90.921186] systemd[1]: Reloading finished in 298 ms.2565machine # [ 91.004398] systemd[589]: Reexecution requested from client PID 6250 ('switch-to-confi')...2566machine # [ 91.008053] systemd[589]: Reexecuting.2567machine # [ 91.063580] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2568machine # [ 91.175215] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2569machine # [ 91.181630] systemd[589]: Reload requested from client PID 6250 ('switch-to-confi')...2570machine # [ 91.183863] systemd[589]: Reloading...2571machine # [ 91.286020] systemd[589]: Reloading finished in 101 ms.2572machine # [ 91.300141] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2573machine # [ 91.310592] systemd[589]: Stopped Run user-specific NixOS activation.2574machine # [ 91.312745] systemd[589]: Stopping Run user-specific NixOS activation...2575machine # [ 91.314677] systemd[589]: Starting Run user-specific NixOS activation...2576machine # [ 91.346189] systemd[589]: Finished Run user-specific NixOS activation.2577machine # [ 91.349996] systemd[1]: Stopped target Reactivate sysinit units.2578machine # [ 91.354226] systemd[1]: Stopping Reactivate sysinit units...2579machine # [ 91.355071] systemd[1]: Reached target Reactivate sysinit units.2580machine # [ 91.357179] systemd[1]: Reloading test.service...2581machine # [ 91.379796] systemd[1]: Reloaded test.service.2582machine # [ 91.382737] systemd[1]: Reached target Local File Systems.2583machine # [ 91.387583] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2584machine # [ 91.390089] systemd[1]: Starting Create SUID/SGID Wrappers...2585machine # [ 91.390943] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2586machine # [ 91.400205] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672587machine # [ 91.402421] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2588machine # [ 91.404003] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2589machine # [ 91.407611] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2590machine # [ 91.414933] systemd[1]: Reached target Remote File Systems.2591machine # [ 91.415970] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2592machine # [ 91.419505] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2593machine # [ 91.558926] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2594machine # [ 91.562961] systemd[1]: Finished Create SUID/SGID Wrappers.2595machine # [ 91.565071] systemd[1]: Starting linger-users.service...2596machine # [ 91.602297] systemd[1]: linger-users.service: Deactivated successfully.2597machine # [ 91.604149] systemd[1]: Finished linger-users.service.2598machine # [ 91.861167] nixos[6181]: finished switching to system configuration /nix/store/qr9cfi7jniiibz56zsxn6c4f8lvg1cb5-nixos-system-machine-test2599machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.73 seconds)2600machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&12601machine # [ 92.078249] nixos[6323]: switching to system configuration /nix/store/vrbx2vzpvcldbqyrfcw2f5cpzknqp5pz-nixos-system-machine-test2602machine # [ 92.080661] systemd[1]: Stopped target Local File Systems.2603machine # [ 92.082954] systemd[1]: Stopped target Remote File Systems.2604machine # [ 92.357404] systemd[1]: Reload requested from client PID 6323 ('.switch-to-conf') (unit backdoor.service)...2605machine # [ 92.359281] systemd[1]: Reloading...2606machine # [ 92.661322] systemd[1]: Reloading finished in 299 ms.2607machine # [ 92.743766] systemd[589]: Reexecution requested from client PID 6392 ('switch-to-confi')...2608machine # [ 92.746089] systemd[589]: Reexecuting.2609machine # [ 92.803750] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2610machine # [ 92.915202] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2611machine # [ 92.922472] systemd[589]: Reload requested from client PID 6392 ('switch-to-confi')...2612machine # [ 92.923850] systemd[589]: Reloading...2613machine # [ 93.025427] systemd[589]: Reloading finished in 100 ms.2614machine # [ 93.040170] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2615machine # [ 93.050974] systemd[589]: Stopped Run user-specific NixOS activation.2616machine # [ 93.053345] systemd[589]: Stopping Run user-specific NixOS activation...2617machine # [ 93.055346] systemd[589]: Starting Run user-specific NixOS activation...2618machine # [ 93.086283] systemd[589]: Finished Run user-specific NixOS activation.2619machine # [ 93.090018] systemd[1]: Stopped target Reactivate sysinit units.2620machine # [ 93.094081] systemd[1]: Stopping Reactivate sysinit units...2621machine # [ 93.094954] systemd[1]: Reached target Reactivate sysinit units.2622machine # [ 93.096981] systemd[1]: Reloading test.service...2623machine # [ 93.119801] systemd[1]: Reloaded test.service.2624machine # [ 93.125384] systemd[1]: Reached target Remote File Systems.2625machine # [ 93.129455] systemd[1]: Starting linger-users.service...2626machine # [ 93.137063] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2627machine # [ 93.144106] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2628machine # [ 93.145507] systemd[1]: Reached target Local File Systems.2629machine # [ 93.146438] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2630machine # [ 93.160248] systemd[1]: Starting Create SUID/SGID Wrappers...2631machine # [ 93.161175] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2632machine # [ 93.162430] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672633machine # [ 93.172067] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2634machine # [ 93.174768] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2635machine # [ 93.179298] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2636machine # [ 93.213904] systemd[1]: linger-users.service: Deactivated successfully.2637machine # [ 93.217999] systemd[1]: Finished linger-users.service.2638machine # [ 93.345728] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2639machine # [ 93.349293] systemd[1]: Finished Create SUID/SGID Wrappers.2640machine # [ 93.603233] nixos[6323]: finished switching to system configuration /nix/store/vrbx2vzpvcldbqyrfcw2f5cpzknqp5pz-nixos-system-machine-test2641machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.74 seconds)2642machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&12643machine # [ 93.830827] nixos[6465]: switching to system configuration /nix/store/ysypx78vwaxb2cwn9bd7qw9rs1x6ssd3-nixos-system-machine-test2644machine # [ 93.836389] systemd[1]: Stopped target Remote File Systems.2645machine # [ 93.837280] systemd[1]: Stopped target Local File Systems.2646machine # [ 94.113325] systemd[1]: Reload requested from client PID 6465 ('.switch-to-conf') (unit backdoor.service)...2647machine # [ 94.115534] systemd[1]: Reloading...2648machine # [ 94.419399] systemd[1]: Reloading finished in 302 ms.2649machine # [ 94.503874] systemd[589]: Reexecution requested from client PID 6534 ('switch-to-confi')...2650machine # [ 94.507578] systemd[589]: Reexecuting.2651machine # [ 94.563516] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2652machine # [ 94.675768] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2653machine # [ 94.682391] systemd[589]: Reload requested from client PID 6534 ('switch-to-confi')...2654machine # [ 94.685775] systemd[589]: Reloading...2655machine # [ 94.785940] systemd[589]: Reloading finished in 101 ms.2656machine # [ 94.804170] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2657machine # [ 94.813192] systemd[589]: Stopped Run user-specific NixOS activation.2658machine # [ 94.815457] systemd[589]: Stopping Run user-specific NixOS activation...2659machine # [ 94.817512] systemd[589]: Starting Run user-specific NixOS activation...2660machine # [ 94.846288] systemd[589]: Finished Run user-specific NixOS activation.2661machine # [ 94.850373] systemd[1]: Stopped target Reactivate sysinit units.2662machine # [ 94.852581] systemd[1]: Stopping Reactivate sysinit units...2663machine # [ 94.853433] systemd[1]: Reached target Reactivate sysinit units.2664machine # [ 94.856443] systemd[1]: test.service: Deactivated successfully.2665machine # [ 94.857359] systemd[1]: Stopped test.service.2666machine # [ 94.857999] systemd[1]: Stopping test.service...2667machine # [ 94.860322] systemd[1]: Starting test.service...2668machine # [ 94.883720] systemd[1]: Finished test.service.2669machine # [ 94.888134] systemd[1]: Reached target Remote File Systems.2670machine # [ 94.892471] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2671machine # [ 94.893818] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2672machine # [ 94.895108] systemd[1]: Starting linger-users.service...2673machine # [ 94.905232] systemd[1]: Reached target Local File Systems.2674machine # [ 94.909592] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2675machine # [ 94.917003] systemd[1]: Starting Create SUID/SGID Wrappers...2676machine # [ 94.917915] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2677machine # [ 94.919139] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672678machine # [ 94.928312] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2679machine # [ 94.930830] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2680machine # [ 94.934419] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2681machine # [ 94.978057] systemd[1]: linger-users.service: Deactivated successfully.2682machine # [ 94.981111] systemd[1]: Finished linger-users.service.2683machine # [ 95.102273] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2684machine # [ 95.105067] systemd[1]: Finished Create SUID/SGID Wrappers.2685machine # [ 95.359166] nixos[6465]: finished switching to system configuration /nix/store/ysypx78vwaxb2cwn9bd7qw9rs1x6ssd3-nixos-system-machine-test2686machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.76 seconds)2687machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&12688machine # [ 95.559641] nixos[6607]: switching to system configuration /nix/store/ha9xbsxa2rlcsk3y16bgpf9yzsrw7zhp-nixos-system-machine-test2689machine # [ 95.562223] systemd[1]: Stopped target Local File Systems.2690machine # [ 95.564817] systemd[1]: Stopped target Remote File Systems.2691machine # [ 95.817990] systemd[1]: Reload requested from client PID 6607 ('.switch-to-conf') (unit backdoor.service)...2692machine # [ 95.820194] systemd[1]: Reloading...2693machine # [ 96.107461] systemd[1]: Reloading finished in 285 ms.2694machine # [ 96.188398] systemd[589]: Reexecution requested from client PID 6676 ('switch-to-confi')...2695machine # [ 96.191198] systemd[589]: Reexecuting.2696machine # [ 96.247415] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2697machine # [ 96.355507] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2698machine # [ 96.362181] systemd[589]: Reload requested from client PID 6676 ('switch-to-confi')...2699machine # [ 96.364515] systemd[589]: Reloading...2700machine # [ 96.465280] systemd[589]: Reloading finished in 99 ms.2701machine # [ 96.481525] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2702machine # [ 96.489183] systemd[589]: Stopped Run user-specific NixOS activation.2703machine # [ 96.491508] systemd[589]: Stopping Run user-specific NixOS activation...2704machine # [ 96.493586] systemd[589]: Starting Run user-specific NixOS activation...2705machine # [ 96.522196] systemd[589]: Finished Run user-specific NixOS activation.2706machine # [ 96.525812] systemd[1]: Stopped target Reactivate sysinit units.2707machine # [ 96.528782] systemd[1]: Stopping Reactivate sysinit units...2708machine # [ 96.529649] systemd[1]: Reached target Reactivate sysinit units.2709machine # [ 96.531584] systemd[1]: Reached target Local File Systems.2710machine # [ 96.534132] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2711machine # [ 96.535555] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2712machine # [ 96.538506] systemd[1]: Reached target Remote File Systems.2713machine # [ 96.543199] systemd[1]: Starting linger-users.service...2714machine # [ 96.553456] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2715machine # [ 96.560839] systemd[1]: Starting Create SUID/SGID Wrappers...2716machine # [ 96.561727] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2717machine # [ 96.562963] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672718machine # [ 96.574573] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2719machine # [ 96.579473] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2720machine # [ 96.581258] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2721machine # [ 96.615534] systemd[1]: linger-users.service: Deactivated successfully.2722machine # [ 96.618979] systemd[1]: Finished linger-users.service.2723machine # [ 96.747827] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2724machine # [ 96.750279] systemd[1]: Finished Create SUID/SGID Wrappers.2725machine # [ 97.005764] nixos[6607]: finished switching to system configuration /nix/store/ha9xbsxa2rlcsk3y16bgpf9yzsrw7zhp-nixos-system-machine-test2726machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.65 seconds)2727(finished: subtest: unit file parser, in 23.12 seconds)2728subtest: restart and reload by activation script2729machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&12730machine # [ 97.213634] nixos[6747]: switching to system configuration /nix/store/gbzii7acndhl9mz38gzyd7ly15azvhxm-nixos-system-machine-test2731machine # [ 97.216308] systemd[1]: Stopped target Remote File Systems.2732machine # [ 97.218561] systemd[1]: Stopped target Local File Systems.2733machine # [ 97.471420] systemd[1]: Reload requested from client PID 6747 ('.switch-to-conf') (unit backdoor.service)...2734machine # [ 97.473719] systemd[1]: Reloading...2735machine # [ 97.761473] systemd[1]: Reloading finished in 285 ms.2736machine # [ 97.845806] systemd[589]: Reexecution requested from client PID 6816 ('switch-to-confi')...2737machine # [ 97.849541] systemd[589]: Reexecuting.2738machine # [ 97.907074] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2739machine # [ 98.015109] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2740machine # [ 98.021913] systemd[589]: Reload requested from client PID 6816 ('switch-to-confi')...2741machine # [ 98.025931] systemd[589]: Reloading...2742machine # [ 98.124724] systemd[589]: Reloading finished in 100 ms.2743machine # [ 98.140135] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2744machine # [ 98.148688] systemd[589]: Stopped Run user-specific NixOS activation.2745machine # [ 98.150777] systemd[589]: Stopping Run user-specific NixOS activation...2746machine # [ 98.152840] systemd[589]: Starting Run user-specific NixOS activation...2747machine # [ 98.181688] systemd[589]: Finished Run user-specific NixOS activation.2748machine # [ 98.185458] systemd[1]: Stopped target Reactivate sysinit units.2749machine # [ 98.187589] systemd[1]: Stopping Reactivate sysinit units...2750machine # [ 98.190207] systemd[1]: Reached target Reactivate sysinit units.2751machine # [ 98.191082] systemd[1]: Reached target Local File Systems.2752machine # [ 98.194083] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2753machine # [ 98.198732] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2754machine # [ 98.201034] systemd[1]: Reached target Remote File Systems.2755machine # [ 98.204062] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2756machine # [ 98.209628] systemd[1]: Starting Create SUID/SGID Wrappers...2757machine # [ 98.210542] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2758machine # [ 98.211836] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672759machine # [ 98.220218] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2760machine # [ 98.221834] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2761machine # [ 98.223079] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2762machine # [ 98.373502] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2763machine # [ 98.376535] systemd[1]: Finished Create SUID/SGID Wrappers.2764machine # [ 98.379560] systemd[1]: Starting linger-users.service...2765machine # [ 98.417357] systemd[1]: linger-users.service: Deactivated successfully.2766machine # [ 98.419862] systemd[1]: Finished linger-users.service.2767machine # [ 98.674858] nixos[6747]: finished switching to system configuration /nix/store/gbzii7acndhl9mz38gzyd7ly15azvhxm-nixos-system-machine-test2768machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.67 seconds)2769machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12770machine # [ 98.891099] nixos[6887]: switching to system configuration /nix/store/hliaz6k7vl55m0psgk6vn1m7gslyqdn5-nixos-system-machine-test2771machine # [ 98.893746] systemd[1]: test.service: Deactivated successfully.2772machine # [ 98.897133] systemd[1]: Stopped test.service.2773machine # [ 98.898367] systemd[1]: Stopped target Local File Systems.2774machine # [ 98.899167] systemd[1]: Stopped target Remote File Systems.2775machine # [ 99.168363] systemd[1]: Reload requested from client PID 6887 ('.switch-to-conf') (unit backdoor.service)...2776machine # [ 99.170244] systemd[1]: Reloading...2777machine # [ 99.474624] systemd[1]: Reloading finished in 302 ms.2778machine # [ 99.559097] systemd[589]: Reexecution requested from client PID 6958 ('switch-to-confi')...2779machine # [ 99.561222] systemd[589]: Reexecuting.2780machine # [ 99.623790] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2781machine # [ 99.734874] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2782machine # [ 99.741472] systemd[589]: Reload requested from client PID 6958 ('switch-to-confi')...2783machine # [ 99.744848] systemd[589]: Reloading...2784machine # [ 99.844909] systemd[589]: Reloading finished in 100 ms.2785machine # [ 99.860133] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2786machine # [ 99.869180] systemd[589]: Stopped Run user-specific NixOS activation.2787machine # [ 99.871365] systemd[589]: Stopping Run user-specific NixOS activation...2788machine # [ 99.873332] systemd[589]: Starting Run user-specific NixOS activation...2789machine # [ 99.901616] systemd[589]: Finished Run user-specific NixOS activation.2790machine # [ 99.905391] systemd[1]: Stopped target Reactivate sysinit units.2791machine # [ 99.906777] systemd[1]: Stopping Reactivate sysinit units...2792machine # [ 99.907700] systemd[1]: Reached target Reactivate sysinit units.2793machine # [ 99.915840] systemd[1]: Created slice Slice /system/templated-no-restart-service.2794machine # [ 99.918890] systemd[1]: Reached target Local File Systems.2795machine # [ 99.920836] systemd[1]: Starting templated-no-restart-service@instance.service...2796machine # [ 99.925991] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2797machine # [ 99.936390] systemd[1]: Starting Create SUID/SGID Wrappers...2798machine # [ 99.937297] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2799machine # [ 99.938563] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672800machine # [ 99.945423] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2801machine # [ 99.947042] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2802machine # [ 99.957969] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2803machine # [ 99.959247] systemd[1]: Reached target Remote File Systems.2804machine # [ 99.965128] systemd[1]: Created slice Slice /system/templated-reload-triggers.2805machine # [ 99.969270] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart.2806machine # [ 99.983104] systemd[1]: Created slice Slice /system/templated-simple-restart-service.2807machine # [ 99.992738] systemd[1]: Created slice Slice /system/templated-simple-reload-service.2808machine # [ 99.997994] systemd[1]: Created slice Slice /system/templated-simple-service.2809machine # [ 100.006226] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2810machine # [ 100.010818] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2811machine # [ 100.016812] systemd[1]: Finished templated-no-restart-service@instance.service.2812machine # [ 100.017873] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as.2813machine # [ 100.150696] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2814machine # [ 100.155082] systemd[1]: Finished Create SUID/SGID Wrappers.2815machine # [ 100.158140] systemd[1]: Starting linger-users.service...2816machine # [ 100.162117] systemd[1]: Starting no-restart-service.service...2817machine # [ 100.174422] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2818machine # [ 100.175515] systemd[1]: Starting reload-triggers-and-restart.service...2819machine # [ 100.188283] systemd[1]: Starting reload-triggers.service...2820machine # [ 100.195033] systemd[1]: Starting simple-reload-service.service...2821machine # [ 100.204084] systemd[1]: Starting simple-restart-service.service...2822machine # [ 100.219772] systemd[1]: Starting simple-service.service...2823machine # [ 100.239473] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2824machine # [ 100.276577] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2825machine # [ 100.293513] systemd[1]: Starting templated-reload-triggers@instance.service...2826machine # [ 100.294632] systemd[1]: Starting templated-simple-reload-service@instance.service...2827machine # [ 100.322650] systemd[1]: Starting templated-simple-restart-service@instance.service...2828machine # [ 100.348313] systemd[1]: Starting templated-simple-service@instance.service...2829machine # [ 100.386218] systemd[1]: Finished no-restart-service.service.2830machine # [ 100.404336] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2831machine # [ 100.420774] systemd[1]: Finished reload-triggers.service.2832machine # [ 100.434212] systemd[1]: Finished reload-triggers-and-restart.service.2833machine # [ 100.446072] systemd[1]: Finished simple-reload-service.service.2834machine # [ 100.447090] systemd[1]: Finished simple-restart-service.service.2835machine # [ 100.455795] systemd[1]: Finished simple-service.service.2836machine # [ 100.458872] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2837machine # [ 100.462149] systemd[1]: Finished templated-simple-restart-service@instance.service.2838machine # [ 100.463270] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2839machine # [ 100.467382] systemd[1]: Finished templated-simple-reload-service@instance.service.2840machine # [ 100.469707] systemd[1]: Finished templated-reload-triggers@instance.service.2841machine # [ 100.470761] systemd[1]: Finished templated-simple-service@instance.service.2842machine # [ 100.474811] systemd[1]: linger-users.service: Deactivated successfully.2843machine # [ 100.475854] systemd[1]: Finished linger-users.service.2844machine # [ 100.729532] nixos[6887]: finished switching to system configuration /nix/store/hliaz6k7vl55m0psgk6vn1m7gslyqdn5-nixos-system-machine-test2845machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.05 seconds)2846machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12847machine # [ 100.974220] nixos[7057]: switching to system configuration /nix/store/hliaz6k7vl55m0psgk6vn1m7gslyqdn5-nixos-system-machine-test2848machine # [ 100.976747] systemd[1]: Stopped target Local File Systems.2849machine # [ 100.979371] systemd[1]: Stopped target Remote File Systems.2850machine # [ 101.244673] systemd[1]: Reload requested from client PID 7057 ('.switch-to-conf') (unit backdoor.service)...2851machine # [ 101.246586] systemd[1]: Reloading...2852machine # [ 101.550543] systemd[1]: Reloading finished in 302 ms.2853machine # [ 101.640157] systemd[589]: Reexecution requested from client PID 7128 ('switch-to-confi')...2854machine # [ 101.641556] systemd[589]: Reexecuting.2855machine # [ 101.699724] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2856machine # [ 101.808788] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2857machine # [ 101.815129] systemd[589]: Reload requested from client PID 7128 ('switch-to-confi')...2858machine # [ 101.817192] systemd[589]: Reloading...2859machine # [ 101.917022] systemd[589]: Reloading finished in 99 ms.2860machine # [ 101.932130] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2861machine # [ 101.941824] systemd[589]: Stopped Run user-specific NixOS activation.2862machine # [ 101.942813] systemd[589]: Stopping Run user-specific NixOS activation...2863machine # [ 101.945526] systemd[589]: Starting Run user-specific NixOS activation...2864machine # [ 101.972900] systemd[589]: Finished Run user-specific NixOS activation.2865machine # [ 101.976531] systemd[1]: Stopped target Reactivate sysinit units.2866machine # [ 101.978994] systemd[1]: Stopping Reactivate sysinit units...2867machine # [ 101.979885] systemd[1]: Reached target Reactivate sysinit units.2868machine # [ 101.984703] systemd[1]: Reloading reload-triggers-and-restart.service...2869machine # [ 101.989559] systemd[1]: Reloading reload-triggers.service...2870machine # [ 102.000589] systemd[1]: Reloading simple-reload-service.service...2871machine # [ 102.009085] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service...2872machine # [ 102.010301] systemd[1]: Reloading templated-reload-triggers@instance.service...2873machine # [ 102.025020] systemd[1]: Reloading templated-simple-reload-service@instance.service...2874machine # [ 102.085324] systemd[1]: Reloaded reload-triggers.service.2875machine # [ 102.091062] systemd[1]: Reloaded simple-reload-service.service.2876machine # [ 102.096691] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service.2877machine # [ 102.098553] systemd[1]: Reloaded reload-triggers-and-restart.service.2878machine # [ 102.099592] systemd[1]: Reloaded templated-reload-triggers@instance.service.2879machine # [ 102.103221] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2880machine # [ 102.108556] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2881machine # [ 102.109724] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2882machine # [ 102.110688] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2883machine # [ 102.116654] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2884machine # [ 102.121963] systemd[1]: simple-restart-service.service: Deactivated successfully.2885machine # [ 102.123063] systemd[1]: Stopped simple-restart-service.service.2886machine # [ 102.123998] systemd[1]: Stopping simple-restart-service.service...2887machine # [ 102.129098] systemd[1]: Starting simple-restart-service.service...2888machine # [ 102.129983] systemd[1]: simple-service.service: Deactivated successfully.2889machine # [ 102.130908] systemd[1]: Stopped simple-service.service.2890machine # [ 102.131721] systemd[1]: Stopping simple-service.service...2891machine # [ 102.140191] systemd[1]: Starting simple-service.service...2892machine # [ 102.141089] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2893machine # [ 102.142572] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2894machine # [ 102.143828] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2895machine # [ 102.161072] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2896machine # [ 102.162312] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2897machine # [ 102.163608] systemd[1]: Stopped templated-simple-restart-service@instance.service.2898machine # [ 102.184891] systemd[1]: Stopping templated-simple-restart-service@instance.service...2899machine # [ 102.195541] systemd[1]: Starting templated-simple-restart-service@instance.service...2900machine # [ 102.210830] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2901machine # [ 102.219422] systemd[1]: Stopped templated-simple-service@instance.service.2902machine # [ 102.227149] systemd[1]: Stopping templated-simple-service@instance.service...2903machine # [ 102.236221] systemd[1]: Starting templated-simple-service@instance.service...2904machine # [ 102.237259] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2905machine # [ 102.238216] systemd[1]: Finished simple-restart-service.service.2906machine # [ 102.245216] systemd[1]: Finished simple-service.service.2907machine # [ 102.249980] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2908machine # [ 102.251293] systemd[1]: Finished templated-simple-restart-service@instance.service.2909machine # [ 102.254612] systemd[1]: Finished templated-simple-service@instance.service.2910machine # [ 102.260905] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2911machine # [ 102.262285] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2912machine # [ 102.266933] systemd[1]: Reached target Local File Systems.2913machine # [ 102.273357] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2914machine # [ 102.274952] systemd[1]: Starting Create SUID/SGID Wrappers...2915machine # [ 102.275837] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2916machine # [ 102.285482] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672917machine # [ 102.287747] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2918machine # [ 102.289573] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2919machine # [ 102.290853] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2920machine # [ 102.292224] systemd[1]: Reached target Remote File Systems.2921machine # [ 102.438924] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2922machine # [ 102.443592] systemd[1]: Finished Create SUID/SGID Wrappers.2923machine # [ 102.446026] systemd[1]: Starting linger-users.service...2924machine # [ 102.482757] systemd[1]: linger-users.service: Deactivated successfully.2925machine # [ 102.485581] systemd[1]: Finished linger-users.service.2926machine # [ 102.741689] nixos[7057]: finished switching to system configuration /nix/store/hliaz6k7vl55m0psgk6vn1m7gslyqdn5-nixos-system-machine-test2927machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.01 seconds)2928machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&12929machine # [ 103.002036] nixos[7223]: switching to system configuration /nix/store/z22nydczhynsypv60wfnziwiw5rh7r9b-nixos-system-machine-test2930machine # [ 103.004791] systemd[1]: Stopped target Local File Systems.2931machine # [ 103.007141] systemd[1]: Stopped target Remote File Systems.2932machine # [ 103.287612] systemd[1]: Reload requested from client PID 7223 ('.switch-to-conf') (unit backdoor.service)...2933machine # [ 103.289610] systemd[1]: Reloading...2934machine # [ 103.605729] systemd[1]: Reloading finished in 313 ms.2935machine # [ 103.691906] systemd[589]: Reexecution requested from client PID 7294 ('switch-to-confi')...2936machine # [ 103.693945] systemd[589]: Reexecuting.2937machine # [ 103.755966] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2938machine # [ 103.867677] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2939machine # [ 103.874157] systemd[589]: Reload requested from client PID 7294 ('switch-to-confi')...2940machine # [ 103.877307] systemd[589]: Reloading...2941machine # [ 103.975167] systemd[589]: Reloading finished in 98 ms.2942machine # [ 103.992147] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2943machine # [ 104.001145] systemd[589]: Stopped Run user-specific NixOS activation.2944machine # [ 104.003406] systemd[589]: Stopping Run user-specific NixOS activation...2945machine # [ 104.005545] systemd[589]: Starting Run user-specific NixOS activation...2946machine # [ 104.033420] systemd[589]: Finished Run user-specific NixOS activation.2947machine # [ 104.037027] systemd[1]: Stopped target Reactivate sysinit units.2948machine # [ 104.041799] systemd[1]: Stopping Reactivate sysinit units...2949machine # [ 104.042699] systemd[1]: Reached target Reactivate sysinit units.2950machine # [ 104.047194] systemd[1]: Reloading reload-triggers.service...2951machine # [ 104.052630] systemd[1]: Reloading simple-reload-service.service...2952machine # [ 104.061307] systemd[1]: Reloading templated-reload-triggers@instance.service...2953machine # [ 104.062378] systemd[1]: Reloading templated-simple-reload-service@instance.service...2954machine # [ 104.121405] systemd[1]: Reloaded reload-triggers.service.2955machine # [ 104.123531] systemd[1]: Reloaded simple-reload-service.service.2956machine # [ 104.126634] systemd[1]: Reloaded templated-reload-triggers@instance.service.2957machine # [ 104.127662] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2958machine # [ 104.132726] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2959machine # [ 104.133920] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2960machine # [ 104.134874] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2961machine # [ 104.137895] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2962machine # [ 104.141600] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully.2963machine # [ 104.142745] systemd[1]: Stopped reload-triggers-and-restart.service.2964machine # [ 104.143690] systemd[1]: Stopping reload-triggers-and-restart.service...2965machine # [ 104.161534] systemd[1]: Starting reload-triggers-and-restart.service...2966machine # [ 104.162490] systemd[1]: simple-restart-service.service: Deactivated successfully.2967machine # [ 104.163652] systemd[1]: Stopped simple-restart-service.service.2968machine # [ 104.180748] systemd[1]: Stopping simple-restart-service.service...2969machine # [ 104.181675] systemd[1]: Starting simple-restart-service.service...2970machine # [ 104.182690] systemd[1]: simple-service.service: Deactivated successfully.2971machine # [ 104.183659] systemd[1]: Stopped simple-service.service.2972machine # [ 104.220428] systemd[1]: Stopping simple-service.service...2973machine # [ 104.221291] systemd[1]: Starting simple-service.service...2974machine # [ 104.235721] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2975machine # [ 104.252517] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2976machine # [ 104.253909] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2977machine # [ 104.255282] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2978machine # [ 104.288597] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully.2979machine # [ 104.296818] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service.2980machine # [ 104.298127] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service...2981machine # [ 104.299344] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2982machine # [ 104.307053] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2983machine # [ 104.309277] systemd[1]: Stopped templated-simple-restart-service@instance.service.2984machine # [ 104.310348] systemd[1]: Stopping templated-simple-restart-service@instance.service...2985machine # [ 104.311418] systemd[1]: Starting templated-simple-restart-service@instance.service...2986machine # [ 104.318941] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2987machine # [ 104.322256] systemd[1]: Stopped templated-simple-service@instance.service.2988machine # [ 104.323338] systemd[1]: Stopping templated-simple-service@instance.service...2989machine # [ 104.325013] systemd[1]: Starting templated-simple-service@instance.service...2990machine # [ 104.326009] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2991machine # [ 104.326959] systemd[1]: Finished simple-restart-service.service.2992machine # [ 104.327812] systemd[1]: Finished reload-triggers-and-restart.service.2993machine # [ 104.339611] systemd[1]: Finished simple-service.service.2994machine # [ 104.347420] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2995machine # [ 104.348750] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2996machine # [ 104.349849] systemd[1]: Finished templated-simple-restart-service@instance.service.2997machine # [ 104.350912] systemd[1]: Finished templated-simple-service@instance.service.2998machine # [ 104.351889] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2999machine # [ 104.353997] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki3000machine # [ 104.355372] systemd[1]: Reached target Remote File Systems.3001machine # [ 104.356238] systemd[1]: Reached target Local File Systems.3002machine # [ 104.357024] systemd[1]: Starting linger-users.service...3003machine # [ 104.357781] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore3004machine # [ 104.359255] systemd[1]: Starting Create SUID/SGID Wrappers...3005machine # [ 104.365804] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.3006machine # [ 104.367092] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc673007machine # [ 104.376412] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore3008machine # [ 104.378138] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3009machine # [ 104.379473] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3010machine # [ 104.417161] systemd[1]: linger-users.service: Deactivated successfully.3011machine # [ 104.418139] systemd[1]: Finished linger-users.service.3012machine # [ 104.537011] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.3013machine # [ 104.540148] systemd[1]: Finished Create SUID/SGID Wrappers.3014machine # [ 104.794349] nixos[7223]: finished switching to system configuration /nix/store/z22nydczhynsypv60wfnziwiw5rh7r9b-nixos-system-machine-test3015machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.05 seconds)3016machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&13017machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.34 seconds)3018(finished: subtest: restart and reload by activation script, in 8.13 seconds)3019(finished: run the VM test script, in 105.91 seconds)3020test script finished in 105.95s3021cleanup3022kill QemuMachine (pid 45)3023machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14)3024machine # [2026-10-18T02:45:12Z INFO virtiofsd] Client disconnected, shutting down3025machine # [2026-10-18T02:45:12Z INFO virtiofsd] Client disconnected, shutting down3026machine # [2026-10-18T02:45:12Z INFO virtiofsd] Client disconnected, shutting down3027(finished: cleanup, in 0.16 seconds)3028additionally exposed symbols:3029 machine, other,3030 vlan1,3031 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