vm-test-run-switch-test-services
checks.aarch64-linux.switchTest
· build #37
· raw
1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7machine: waiting for unit multi-user.target8machine: waiting for the VM to finish booting9machine: starting vm10machine: QEMU running (pid 45)11machine # Disk image does not exist, creating the virtualisation disk image...12machine # Formatting '/build/vm-state-machine/tmp.wqExF0sBwm', 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: e516168d-bc38-4009-9518-f0c8771e8f6b17machine # Superblock backups stored on blocks:18machine # 32768, 98304, 163840, 22937619machine # 20machine # Allocating group tables: 0/8 done21machine # Writing inode tables: 0/8 done22machine # Creating journal (8192 blocks): done23machine # Writing superblocks and filesystem accounting information: 0/8 done24machine # 25machine # Virtualisation disk image created.26machine # Starting virtiofs daemons...27machine # [2026-09-15T21:17:39Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)28machine # [2026-09-15T21:17:39Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether29machine # [2026-09-15T21:17:39Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)30machine # [2026-09-15T21:17:39Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether31machine # [2026-09-15T21:17:39Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)32machine # [2026-09-15T21:17:39Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether33machine # [2026-09-15T21:17:39Z INFO virtiofsd] Waiting for vhost-user socket connection...34machine # [2026-09-15T21:17:39Z INFO virtiofsd] Waiting for vhost-user socket connection...35machine # [2026-09-15T21:17:39Z INFO virtiofsd] Waiting for vhost-user socket connection...36machine # [2026-09-15T21:17:39Z INFO virtiofsd] Client connected, servicing requests37machine # [2026-09-15T21:17:39Z INFO virtiofsd] Client connected, servicing requests38machine # [2026-09-15T21:17:39Z INFO virtiofsd] Client connected, servicing requests39machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]40machine # [ 0.000000] Linux version 6.18.51 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 11 09:49:46 UTC 202641machine # [ 0.000000] KASLR enabled42machine # [ 0.000000] random: crng init done43machine # [ 0.000000] Machine model: linux,dummy-virt44machine # [ 0.000000] efi: UEFI not found.45machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT46machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]47machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f]48machine # [ 0.000000] Zone ranges:49machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]50machine # [ 0.000000] DMA32 empty51machine # [ 0.000000] Normal empty52machine # [ 0.000000] Device empty53machine # [ 0.000000] Movable zone start for each node54machine # [ 0.000000] Early memory node ranges55machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]56machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]57machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc0000058machine # [ 0.000000] psci: probing for conduit method from DT.59machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.60machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs61machine # [ 0.000000] psci: Trusted OS migration not required62machine # [ 0.000000] psci: SMC Calling Convention v1.163machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)64machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 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/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/init regInfo=/nix/store/g3m283rd6cqyliafsdkby9nqsalry0c4-closure-info/registration console=ttyAMA0,115200n8 console=tty074machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/g3m283rd6cqyliafsdkby9nqsalry0c4-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 74894 entries in 294 pages88machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups89machine # [ 0.000000] rcu: Hierarchical RCU implementation.90machine # [ 0.000000] rcu: RCU event tracing is enabled.91machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.92machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.93machine # [ 0.000000] Rude variant of Tasks RCU enabled.94machine # [ 0.000000] Tracing variant of Tasks RCU enabled.95machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.96machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=197machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.98machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.99machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.100machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0101machine # [ 0.000000] GICv3: 256 SPIs implemented102machine # [ 0.000000] GICv3: 0 Extended SPIs implemented103machine # [ 0.000000] Root IRQ handler: gic_handle_irq104machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI105machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0106machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000107machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]108machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)109machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)110machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000111machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000112machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.113machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns114machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).115machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns116machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns117machine # [ 0.000029] arm-pv: using stolen time PV118machine # [ 0.000396] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)119machine # [ 0.000601] Console: colour dummy device 80x25120machine # [ 0.000609] printk: legacy console [tty0] enabled121machine # [ 0.000808] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)122machine # [ 0.000816] pid_max: default: 32768 minimum: 301123machine # [ 0.000902] LSM: initializing lsm=capability,landlock,yama,bpf,ima124machine # [ 0.001047] landlock: Up and running.125machine # [ 0.001050] Yama: becoming mindful.126machine # [ 0.001560] LSM support for eBPF active127machine # [ 0.001691] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)128machine # [ 0.001736] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)129machine # [ 0.002931] cacheinfo: Unable to detect cache hierarchy for CPU 0130machine # [ 0.003706] rcu: Hierarchical SRCU implementation.131machine # [ 0.003711] rcu: Max phase no-delay instances is 1000.132machine # [ 0.004977] fsl-mc MSI: its@8080000 domain created133machine # [ 0.005070] EFI services will not be available.134machine # [ 0.005142] smp: Bringing up secondary CPUs ...135machine # [ 0.005151] smp: Brought up 1 node, 1 CPU136machine # [ 0.005154] SMP: Total of 1 processors activated.137machine # [ 0.005157] CPU: All CPU(s) started at EL1138machine # [ 0.005171] CPU features: detected: Branch Target Identification139machine # [ 0.005176] CPU features: detected: ARMv8.4 Translation Table Level140machine # [ 0.005179] CPU features: detected: Instruction cache invalidation not required for I/D coherence141machine # [ 0.005183] CPU features: detected: Data cache clean to the PoU not required for I/D coherence142machine # [ 0.005187] CPU features: detected: Common not Private translations143machine # [ 0.005190] CPU features: detected: CRC32 instructions144machine # [ 0.005193] CPU features: detected: Data cache clean to Point of Deep Persistence145machine # [ 0.005196] CPU features: detected: Data cache clean to Point of Persistence146machine # [ 0.005199] CPU features: detected: Data independent timing control (DIT)147machine # [ 0.005202] CPU features: detected: E0PD148machine # [ 0.005205] CPU features: detected: Enhanced Counter Virtualization149machine # [ 0.005208] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)150machine # [ 0.005211] CPU features: detected: Enhanced Virtualization Traps151machine # [ 0.005214] CPU features: detected: Fine Grained Traps152machine # [ 0.005218] CPU features: detected: Generic authentication (architected QARMA5 algorithm)153machine # [ 0.005223] CPU features: detected: RCpc load-acquire (LDAPR)154machine # [ 0.005226] CPU features: detected: LSE atomic instructions155machine # [ 0.005229] CPU features: detected: Privileged Access Never156machine # [ 0.005232] CPU features: detected: PMUv3157machine # [ 0.005235] CPU features: detected: RAS Extension Support158machine # [ 0.005238] CPU features: detected: RASv1p1 Extension Support159machine # [ 0.005240] CPU features: detected: Random Number Generator160machine # [ 0.005243] CPU features: detected: Speculation barrier (SB)161machine # [ 0.005245] CPU features: detected: Stage-2 Force Write-Back162machine # [ 0.005249] CPU features: detected: TLB range maintenance instructions163machine # [ 0.005254] CPU features: detected: Speculative Store Bypassing Safe (SSBS)164machine # [ 0.005293] alternatives: applying system-wide alternatives165machine # [ 0.008351] CPU features: detected: BBM Level 2 without TLB conflict abort166machine # [ 0.008591] Memory: 893784K/1048576K available (24448K kernel code, 7090K rwdata, 26360K rodata, 4736K init, 1107K bss, 113268K reserved, 32768K cma-reserved)167machine # [ 0.008936] devtmpfs: initialized168machine # [ 0.010712] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)169machine # [ 0.010734] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).170machine # [ 0.010925] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL171machine # [ 0.010929] 0 pages in range for non-PLT usage172machine # [ 0.010930] 508288 pages in range for PLT usage173machine # [ 0.011028] pinctrl core: initialized pinctrl subsystem174machine # [ 0.011776] DMI not present or invalid.175machine # [ 0.014972] NET: Registered PF_NETLINK/PF_ROUTE protocol family176machine # [ 0.017440] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations177machine # [ 0.017593] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations178machine # [ 0.017770] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations179machine # [ 0.017796] audit: initializing netlink subsys (disabled)180machine # [ 0.018397] thermal_sys: Registered thermal governor 'fair_share'181machine # [ 0.018399] thermal_sys: Registered thermal governor 'bang_bang'182machine # [ 0.018402] thermal_sys: Registered thermal governor 'step_wise'183machine # [ 0.018405] thermal_sys: Registered thermal governor 'user_space'184machine # [ 0.018410] thermal_sys: Registered thermal governor 'power_allocator'185machine # [ 0.018435] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1186machine # [ 0.018443] cpuidle: using governor ladder187machine # [ 0.018449] cpuidle: using governor menu188machine # [ 0.018641] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.189machine # [ 0.018658] ASID allocator initialised with 65536 entries190machine # [ 0.019749] Serial: AMBA PL011 UART driver191machine # [ 0.024918] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1192machine # [ 0.025081] printk: console [ttyAMA0] enabled193machine # [ 0.151305] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages194machine # [ 0.151328] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page195machine # [ 0.151334] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages196machine # [ 0.151339] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page197machine # [ 0.151343] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages198machine # [ 0.151347] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page199machine # [ 0.151352] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages200machine # [ 0.151356] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page201machine # [ 0.159078] fbcon: Taking over console202machine # [ 0.159094] ACPI: Interpreter disabled.203machine # [ 0.160999] iommu: Default domain type: Translated204machine # [ 0.161011] iommu: DMA domain TLB invalidation policy: strict mode205machine # [ 0.162776] SCSI subsystem initialized206machine # [ 0.170431] usbcore: registered new interface driver usbfs207machine # [ 0.170462] usbcore: registered new interface driver hub208machine # [ 0.170480] usbcore: registered new device driver usb209machine # [ 0.170752] pps_core: LinuxPPS API ver. 1 registered210machine # [ 0.170759] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>211machine # [ 0.170783] PTP clock support registered212machine # [ 0.170845] EDAC MC: Ver: 3.0.0213machine # [ 0.175594] scmi_core: SCMI protocol bus registered214machine # [ 0.176579] FPGA manager framework215machine # [ 0.177567] vgaarb: loaded216machine # [ 0.178239] clocksource: Switched to clocksource arch_sys_counter217machine # [ 0.178899] VFS: Disk quotas dquot_6.6.0218machine # [ 0.178933] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)219machine # [ 0.181414] netfs: FS-Cache loaded220machine # [ 0.181517] pnp: PnP ACPI: disabled221machine # [ 0.187805] NET: Registered PF_INET protocol family222machine # [ 0.187977] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)223machine # [ 0.218183] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)224machine # [ 0.218231] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)225machine # [ 0.220450] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)226machine # [ 0.220498] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)227machine # [ 0.220573] TCP: Hash tables configured (established 8192 bind 8192)228machine # [ 0.220659] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)229machine # [ 0.220716] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)230machine # [ 0.220769] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)231machine # [ 0.220873] NET: Registered PF_UNIX/PF_LOCAL protocol family232machine # [ 0.220894] NET: Registered PF_XDP protocol family233machine # [ 0.220916] PCI: CLS 0 bytes, default 64234machine # [ 0.221173] Trying to unpack rootfs image as initramfs...235machine # [ 0.238272] kvm [1]: HYP mode not available236machine # [ 0.335011] Initialise system trusted keyrings237machine # [ 0.335793] workingset: timestamp_bits=42 max_order=18 bucket_order=0238machine # [ 0.337031] squashfs: version 4.0 (2009/01/31) Phillip Lougher239machine # [ 0.337864] 9p: Installing v9fs 9p2000 file system support240machine # [ 0.366619] Key type asymmetric registered241machine # [ 0.366649] Asymmetric key parser 'x509' registered242machine # [ 0.366726] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)243machine # [ 0.368894] io scheduler mq-deadline registered244machine # [ 0.368905] io scheduler kyber registered245machine # [ 0.378478] pl061_gpio 9030000.pl061: PL061 GPIO chip registered246machine # [ 0.379864] ledtrig-cpu: registered to indicate activity on CPUs247machine # [ 0.380264] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:248machine # [ 0.380282] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000249machine # [ 0.380295] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000250machine # [ 0.380303] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000251machine # [ 0.380324] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits252machine # [ 0.380348] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]253machine # [ 0.380429] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00254machine # [ 0.380438] pci_bus 0000:00: root bus resource [bus 00-ff]255machine # [ 0.380444] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]256machine # [ 0.380449] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]257machine # [ 0.380454] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]258machine # [ 0.380510] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint259machine # [ 0.380950] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint260machine # [ 0.381137] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]261machine # [ 0.381154] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]262machine # [ 0.381184] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]263machine # [ 0.381201] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]264machine # [ 0.381667] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint265machine # [ 0.381868] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]266machine # [ 0.381885] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]267machine # [ 0.381916] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]268machine # [ 0.401995] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint269machine # [ 0.402186] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]270machine # [ 0.402205] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]271machine # [ 0.402235] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]272machine # [ 0.410823] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint273machine # [ 0.411039] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]274machine # [ 0.411057] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]275machine # [ 0.411086] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]276machine # [ 0.411107] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]277machine # [ 0.411553] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint278machine # [ 0.411742] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]279machine # [ 0.411772] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]280machine # [ 0.412217] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint281machine # [ 0.412405] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]282machine # [ 0.412436] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]283machine # [ 0.412829] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint284machine # [ 0.413014] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]285machine # [ 0.413269] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint286machine # [ 0.413457] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]287machine # [ 0.413487] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]288machine # [ 0.413943] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint289machine # [ 0.414126] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]290machine # [ 0.414157] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]291machine # [ 0.430568] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint292machine # [ 0.430755] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]293machine # [ 0.430786] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]294machine # [ 0.431235] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint295machine # [ 0.431536] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]296machine # [ 0.431554] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]297machine # [ 0.431583] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]298machine # [ 0.432042] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint299machine # [ 0.432221] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]300machine # [ 0.432238] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]301machine # [ 0.432268] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]302machine # [ 0.432871] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned303machine # [ 0.432883] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned304machine # [ 0.432889] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned305machine # [ 0.432934] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned306machine # [ 0.432982] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned307machine # [ 0.433030] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned308machine # [ 0.433077] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned309machine # [ 0.433124] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned310machine # [ 0.433171] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned311machine # [ 0.433218] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned312machine # [ 0.433266] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned313machine # [ 0.433312] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned314machine # [ 0.433398] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned315machine # [ 0.433444] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned316machine # [ 0.433467] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned317machine # [ 0.433490] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned318machine # [ 0.433512] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned319machine # [ 0.433535] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned320machine # [ 0.433558] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned321machine # [ 0.433580] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned322machine # [ 0.433604] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned323machine # [ 0.433630] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned324machine # [ 0.433653] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned325machine # [ 0.433676] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned326machine # [ 0.433712] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned327machine # [ 0.433736] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned328machine # [ 0.433758] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned329machine # [ 0.433780] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned330machine # [ 0.433805] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned331machine # [ 0.433827] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned332machine # [ 0.433850] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned333machine # [ 0.433878] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]334machine # [ 0.433888] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]335machine # [ 0.433893] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]336machine # [ 0.478796] pci 0000:00:07.0: enabling device (0000 -> 0002)337machine # [ 0.504544] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)338machine # [ 0.514526] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)339machine # [ 0.518225] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)340machine # [ 0.520377] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)341machine # [ 0.530466] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)342machine # [ 0.533239] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)343machine # [ 0.543253] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)344machine # [ 0.545215] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)345machine # [ 0.548842] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)346machine # [ 0.555309] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)347machine # [ 0.563383] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)348machine # [ 0.579399] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled349machine # [ 0.581879] msm_serial: driver initialized350machine # [ 0.582030] SuperH (H)SCI(F) driver initialized351machine # [ 0.582083] STM32 USART driver initialized352machine # [ 0.613102] loop: module loaded353machine # [ 0.613299] virtio_blk virtio2: 1/0/0 default/read/poll queues354machine # [ 0.614374] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)355machine # [ 0.626900] megasas: 07.734.00.00-rc1356machine # [ 0.627603] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]357machine # [ 0.629616] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000358machine # [ 0.629644] Intel/Sharp Extended Query Table at 0x0031359machine # [ 0.631407] Using buffer write method360machine # [ 0.631484] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]361machine # [ 0.633462] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000362machine # [ 0.633487] Intel/Sharp Extended Query Table at 0x0031363machine # [ 0.647218] Using buffer write method364machine # [ 0.647246] Concatenating MTD devices:365machine # [ 0.647251] (0): "0.flash"366machine # [ 0.647254] (1): "0.flash"367machine # [ 0.647258] into device "0.flash"368machine # [ 0.916731] Freeing initrd memory: 26408K369machine # [ 0.922996] tun: Universal TUN/TAP device driver, 1.6370machine # [ 0.926983] thunder_xcv, ver 1.0371machine # [ 0.927024] thunder_bgx, ver 1.0372machine # [ 0.927046] nicpf, ver 1.0373machine # [ 0.927610] e1000: Intel(R) PRO/1000 Network Driver374machine # [ 0.927622] e1000: Copyright (c) 1999-2006 Intel Corporation.375machine # [ 0.927651] e1000e: Intel(R) PRO/1000 Network Driver376machine # [ 0.927660] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.377machine # [ 0.927688] igb: Intel(R) Gigabit Ethernet Network Driver378machine # [ 0.927693] igb: Copyright (c) 2007-2014 Intel Corporation.379machine # [ 0.927715] igbvf: Intel(R) Gigabit Virtual Function Network Driver380machine # [ 0.927721] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.381machine # [ 0.927867] sky2: driver version 1.30382machine # [ 0.929547] usbcore: registered new interface driver usb-storage383machine # [ 0.929656] usbcore: registered new interface driver usbserial_generic384machine # [ 0.929673] usbserial: USB Serial support registered for generic385machine # [ 0.931046] ehci-pci 0000:00:07.0: EHCI Host Controller386machine # [ 0.931085] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1387machine # [ 0.931327] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000388machine # [ 0.943285] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00389machine # [ 0.943709] hub 1-0:1.0: USB hub found390machine # [ 0.943735] hub 1-0:1.0: 6 ports detected391machine # [ 0.946068] hv_vmbus: registering driver hyperv_keyboard392machine # [ 0.947757] rtc-pl031 9010000.pl031: registered as rtc0393machine # [ 0.947787] rtc-pl031 9010000.pl031: setting system clock to 2026-09-15T21:17:41 UTC (1789507061)394machine # [ 0.948088] i2c_dev: i2c /dev entries driver395machine # [ 0.953439] sdhci: Secure Digital Host Controller Interface driver396machine # [ 0.953457] sdhci: Copyright(c) Pierre Ossman397machine # [ 0.953730] Synopsys Designware Multimedia Card Interface Driver398machine # [ 0.954093] sdhci-pltfm: SDHCI platform and OF driver helper399machine # [ 0.958535] hid: raw HID events driver (C) Jiri Kosina400machine # [ 0.958770] usbcore: registered new interface driver usbhid401machine # [ 0.958777] usbhid: USB HID core driver402machine # [ 0.961782] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available403machine # [ 0.964515] drop_monitor: Initializing network drop monitor service404machine # [ 0.964682] NET: Registered PF_INET6 protocol family405machine # [ 0.966992] Segment Routing with IPv6406machine # [ 0.967013] In-situ OAM (IOAM) with IPv6407machine # [ 0.967044] NET: Registered PF_PACKET protocol family408machine # [ 0.968728] 9pnet: Installing 9P2000 support409machine # [ 0.968776] Key type dns_resolver registered410machine # [ 0.976118] registered taskstats version 1411machine # [ 0.976271] Loading compiled-in X.509 certificates412machine # [ 0.985471] Demotion targets for Node 0: null413machine # [ 0.985614] Key type .fscrypt registered414machine # [ 0.985627] Key type fscrypt-provisioning registered415machine # [ 0.985753] ima: No TPM chip found, activating TPM-bypass!416machine # [ 0.985773] ima: Allocated hash algorithm: sha1417machine # [ 0.985798] ima: No architecture policies found418machine # [ 0.989998] input: gpio-keys as /devices/platform/gpio-keys/input/input0419machine # [ 1.010140] clk: Disabling unused clocks420machine # [ 1.010174] PM: genpd: Disabling unused power domains421machine # [ 1.014665] Freeing unused kernel memory: 4736K422machine # [ 1.014882] Run /init as init process423machine # [ 1.032641] systemd[1]: Successfully made /usr/ read-only.424machine # [ 1.190325] usb 1-1: new high-speed USB device number 2 using ehci-pci425machine # [ 1.345351] 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/input1426machine # [ 1.367856] systemd[1]: systemd 262-e2c8482 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)427machine # [ 1.380370] systemd[1]: Detected virtualization qemu.428machine # [ 1.382670] systemd[1]: Detected architecture arm64.429machine # [ 1.384650] systemd[1]: Running in initrd.430machine # [ 1.387727] systemd[1]: Initializing machine ID from random generator.431machine # [ 1.391002] systemd[1]: Hostname set to <machine>.432machine # [ 1.438630] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0433machine # [ 1.562306] usb 1-2: new high-speed USB device number 3 using ehci-pci434machine # [ 1.568679] systemd[1]: bpf-restrict-fs: LSM BPF program attached435machine # [ 1.628541] systemd[1]: Queued start job for default target Initrd Default Target.436machine # [ 1.636596] systemd[1]: Created slice Slice /system/modprobe.437machine # [ 1.637720] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.438machine # [ 1.638853] systemd[1]: Expecting device /dev/disk/by-label/nixos...439machine # [ 1.639672] systemd[1]: Reached target Path Units.440machine # [ 1.640297] systemd[1]: Reached target Slice Units.441machine # [ 1.640953] systemd[1]: Reached target Swaps.442machine # [ 1.641625] systemd[1]: Reached target Timer Units.443machine # [ 1.642452] systemd[1]: Listening on D-Bus System Message Bus Socket.444machine # [ 1.643428] systemd[1]: Listening on Journal Socket (/dev/log).445machine # [ 1.644334] systemd[1]: Listening on Journal Sockets.446machine # [ 1.645061] systemd[1]: Listening on udev Kernel Socket.447machine # [ 1.645758] systemd[1]: Reached target Socket Units.448machine # [ 1.647847] systemd[1]: Starting Create List of Static Device Nodes...449machine # [ 1.648816] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs450machine # [ 1.655743] systemd[1]: Mounting Kernel Configuration File System...451machine # [ 1.666745] systemd[1]: Starting Journal Service...452machine # [ 1.686466] systemd[1]: Starting Load Kernel Modules...453machine # [ 1.687346] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os454machine # [ 1.694559] systemd[1]: Starting Coldplug All udev Devices...455machine # [ 1.716753] systemd[1]: Finished Create List of Static Device Nodes.456machine # [ 1.717945] systemd[1]: Mounted Kernel Configuration File System.457machine # [ 1.726867] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...458machine # [ 1.730108] 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/input2459machine # [ 1.732050] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0460machine # [ 1.770951] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.461machine # [ 1.777017] systemd-journald[72]: Collecting audit messages is disabled.462machine # [ 1.790331] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev463machine # [ 1.796888] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0464machine # [ 1.797139] [drm] features: -virgl +edid -resource_blob -host_visible465machine # [ 1.797148] [drm] features: -context_init466machine # [ 1.797961] [drm] number of scanouts: 1467machine # [ 1.797980] [drm] number of cap sets: 0468machine # [ 1.815126] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.469machine # [ 1.822709] systemd[1]: Starting Create Static Device Nodes in /dev...470machine # [ 1.830600] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic471machine # [ 1.830625] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0472machine # [ 1.882317] Console: switching to colour frame buffer device 160x50473machine # [ 1.883037] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device474machine # [ 1.886829] systemd[1]: Finished Create Static Device Nodes in /dev.475machine # [ 1.887112] systemd[1]: Reached target Preparation for Local File Systems.476machine # [ 1.887149] systemd[1]: Reached target Local File Systems.477machine # [ 1.898696] systemd[1]: Starting Rule-based Manager for Device Events and Files...478machine # [ 1.914452] systemd[1]: Finished Load Kernel Modules.479machine # [ 1.922720] systemd[1]: Starting Apply Kernel Variables...480machine # [ 1.951486] systemd-modules-load[73]: Inserted module 'dm_mod'481machine # [ 1.966749] systemd[1]: Started Journal Service.482machine # [ 1.956247] systemd-modules-load[73]: Module 'virtio_balloon' is built in483machine # [ 1.957448] systemd-modules-load[73]: Module 'virtio_console' is built in484machine # [ 1.958626] systemd-modules-load[73]: Inserted module 'virtio_gpu'485machine # [ 1.959666] systemd-modules-load[73]: Module 'virtio_rng' is built in486machine # [ 1.976961] systemd[1]: Starting Create System Files and Directories...487machine # [ 1.989274] systemd[1]: Finished Apply Kernel Variables.488machine # [ 2.015657] systemd-udevd[78]: Using default interface naming scheme 'v261'.489machine # [ 2.034089] systemd[1]: Finished Create System Files and Directories.490machine # [ 2.058654] systemd[1]: Started Rule-based Manager for Device Events and Files.491machine # [ 2.147782] systemd[1]: Starting Virtual Console Setup...492machine # [ 2.232575] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones.493machine # [ 2.237728] systemd[1]: Finished Virtual Console Setup.494machine # [ 2.918119] systemd[1]: Finished Coldplug All udev Devices.495machine # [ 2.919138] systemd[1]: Reached target System Initialization.496machine # [ 2.920008] systemd[1]: Reached target Basic System.497machine # [ 3.098478] (udev-worker)[89]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.498machine # [ 3.113777] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.499machine # [ 3.204668] systemd[1]: Found device /dev/disk/by-label/nixos.500machine # [ 3.207865] systemd[1]: Reached target Initrd Root Device.501machine # [ 3.210775] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...502machine # [ 3.274909] systemd-fsck[109]: nixos: clean, 12/65536 files, 13019/262144 blocks503machine # [ 3.280064] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.504machine # [ 3.290207] systemd[1]: Mounting /sysroot...505machine # [ 3.348410] EXT4-fs (vda): mounted filesystem e516168d-bc38-4009-9518-f0c8771e8f6b r/w with ordered data mode. Quota mode: none.506machine # [ 3.340209] systemd[1]: Mounted /sysroot.507machine # [ 3.342665] systemd[1]: Reached target Initrd Root File System.508machine # [ 3.348183] systemd[1]: Starting Mountpoints Configured in the Real Root...509machine # [ 3.381709] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload.510machine # [ 3.387143] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)...511machine # [ 3.392916] systemd[1]: Reloading...512machine # [ 3.611918] systemd[1]: Reloading finished in 221 ms.513machine # [ 3.648222] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace...514machine # [ 3.652701] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace...515machine # [ 3.657441] systemd[1]: initrd-parse-etc.service: Deactivated successfully.516machine # [ 3.661188] systemd[1]: Finished Mountpoints Configured in the Real Root.517machine # [ 3.664214] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.518machine # [ 3.702325] systemd[1]: Mounting /sysroot/nix/.ro-store...519machine # [ 3.705437] systemd[1]: Mounting /sysroot/nix/.rw-store...520machine # [ 3.725946] systemd[1]: Mounting /sysroot/run...521machine # [ 3.738811] systemd[1]: Mounting /sysroot/tmp/shared...522machine # [ 3.771836] systemd[1]: Mounting /sysroot/tmp/xchg...523machine # [ 3.867130] fuse: init (API version 7.45)524machine # [ 3.862718] systemd[1]: Mounted /sysroot/nix/.rw-store.525machine # [ 3.884983] virtiofs virtio6: discovered new tag: nix-store526machine # [ 3.885875] virtiofs virtio6: virtio_fs_setup_dax: No cache capability527machine # [ 3.873873] systemd[1]: Mounted /sysroot/run.528machine # [ 3.900177] virtiofs virtio7: discovered new tag: shared529machine # [ 3.900990] virtiofs virtio7: virtio_fs_setup_dax: No cache capability530machine # [ 3.907222] virtiofs virtio8: discovered new tag: xchg531machine # [ 3.907987] virtiofs virtio8: virtio_fs_setup_dax: No cache capability532machine # [ 3.895377] systemd[1]: Starting rw-sysroot-nix-store.service...533machine # [ 3.918454] systemd[1]: Mounted /sysroot/nix/.ro-store.534machine # [ 3.924294] systemd[1]: Mounted /sysroot/tmp/shared.535machine # [ 3.930271] systemd[1]: Mounted /sysroot/tmp/xchg.536machine # [ 3.938638] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.537machine # [ 3.940963] systemd[1]: Finished rw-sysroot-nix-store.service.538machine # [ 4.700170] systemd[1]: Mounting /sysroot/nix/store...539machine # [ 4.756112] systemd[1]: Mounted /sysroot/nix/store.540machine # [ 4.757039] systemd[1]: Reached target Initrd File Systems.541machine # [ 4.764261] systemd[1]: Starting Find NixOS closure...542machine # [ 4.769906] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...543machine # [ 4.817953] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.544machine # [ 4.820239] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.545machine # [ 4.840247] systemd[1]: Finished Find NixOS closure.546machine # [ 4.843716] systemd[1]: Reached target Initrd Default Target.547machine # [ 4.855091] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...548machine # [ 4.874757] (udev-worker)[93]: mtd0ro: Failed to find and pin callout binary "/nix/store/yf6qr0y28a50mnhgyrfdk0hmnvgr6c9d-systemd-262-e2c8482/lib/udev/mtd_probe": No such file or directory549machine # [ 4.882501] (udev-worker)[93]: 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 directory550machine # [ 4.906454] systemd[1]: Stopped target Initrd Default Target.551machine # [ 4.909292] systemd[1]: Stopped target Basic System.552machine # [ 4.913525] systemd[1]: Stopped target Initrd Root Device.553machine # [ 4.915395] systemd[1]: Stopped target Path Units.554machine # [ 4.921000] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.555machine # [ 4.924220] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.556machine # [ 4.927608] systemd[1]: Stopped target Slice Units.557machine # [ 4.934132] systemd[1]: Stopped target Socket Units.558machine # [ 4.935014] systemd[1]: Stopped target System Initialization.559machine # [ 4.935917] systemd[1]: Stopped target Swaps.560machine # [ 4.940447] systemd[1]: Stopped target Timer Units.561machine # [ 4.944591] systemd[1]: dbus.socket: Deactivated successfully.562machine # [ 4.946925] systemd[1]: Closed D-Bus System Message Bus Socket.563machine # [ 4.949756] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.564machine # [ 4.955482] systemd[1]: Stopped Find NixOS closure.565machine # [ 4.956723] systemd[1]: Starting rw-sysroot-nix-store.service...566machine # [ 4.968304] systemd[1]: systemd-sysctl.service: Deactivated successfully.567machine # [ 4.969555] systemd[1]: Stopped Apply Kernel Variables.568machine # [ 4.971862] systemd[1]: systemd-modules-load.service: Deactivated successfully.569machine # [ 4.981790] systemd[1]: Stopped Load Kernel Modules.570machine # [ 4.982786] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.571machine # [ 4.989839] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.572machine # [ 4.994316] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.573machine # [ 5.001621] systemd[1]: Stopped Create System Files and Directories.574machine # [ 5.003200] systemd[1]: Stopped target Local File Systems.575machine # [ 5.005069] systemd[1]: Stopped target Preparation for Local File Systems.576machine # [ 5.011091] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.577machine # [ 5.014435] systemd[1]: Stopped Coldplug All udev Devices.578machine # [ 5.015264] systemd[1]: Stopping Rule-based Manager for Device Events and Files...579machine # [ 5.018433] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.580machine # [ 5.024728] systemd[1]: Stopped Virtual Console Setup.581machine # [ 5.025586] systemd[1]: initrd-cleanup.service: Deactivated successfully.582machine # [ 5.026555] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.583machine # [ 5.028252] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.584machine # [ 5.032198] systemd[1]: Finished rw-sysroot-nix-store.service.585machine # [ 5.033151] systemd[1]: Starting Virtual Console Setup...586machine # [ 5.042373] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.587machine # [ 5.047680] systemd[1]: Stopped Virtual Console Setup.588machine # [ 5.053216] systemd[1]: Starting Virtual Console Setup...589machine # [ 5.070619] systemd[1]: systemd-udevd.service: Deactivated successfully.590machine # [ 5.072263] systemd[1]: Stopped Rule-based Manager for Device Events and Files.591machine # [ 5.076336] systemd[1]: systemd-udevd.service: Consumed 1.755s CPU time over 3.189s wall clock time, 21.5M memory peak.592machine # [ 5.081627] systemd[1]: Starting Cleanup udev Database...593machine # [ 5.084244] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.594machine # [ 5.091156] systemd[1]: Stopped Create Static Device Nodes in /dev.595machine # [ 5.092366] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.596machine # [ 5.093498] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.597machine # [ 5.094493] systemd[1]: kmod-static-nodes.service: Deactivated successfully.598machine # [ 5.095510] systemd[1]: Stopped Create List of Static Device Nodes.599machine # [ 5.120655] systemd-vconsole-setup[172]: Configuration of first virtual console was skipped, ignoring remaining ones.600machine # [ 5.128289] systemd[1]: Finished Virtual Console Setup.601machine # [ 5.157941] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.602machine # [ 5.160896] systemd[1]: Finished Cleanup udev Database.603machine # [ 5.163540] systemd[1]: Reached target Switch Root.604machine # [ 5.165150] systemd[1]: Starting NixOS Activation...605machine # [ 5.262408] initrd-nixos-activation-start[178]: booting system configuration /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test606machine # [ 5.301042] initrd-nixos-activation-start[178]: running activation script...607machine # [ 5.595001] initrd-nixos-activation-start[201]: setting up /etc...608machine # [ 5.739098] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.609machine # [ 5.742826] systemd[1]: Finished NixOS Activation.610machine # [ 5.744223] systemd[1]: Starting Switch Root...611machine # [ 5.770733] systemd[1]: Switching root.612machine # [ 5.977089] systemd-journald[72]: Received SIGTERM from PID 1 (systemd).613machine # [ 6.531898] systemd[1]: systemd 262-e2c8482 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)614machine # [ 6.545065] systemd[1]: Detected virtualization qemu.615machine # [ 6.548591] systemd[1]: Detected architecture arm64.616machine # [ 6.552865] systemd[1]: Detected first boot.617machine # [ 6.559978] systemd[1]: Initializing machine ID from random generator.618machine # [ 6.713134] systemd[1]: bpf-restrict-fs: LSM BPF program attached619machine # [ 6.880221] systemd[1]: Applying preset policy.620machine # [ 7.152735] systemd[1]: Populated /etc with preset unit settings.621machine # [ 7.393952] systemd[1]: initrd-switch-root.service: Deactivated successfully.622machine # [ 7.395840] systemd[1]: Stopped initrd-switch-root.service.623machine # [ 7.400644] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.624machine # [ 7.405208] systemd[1]: Created slice Slice /system/getty.625machine # [ 7.408443] systemd[1]: Created slice User and Session Slice.626machine # [ 7.410886] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.627machine # [ 7.413331] systemd[1]: Started Forward Password Requests to Wall Directory Watch.628machine # [ 7.415878] systemd[1]: Expecting device /dev/hvc0...629machine # [ 7.417822] systemd[1]: Expecting device /dev/ttyAMA0...630machine # [ 7.420039] systemd[1]: Reached target Local Encrypted Volumes.631machine # [ 7.422088] systemd[1]: Stopped target initrd-fs.target.632machine # [ 7.424127] systemd[1]: Stopped target initrd-root-fs.target.633machine # [ 7.426441] systemd[1]: Stopped target initrd-switch-root.target.634machine # [ 7.428455] systemd[1]: Reached target Virtual Machines and Containers.635machine # [ 7.430746] systemd[1]: Reached target Path Units.636machine # [ 7.432671] systemd[1]: Reached target Remote File Systems.637machine # [ 7.434857] systemd[1]: Reached target Slice Units.638machine # [ 7.436782] systemd[1]: Reached target Swaps.639machine # [ 7.440296] systemd[1]: Listening on Query the User Interactively for a Password.640machine # [ 7.443575] systemd[1]: Listening on Process Core Dump Socket.641machine # [ 7.445882] systemd[1]: Listening on Credential Encryption/Decryption.642machine # [ 7.448216] systemd[1]: Listening on Factory Reset Management.643machine # [ 7.449520] systemd[1]: Listening on Hostname Service Socket.644machine # [ 7.454121] systemd[1]: Starting Journal Log Access Socket...645machine # [ 7.456385] systemd[1]: Listening on Journal Audit Socket.646machine # [ 7.460149] systemd[1]: Listening on Console Output Muting Service Socket.647machine # [ 7.461785] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.648machine # [ 7.463549] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os649machine # [ 7.466960] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki650machine # [ 7.474279] systemd[1]: Listening on Disk Repartitioning Service Socket.651machine # [ 7.475771] systemd[1]: Listening on udev Varlink Socket.652machine # [ 7.479677] systemd[1]: Mounting Huge Pages File System...653machine # [ 7.487266] systemd[1]: Mounting POSIX Message Queue File System...654machine # [ 7.491582] systemd[1]: Mounting Kernel Debug File System...655machine # [ 7.510113] systemd[1]: Mounting Kernel Trace File System...656machine # [ 7.525997] systemd[1]: Starting Create List of Static Device Nodes...657machine # [ 7.528494] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs658machine # [ 7.546637] systemd[1]: Mounting Kernel Configuration File System...659machine # [ 7.549027] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm660machine # [ 7.555466] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore661machine # [ 7.558683] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse662machine # [ 7.589501] systemd[1]: Mounting FUSE Control File System...663machine # [ 7.598893] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67664machine # [ 7.621550] systemd[1]: Starting Journal Service...665machine # [ 7.635850] systemd[1]: Starting Load Kernel Modules...666machine # [ 7.662459] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...667machine # [ 7.674956] systemd[1]: Starting Remount Root and Kernel File Systems...668machine # [ 7.677468] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os669machine # [ 7.692402] systemd-journald[273]: Collecting audit messages is enabled.670machine # [ 7.700798] systemd[1]: Starting Coldplug All udev Devices...671machine # [ 7.703418] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.672machine # [ 7.704788] systemd[1]: Stopped Virtual Console Setup.673machine # [ 7.688838] systemd[1]: Queued start job for default target Multi-User System.674machine # [ 7.690279] systemd[1]: systemd-journald.service: Deactivated successfully.675machine # [ 7.712880] systemd[1]: Started Journal Service.676machine # [ 7.716663] systemd[1]: Listening on Journal Log Access Socket.677machine # [ 7.719417] systemd[1]: Mounted Huge Pages File System.678machine # [ 7.724349] systemd[1]: Mounted POSIX Message Queue File System.679machine # [ 7.725241] systemd[1]: Mounted Kernel Debug File System.680machine # [ 7.726013] systemd[1]: Mounted Kernel Trace File System.681machine # [ 7.736468] systemd[1]: Finished Create List of Static Device Nodes.682machine # [ 7.737549] systemd[1]: Mounted Kernel Configuration File System.683machine # [ 7.764493] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...684machine # [ 7.765963] systemd-modules-load[274]: Module 'atkbd' is built in685machine # [ 7.776162] systemd-modules-load[274]: Module 'loop' is built in686machine # [ 7.777238] systemd[1]: Mounted FUSE Control File System.687machine # [ 7.806402] EXT4-fs (vda): re-mounted e516168d-bc38-4009-9518-f0c8771e8f6b.688machine # [ 7.792443] systemd[1]: Finished Load Kernel Modules.689machine # [ 7.807198] systemd[1]: Starting Firewall...690machine # [ 7.818580] systemd[1]: Starting Apply Kernel Variables...691machine # [ 7.827028] systemd[1]: Finished Remount Root and Kernel File Systems.692machine # [ 7.828346] systemd[1]: Listening on Disk Image Download Service Socket.693machine # [ 7.838195] systemd[1]: Starting Flush Journal to Persistent Storage...694machine # [ 7.839218] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore695machine # [ 7.848568] systemd-oomd[276]: No swap; memory pressure usage will be degraded696machine # [ 7.864370] systemd[1]: Starting Load/Save OS Random Seed...697machine # [ 7.865347] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os698machine # [ 7.871123] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.699machine # [ 7.969174] systemd[1]: Finished Load/Save OS Random Seed.700machine # [ 7.990583] systemd-journald[273]: Received client request to flush runtime journal.701machine # [ 8.024426] systemd[1]: Reached target First Boot Complete.702machine # [ 8.031101] systemd[1]: Finished Flush Journal to Persistent Storage.703machine # [ 8.054539] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.704machine # [ 8.063724] systemd[1]: Starting Create Static Device Nodes in /dev...705machine # [ 8.068754] systemd[1]: Finished Apply Kernel Variables.706machine # [ 8.361102] systemd[1]: Finished Create Static Device Nodes in /dev.707machine # [ 8.365700] systemd[1]: Reached target Preparation for Local File Systems.708machine # [ 8.370585] systemd[1]: Starting Rule-based Manager for Device Events and Files...709machine # [ 8.395669] systemd[1]: Mounting /run/wrappers...710machine # [ 8.480870] systemd[1]: Mounted /run/wrappers.711machine # [ 8.481684] systemd[1]: Reached target Local File Systems.712machine # [ 8.486981] systemd[1]: Listening on Boot Loader Control Service Socket.713machine # [ 8.493154] systemd[1]: Starting Create SUID/SGID Wrappers...714machine # [ 8.494103] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.715machine # [ 8.504989] systemd[1]: Starting Save Transient machine-id to Disk...716machine # [ 8.507056] systemd[1]: Starting Create System Files and Directories...717machine # [ 8.572680] systemd-udevd[310]: Using default interface naming scheme 'v261'.718machine # [ 8.636073] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.719machine # [ 8.650212] systemd[1]: Finished Save Transient machine-id to Disk.720machine # [ 8.735519] systemd[1]: Finished Create System Files and Directories.721machine # [ 8.743554] systemd[1]: Starting Rebuild Journal Catalog...722machine # [ 8.751741] systemd[1]: Starting Record System Boot/Shutdown in UTMP...723machine # [ 8.792467] systemd[1]: Started Rule-based Manager for Device Events and Files.724machine # [ 8.937553] systemd[1]: Finished Record System Boot/Shutdown in UTMP.725machine # [ 8.980085] systemd[1]: Finished Rebuild Journal Catalog.726machine # [ 8.992684] systemd[1]: Starting Update is Completed...727machine # [ 9.120599] systemd[1]: Finished Update is Completed.728machine # [ 9.213592] systemd[1]: Finished Coldplug All udev Devices.729machine # [ 9.340689] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs730machine # [ 9.386090] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse731machine # [ 9.450177] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.732machine # [ 9.454411] systemd[1]: Finished Create SUID/SGID Wrappers.733machine # [ 9.462978] systemd[1]: Reached target System Initialization.734machine # [ 9.463947] systemd[1]: Started Discard unused filesystem blocks once a week.735machine # [ 9.469184] systemd[1]: Started Daily Cleanup of Temporary Directories.736machine # [ 9.470220] systemd[1]: Reached target Timer Units.737machine # [ 9.470945] systemd[1]: Listening on D-Bus System Message Bus Socket.738machine # [ 9.471871] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.739machine # [ 9.484189] systemd[1]: Reached target Socket Units.740machine # [ 9.484994] systemd[1]: Reached target Basic System.741machine # [ 9.485734] systemd[1]: Starting Import lastlog data into lastlog2 database...742machine # [ 9.486726] systemd[1]: Starting Name Service Cache Daemon (nsncd)...743machine # [ 9.497163] systemd[1]: Starting Post-Boot Actions...744machine # [ 9.514515] systemd[1]: Started Reset console on configuration changes.745machine # [ 9.549282] systemd[1]: Starting resolvconf update...746machine # [ 9.602565] systemd[1]: Starting D-Bus System Message Bus...747machine # [ 9.647967] nsncd[427]: Sep 15 21:17:50.217 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"748machine # [ 9.663579] systemd[1]: Started Name Service Cache Daemon (nsncd).749machine # [ 9.676242] systemd[1]: Reached target Host and Network Name Lookups.750machine # [ 9.677310] systemd[1]: Reached target User and Group Name Lookups.751machine # [ 9.712609] systemd[1]: Starting User Login Management...752machine # [ 9.719642] systemd[1]: Finished Post-Boot Actions.753machine # [ 9.806361] systemd[1]: Finished Import lastlog data into lastlog2 database.754machine # [ 9.823287] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.755machine # [ 9.860218] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.756machine # [ 9.873797] systemd[1]: Started backdoor.service.757machine # [ 9.877796] dbus-broker-launch[434]: Looking up NSS user entry for 'systemd-timesync'...758machine # [ 9.906012] dbus-broker-launch[434]: NSS returned no entry for 'systemd-timesync'759machine # [ 9.907225] dbus-broker-launch[434]: Invalid user-name in /nix/store/vcpvwcmmxjnida0r2hbxc1gdb3y5crj8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"760machine # [ 9.955605] systemd-logind[451]: New seat seat0.761machine # [ 9.961628] systemd[1]: Started D-Bus System Message Bus.762machine # [ 9.962434] systemd[1]: Started User Login Management.763machine # [ 9.979782] systemd[1]: Starting linger-users.service...764machine # [ 10.039893] dbus-broker-launch[434]: Ready765machine # connecting to host...766machine # [ 10.100397] systemd[1]: Stopped target Host and Network Name Lookups.767machine # [ 10.107712] systemd[1]: Stopping Host and Network Name Lookups...768machine # [ 10.116310] systemd[1]: Stopped target User and Group Name Lookups.769machine # [ 10.117267] systemd[1]: Stopping User and Group Name Lookups...770machine # [ 10.118068] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...771machine # [ 10.118922] systemd[1]: nscd.service: Deactivated successfully.772machine # [ 10.133771] systemd[1]: Stopped Name Service Cache Daemon (nsncd).773machine: Guest shell says: b'Spawning backdoor root shell...\n'774machine: connected to guest root shell775machine: (connecting took 10.46 seconds)776machine: (finished: waiting for the VM to finish booting, in 10.96 seconds)777machine # [ 10.161304] systemd[1]: Starting Name Service Cache Daemon (nsncd)...778machine # [ 10.259148] systemd[1]: Created slice Slice /user/1001.779machine # [ 10.292528] systemd[1]: Starting User Runtime Directory /run/user/1001...780machine # [ 10.320668] systemd[1]: linger-users.service: Deactivated successfully.781machine # [ 10.322053] (udev-worker)[382]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.782machine # [ 10.376459] (udev-worker)[382]: Network interface NamePolicy= disabled on kernel command line.783machine # [ 10.377680] systemd[1]: Finished linger-users.service.784machine # [ 10.463483] systemd[1]: Started Name Service Cache Daemon (nsncd).785machine # [ 10.473689] nsncd[522]: Sep 15 21:17:51.018 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"786machine # [ 10.475847] systemd[1]: Reached target Host and Network Name Lookups.787machine # [ 10.536366] systemd[1]: Reached target User and Group Name Lookups.788machine # [ 10.537368] systemd[1]: Condition check resulted in Virtio network device being skipped.789machine # [ 10.586911] systemd[1]: Finished resolvconf update.790machine # [ 10.587878] systemd[1]: Starting DHCP Client...791machine # [ 10.640248] systemd[1]: Finished User Runtime Directory /run/user/1001.792machine # [ 10.641327] systemd[1]: Starting User Manager for UID 1001...793machine # [ 10.675146] systemd-logind[451]: Watching system buttons on /dev/input/event0 (gpio-keys)794machine # [ 10.796365] (systemd)[568]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0)795machine # [ 10.834398] systemd-logind[451]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'.796machine # [ 10.874855] mousedev: PS/2 mouse device common for all mice797machine # [ 10.899845] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy798machine # [ 11.181391] systemd-logind[451]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)799machine # [ 11.221411] systemd[568]: Queued start job for default target Main User Target.800machine # [ 11.222544] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy801machine # [ 11.281058] systemd[568]: Created slice User Application Slice.802machine # [ 11.315986] systemd[568]: Started Daily Cleanup of User's Temporary Directories.803machine # [ 11.348729] systemd[568]: Reached target Paths.804machine # [ 11.375859] systemd[568]: Reached target Timers.805machine # [ 11.387046] systemd[568]: Starting D-Bus User Message Bus Socket...806machine # [ 11.401576] systemd[568]: Starting Create User Files and Directories...807machine # [ 11.402570] systemd[568]: Finished Create User Files and Directories.808machine # [ 11.403455] systemd[568]: Listening on D-Bus User Message Bus Socket.809machine # [ 11.440250] systemd[568]: Reached target Sockets.810machine # [ 11.441002] systemd[568]: Reached target Basic System.811machine # [ 11.441998] systemd[1]: Started User Manager for UID 1001.812machine # [ 11.442786] systemd[568]: Starting Run user-specific NixOS activation...813machine # [ 11.443738] systemd[568]: Finished Run user-specific NixOS activation.814machine # [ 11.493209] systemd[568]: Reached target Main User Target.815machine # [ 11.494059] systemd[568]: Startup finished in 504ms.816machine # [ 11.613948] dhcpcd[585]: dhcpcd-10.3.2 starting817machine # [ 11.623013] dhcpcd[607]: dev: loaded udev818machine # [ 11.669473] 8021q: 802.1Q VLAN Support v1.8819machine # [ 11.794628] cfg80211: Loading compiled-in X.509 certificates for regulatory database820machine # [ 11.849823] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'821machine # [ 11.851888] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'822machine # [ 11.854489] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2823machine # [ 11.854811] cfg80211: failed to load regulatory.db824machine # [ 12.025022] systemd[1]: Finished Firewall.825machine # [ 12.025745] systemd[1]: Reached target Preparation for Network.826machine # [ 12.026555] systemd[1]: Starting Address configuration of eth1...827machine # [ 12.067437] systemd[1]: Starting Extra networking commands....828machine # [ 12.247319] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3829machine # [ 12.420832] 8021q: adding VLAN 0 to HW filter on device eth0830machine # [ 12.414974] dhcpcd[607]: eth0: waiting for carrier831machine # [ 12.415807] dhcpcd[607]: eth0: carrier acquired832machine # [ 12.498878] dhcpcd[607]: DUID 00:01:00:01:32:3c:72:81:52:54:00:12:34:56833machine # [ 12.499956] dhcpcd[607]: eth0: IAID 00:12:34:56834machine # [ 12.515639] dhcpcd[607]: eth0: adding address fe80::5054:ff:fe12:3456835machine # [ 12.559596] 8021q: adding VLAN 0 to HW filter on device eth1836machine # [ 12.613806] systemd[1]: Starting Virtual Console Setup...837machine # [ 12.653632] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.838machine # [ 12.655201] network-addresses-eth1-start[639]: adding address 192.168.1.1/24... done839machine # [ 12.684945] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.840machine # [ 12.686333] systemd[1]: Stopped Virtual Console Setup.841machine # [ 12.705402] systemd[1]: Starting Virtual Console Setup...842machine # [ 12.708288] network-addresses-eth1-start[639]: adding address 2001:db8:1::1/64... done843machine # [ 12.721914] systemd-logind[451]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)844machine # [ 12.744572] systemd[1]: Finished Address configuration of eth1.845machine # [ 12.813057] systemd[1]: Finished Extra networking commands..846machine # [ 12.815154] systemd[1]: Reached target Network.847machine # [ 12.825009] systemd[1]: Starting Permit User Sessions...848machine # [ 12.858855] systemd[1]: Finished Permit User Sessions.849machine # [ 12.864801] systemd[1]: Started Getty on tty1.850machine # [ 12.868705] systemd[1]: Reached target Login Prompts.851machine # [ 12.931269] systemd-vconsole-setup[668]: Configuration of first virtual console was skipped, ignoring remaining ones.852machine # [ 12.937994] systemd[1]: Finished Virtual Console Setup.853machine # [ 14.113490] dhcpcd[607]: eth0: soliciting a DHCP lease854machine # [ 14.117529] dhcpcd[607]: eth0: offered 10.0.2.15 from 10.0.2.2855machine # [ 14.124516] dhcpcd[607]: eth0: probing address 10.0.2.15/24856machine # [ 14.219299] dhcpcd[607]: eth0: soliciting an IPv6 router857machine # [ 14.222989] dhcpcd[607]: eth0: Router Advertisement from fe80::2858machine # [ 14.225704] dhcpcd[607]: eth0: adding address fec0::5054:ff:fe12:3456/64859machine # [ 14.228552] dhcpcd[607]: eth0: adding route to fec0::/64860machine # [ 14.230910] dhcpcd[607]: eth0: adding default route via fe80::2861machine # [ 18.980914] dhcpcd[607]: eth0: leased 10.0.2.15 for 86400 seconds862machine # [ 18.984324] dhcpcd[607]: eth0: adding route to 10.0.2.0/24863machine # [ 18.986809] dhcpcd[607]: eth0: adding default route via 10.0.2.2864machine # [ 19.189327] systemd[1]: Started DHCP Client.865machine # [ 19.190721] systemd[1]: Reached target Multi-User System.866machine # [ 19.191632] systemd[1]: Startup finished in 1.001s (kernel) + 5.079s (initrd) + 13.109s (userspace) = 19.190s.867machine: (finished: waiting for unit multi-user.target, in 21.04 seconds)868machine: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/bin/switch-to-configuration test869machine # Checking switch inhibitors... done870machine # [ 20.492700] nixos[841]: switching to system configuration /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test871machine # [ 20.495505] systemd[1]: Stopped target Local File Systems.872machine # activating the configuration...873machine # [ 20.498296] systemd[1]: Stopped target Remote File Systems.874machine # setting up /etc...875machine # [ 20.788984] systemd[1]: Reload requested from client PID 841 ('.switch-to-conf') (unit backdoor.service)...876machine # [ 20.790937] systemd[1]: Reloading...877machine # [ 21.119222] systemd[1]: Reloading finished in 326 ms.878machine # reloading user units for usertest...879machine # [ 21.171399] systemd[568]: Created slice User Core Session Slice.880machine # [ 21.174916] systemd[568]: Starting D-Bus User Message Bus...881machine # [ 21.205525] dbus-broker-launch[911]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/vcpvwcmmxjnida0r2hbxc1gdb3y5crj8-system-path/share/dbus-1/services/org.freedesktop.import1.service'882machine # [ 21.208623] dbus-broker-launch[911]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/vcpvwcmmxjnida0r2hbxc1gdb3y5crj8-system-path/share/dbus-1/services/org.freedesktop.machine1.service'883machine # [ 21.211594] dbus-broker-launch[911]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/vcpvwcmmxjnida0r2hbxc1gdb3y5crj8-system-path/share/dbus-1/services/org.freedesktop.portable1.service'884machine # [ 21.214685] dbus-broker-launch[911]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/vcpvwcmmxjnida0r2hbxc1gdb3y5crj8-system-path/share/dbus-1/services/org.freedesktop.systemd1.service'885machine # [ 21.219093] dbus-broker-launch[911]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored886machine # [ 21.221720] dbus-broker-launch[911]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored887machine # [ 21.224528] systemd[568]: Started D-Bus User Message Bus.888machine # [ 21.228268] dbus-broker-launch[911]: Ready889machine # [ 21.276106] systemd[568]: Reexecution requested from client PID 910 ('switch-to-confi')...890machine # [ 21.277597] systemd[568]: Reexecuting.891machine # [ 21.327966] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy892machine # [ 21.445366] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy893machine # [ 21.452376] systemd[568]: Reload requested from client PID 910 ('switch-to-confi')...894machine # [ 21.454821] systemd[568]: Reloading...895machine # [ 21.566413] systemd[568]: Reloading finished in 110 ms.896machine # [ 21.580209] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy897machine # restarting the following user units: nixos-activation.service898machine # [ 21.592089] systemd[568]: Stopped Run user-specific NixOS activation.899machine # [ 21.594438] systemd[568]: Stopping Run user-specific NixOS activation...900machine # [ 21.596630] systemd[568]: Starting Run user-specific NixOS activation...901machine # [ 21.631661] systemd[568]: Finished Run user-specific NixOS activation.902machine # restarting sysinit-reactivation.target903machine # [ 21.644296] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....904machine # [ 21.724336] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..905machine # [ 21.731442] systemd[1]: Reached target Reactivate sysinit units.906machine # [ 21.738959] systemd[1]: Reached target Remote File Systems.907machine # [ 21.742692] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os908machine # [ 21.747970] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki909machine # [ 21.756250] systemd[1]: Starting linger-users.service...910machine # [ 21.757149] systemd[1]: Reached target Local File Systems.911machine # [ 21.763910] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore912machine # [ 21.776392] systemd[1]: Starting Create SUID/SGID Wrappers...913machine # [ 21.777274] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.914machine # [ 21.778481] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67915machine # [ 21.792423] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore916machine # [ 21.794101] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os917machine # [ 21.805837] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os918machine # [ 21.872879] systemd[1]: linger-users.service: Deactivated successfully.919machine # [ 21.876480] systemd[1]: Finished linger-users.service.920machine # [ 22.017586] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.921machine # [ 22.020351] systemd[1]: Finished Create SUID/SGID Wrappers.922machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service923machine # [ 22.288871] nixos[841]: finished switching to system configuration /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test924machine: (finished: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/bin/switch-to-configuration test, in 2.07 seconds)925machine: must succeed: rm /etc/NIXOS926machine: (finished: must succeed: rm /etc/NIXOS, in 0.05 seconds)927machine: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/v77csy8p1yzqn64kirmr38008picpwnv-nixos-system-other-test/bin/switch-to-configuration test928machine # this should succeed (config: /nix/store/v77csy8p1yzqn64kirmr38008picpwnv-nixos-system-other-test, action: test)929machine # Checking switch inhibitors... done930machine # [ 22.626857] nixos[989]: switching to system configuration /nix/store/v77csy8p1yzqn64kirmr38008picpwnv-nixos-system-other-test931machine # [ 22.629641] systemd[1]: Stopped target Remote File Systems.932machine # activating the configuration...933machine # [ 22.632488] systemd[1]: Stopped target Local File Systems.934machine # removing user ‘usertest’935machine # setting up /etc...936machine # [ 22.926356] systemd[1]: Reload requested from client PID 989 ('.switch-to-conf') (unit backdoor.service)...937machine # [ 22.928549] systemd[1]: Reloading...938machine # [ 23.274981] systemd[1]: Reloading finished in 344 ms.939machine # reloading user units for usertest...940machine # [ 23.376452] systemd[568]: Reexecution requested from client PID 1060 ('switch-to-confi')...941machine # [ 23.381600] systemd[568]: Reexecuting.942machine # [ 23.427543] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy943machine # [ 23.549850] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy944machine # [ 23.556316] systemd[568]: Reload requested from client PID 1060 ('switch-to-confi')...945machine # [ 23.558771] systemd[568]: Reloading...946machine # [ 23.671761] systemd[568]: Reloading finished in 112 ms.947machine # [ 23.688196] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy948machine # restarting the following user units: nixos-activation.service949machine # [ 23.699332] systemd[568]: Stopped Run user-specific NixOS activation.950machine # [ 23.701744] systemd[568]: Stopping Run user-specific NixOS activation...951machine # [ 23.704063] systemd[568]: Starting Run user-specific NixOS activation...952machine # [ 23.737138] systemd[568]: Finished Run user-specific NixOS activation.953machine # restarting sysinit-reactivation.target954machine # [ 23.741752] systemd[1]: Stopped target Reactivate sysinit units.955machine # reloading the following units: dbus-broker.service[ 23.744591] systemd[1]: Stopping Reactivate sysinit units...956machine # [ 23.745480] systemd[1]: Reached target Reactivate sysinit units.957machine # 958machine # [ 23.749069] systemd[1]: Reloading D-Bus System Message Bus...959machine # [ 23.751055] dbus-broker-launch[434]: Caught SIGHUP, trigger reload.960machine # [ 23.757579] dbus-broker-launch[434]: Looking up NSS user entry for 'systemd-timesync'...961machine # [ 23.759769] dbus-broker-launch[434]: NSS returned no entry for 'systemd-timesync'962machine # [ 23.761130] dbus-broker-launch[434]: Invalid user-name in /nix/store/wcbbx87z8mk1zpdd2fxcqai8im93kzh2-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"963machine # [ 23.778009] systemd[1]: Reloaded D-Bus System Message Bus.964machine # restarting the following units: network-addresses-eth1.service965machine # [ 23.784920] systemd[1]: Stopping Address configuration of eth1...966machine # [ 23.816461] network-addresses-eth1-pre-stop[1072]: deleting address 192.168.1.1/24... done967machine # [ 23.822748] network-addresses-eth1-pre-stop[1072]: deleting address 2001:db8:1::1/64... done968machine # [ 23.829672] systemd[1]: network-addresses-eth1.service: Deactivated successfully.969machine # [ 23.832215] systemd[1]: Stopped Address configuration of eth1.970machine # [ 23.837259] systemd[1]: Starting Address configuration of eth1...971machine # [ 23.879794] network-addresses-eth1-start[1077]: adding address 192.168.1.2/24... done972machine # [ 23.887361] network-addresses-eth1-start[1077]: adding address 2001:db8:1::2/64... done973machine # [ 23.897110] systemd[1]: Finished Address configuration of eth1.974machine # [ 23.903134] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os975machine # [ 23.906831] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki976machine # [ 23.909762] systemd[1]: Reached target Remote File Systems.977machine # [ 23.915116] systemd[1]: Starting linger-users.service...978machine # [ 23.919487] systemd[1]: Reached target Local File Systems.979machine # [ 23.927382] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore980machine # [ 23.936286] systemd[1]: Starting Create SUID/SGID Wrappers...981machine # [ 23.937220] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.982machine # [ 23.938445] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67983machine # [ 23.943441] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore984machine # [ 23.949495] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os985machine # [ 23.950867] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os986machine # [ 23.981892] linger-users-start[1091]: id: ‘usertest’: no such user987machine # [ 23.984549] linger-users-start[1088]: Removing linger for missing user usertest988machine # [ 23.995328] systemd[1]: linger-users.service: Deactivated successfully.989machine # [ 23.998205] systemd[1]: Finished linger-users.service.990machine # [ 24.164320] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.991machine # [ 24.167605] systemd[1]: Finished Create SUID/SGID Wrappers.992machine # [ 24.425004] nixos[989]: finished switching to system configuration /nix/store/v77csy8p1yzqn64kirmr38008picpwnv-nixos-system-other-test993machine: (finished: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/v77csy8p1yzqn64kirmr38008picpwnv-nixos-system-other-test/bin/switch-to-configuration test, in 2.08 seconds)994subtest: services995machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1996machine # [ 24.713841] nixos[1155]: switching to system configuration /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test997machine # [ 24.716391] systemd[1]: Stopped target Remote File Systems.998machine # [ 24.718767] systemd[1]: Stopped target Local File Systems.999machine # [ 24.989322] systemd[1]: Reload requested from client PID 1155 ('.switch-to-conf') (unit backdoor.service)...1000machine # [ 24.991219] systemd[1]: Reloading...1001machine # [ 25.326073] systemd[1]: Reloading finished in 333 ms.1002machine # [ 25.439426] systemd[568]: Reexecution requested from client PID 1224 ('switch-to-confi')...1003machine # [ 25.443787] systemd[568]: Reexecuting.1004machine # [ 25.499896] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1005machine # [ 25.619430] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1006machine # [ 25.625934] systemd[568]: Reload requested from client PID 1224 ('switch-to-confi')...1007machine # [ 25.628403] systemd[568]: Reloading...1008machine # [ 25.741848] systemd[568]: Reloading finished in 112 ms.1009machine # [ 25.756182] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1010machine # [ 25.766335] systemd[568]: Stopped Run user-specific NixOS activation.1011machine # [ 25.767438] systemd[568]: Stopping Run user-specific NixOS activation...1012machine # [ 25.769982] systemd[568]: Starting Run user-specific NixOS activation...1013machine # [ 25.800620] systemd[568]: Finished Run user-specific NixOS activation.1014machine # [ 25.804516] systemd[1]: Stopped target Reactivate sysinit units.1015machine # [ 25.809045] systemd[1]: Stopping Reactivate sysinit units...1016machine # [ 25.810393] systemd[1]: Reached target Reactivate sysinit units.1017machine # [ 25.811288] systemd[1]: Reloading D-Bus System Message Bus...1018machine # [ 25.812778] dbus-broker-launch[434]: Caught SIGHUP, trigger reload.1019machine # [ 25.817143] dbus-broker-launch[434]: Looking up NSS user entry for 'systemd-timesync'...1020machine # [ 25.819288] dbus-broker-launch[434]: NSS returned no entry for 'systemd-timesync'1021machine # [ 25.820650] dbus-broker-launch[434]: Invalid user-name in /nix/store/vcpvwcmmxjnida0r2hbxc1gdb3y5crj8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1022machine # [ 25.836168] systemd[1]: Reloaded D-Bus System Message Bus.1023machine # [ 25.841955] systemd[1]: Stopping Address configuration of eth1...1024machine # [ 25.875432] network-addresses-eth1-pre-stop[1237]: deleting address 192.168.1.2/24... done1025machine # [ 25.882080] network-addresses-eth1-pre-stop[1237]: deleting address 2001:db8:1::2/64... done1026machine # [ 25.889034] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1027machine # [ 25.891351] systemd[1]: Stopped Address configuration of eth1.1028machine # [ 25.896218] systemd[1]: Starting Address configuration of eth1...1029machine # [ 25.939085] network-addresses-eth1-start[1242]: adding address 192.168.1.1/24... done1030machine # [ 25.946352] network-addresses-eth1-start[1242]: adding address 2001:db8:1::1/64... done1031machine # [ 25.955841] systemd[1]: Finished Address configuration of eth1.1032machine # [ 25.961210] systemd[1]: Reached target Remote File Systems.1033machine # [ 25.965911] systemd[1]: Starting linger-users.service...1034machine # [ 25.979003] systemd[1]: Reached target Local File Systems.1035machine # [ 25.979949] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1036machine # [ 25.989883] systemd[1]: Starting Create SUID/SGID Wrappers...1037machine # [ 25.990801] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1038machine # [ 25.997490] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671039machine # [ 25.999816] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1040machine # [ 26.010624] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1041machine # [ 26.014873] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1042machine # [ 26.019927] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1043machine # [ 26.022656] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1044machine # [ 26.046122] systemd[1]: linger-users.service: Deactivated successfully.1045machine # [ 26.049639] systemd[1]: Finished linger-users.service.1046machine # [ 26.192228] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1047machine # [ 26.194819] systemd[1]: Finished Create SUID/SGID Wrappers.1048machine # [ 26.453969] nixos[1155]: finished switching to system configuration /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test1049machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.03 seconds)1050machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/bin/switch-to-configuration test 2>&11051machine # [ 26.726834] nixos[1311]: switching to system configuration /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test1052machine # [ 26.729295] systemd[1]: Stopped target Local File Systems.1053machine # [ 26.731714] systemd[1]: Stopped target Remote File Systems.1054machine # [ 27.003489] systemd[1]: Reload requested from client PID 1311 ('.switch-to-conf') (unit backdoor.service)...1055machine # [ 27.005586] systemd[1]: Reloading...1056machine # [ 27.331043] systemd[1]: Reloading finished in 324 ms.1057machine # [ 27.421507] systemd[568]: Reexecution requested from client PID 1380 ('switch-to-confi')...1058machine # [ 27.425767] systemd[568]: Reexecuting.1059machine # [ 27.479254] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1060machine # [ 27.593212] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1061machine # [ 27.599924] systemd[568]: Reload requested from client PID 1380 ('switch-to-confi')...1062machine # [ 27.603587] systemd[568]: Reloading...1063machine # [ 27.719770] systemd[568]: Reloading finished in 117 ms.1064machine # [ 27.740242] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1065machine # [ 27.751038] systemd[568]: Stopped Run user-specific NixOS activation.1066machine # [ 27.753833] systemd[568]: Stopping Run user-specific NixOS activation...1067machine # [ 27.756188] systemd[568]: Starting Run user-specific NixOS activation...1068machine # [ 27.791644] systemd[568]: Finished Run user-specific NixOS activation.1069machine # [ 27.796573] systemd[1]: Stopped target Reactivate sysinit units.1070machine # [ 27.799460] systemd[1]: Stopping Reactivate sysinit units...1071machine # [ 27.804427] systemd[1]: Reached target Reactivate sysinit units.1072machine # [ 27.805363] systemd[1]: Reached target Remote File Systems.1073machine # [ 27.808951] systemd[1]: Starting linger-users.service...1074machine # [ 27.813467] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1075machine # [ 27.823806] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1076machine # [ 27.831298] systemd[1]: Reached target Local File Systems.1077machine # [ 27.836369] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1078machine # [ 27.838010] systemd[1]: Starting Create SUID/SGID Wrappers...1079machine # [ 27.838807] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1080machine # [ 27.846188] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671081machine # [ 27.848914] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1082machine # [ 27.850518] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1083machine # [ 27.857883] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1084machine # [ 27.917295] systemd[1]: linger-users.service: Deactivated successfully.1085machine # [ 27.921391] systemd[1]: Finished linger-users.service.1086machine # [ 28.081068] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1087machine # [ 28.085184] systemd[1]: Finished Create SUID/SGID Wrappers.1088machine # [ 28.342476] nixos[1311]: finished switching to system configuration /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test1089machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.89 seconds)1090machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11091machine # [ 28.683184] nixos[1451]: switching to system configuration /nix/store/pxk52rvva355wpm5k41573w2s5170ws7-nixos-system-machine-test1092machine # [ 28.686342] systemd[1]: Stopped target Remote File Systems.1093machine # [ 28.688283] systemd[1]: Stopped target Local File Systems.1094machine # [ 28.995578] systemd[1]: Reload requested from client PID 1451 ('.switch-to-conf') (unit backdoor.service)...1095machine # [ 28.997704] systemd[1]: Reloading...1096machine # [ 29.340341] systemd[1]: Reloading finished in 340 ms.1097machine # [ 29.432424] systemd[568]: Reexecution requested from client PID 1521 ('switch-to-confi')...1098machine # [ 29.436311] systemd[568]: Reexecuting.1099machine # [ 29.491294] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1100machine # [ 29.608848] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1101machine # [ 29.615483] systemd[568]: Reload requested from client PID 1521 ('switch-to-confi')...1102machine # [ 29.618894] systemd[568]: Reloading...1103machine # [ 29.730415] systemd[568]: Reloading finished in 112 ms.1104machine # [ 29.744233] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1105machine # [ 29.753351] systemd[568]: Stopped Run user-specific NixOS activation.1106machine # [ 29.755754] systemd[568]: Stopping Run user-specific NixOS activation...1107machine # [ 29.757920] systemd[568]: Starting Run user-specific NixOS activation...1108machine # [ 29.789080] systemd[568]: Finished Run user-specific NixOS activation.1109machine # [ 29.792807] systemd[1]: Stopped target Reactivate sysinit units.1110machine # [ 29.795779] systemd[1]: Stopping Reactivate sysinit units...1111machine # [ 29.800315] systemd[1]: Reached target Reactivate sysinit units.1112machine # [ 29.801238] systemd[1]: Reached target Remote File Systems.1113machine # [ 29.804184] systemd[1]: Starting linger-users.service...1114machine # [ 29.807263] systemd[1]: Starting test.service...1115machine # [ 29.822883] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1116machine # [ 29.825829] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1117machine # [ 29.827183] systemd[1]: Reached target Local File Systems.1118machine # [ 29.837848] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1119machine # [ 29.839515] systemd[1]: Starting Create SUID/SGID Wrappers...1120machine # [ 29.850061] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1121machine # [ 29.851468] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671122machine # [ 29.863533] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1123machine # [ 29.871737] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1124machine # [ 29.878457] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1125machine # [ 29.879896] systemd[1]: Finished test.service.1126machine # [ 29.913435] systemd[1]: linger-users.service: Deactivated successfully.1127machine # [ 29.917874] systemd[1]: Finished linger-users.service.1128machine # [ 30.060332] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1129machine # [ 30.063289] systemd[1]: Finished Create SUID/SGID Wrappers.1130machine # [ 30.324000] nixos[1451]: finished switching to system configuration /nix/store/pxk52rvva355wpm5k41573w2s5170ws7-nixos-system-machine-test1131machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.98 seconds)1132machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11133machine # [ 30.602359] nixos[1594]: switching to system configuration /nix/store/pxk52rvva355wpm5k41573w2s5170ws7-nixos-system-machine-test1134machine # [ 30.605219] systemd[1]: Stopped target Local File Systems.1135machine # [ 30.607479] systemd[1]: Stopped target Remote File Systems.1136machine # [ 30.903020] systemd[1]: Reload requested from client PID 1594 ('.switch-to-conf') (unit backdoor.service)...1137machine # [ 30.905167] systemd[1]: Reloading...1138machine # [ 31.228337] systemd[1]: Reloading finished in 321 ms.1139machine # [ 31.326137] systemd[568]: Reexecution requested from client PID 1663 ('switch-to-confi')...1140machine # [ 31.330801] systemd[568]: Reexecuting.1141machine # [ 31.388805] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1142machine # [ 31.513353] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1143machine # [ 31.519894] systemd[568]: Reload requested from client PID 1663 ('switch-to-confi')...1144machine # [ 31.523951] systemd[568]: Reloading...1145machine # [ 31.639787] systemd[568]: Reloading finished in 116 ms.1146machine # [ 31.656190] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1147machine # [ 31.666224] systemd[568]: Stopped Run user-specific NixOS activation.1148machine # [ 31.668897] systemd[568]: Stopping Run user-specific NixOS activation...1149machine # [ 31.671329] systemd[568]: Starting Run user-specific NixOS activation...1150machine # [ 31.705698] systemd[568]: Finished Run user-specific NixOS activation.1151machine # [ 31.710185] systemd[1]: Stopped target Reactivate sysinit units.1152machine # [ 31.717502] systemd[1]: Stopping Reactivate sysinit units...1153machine # [ 31.718433] systemd[1]: Reached target Reactivate sysinit units.1154machine # [ 31.730655] systemd[1]: Reached target Remote File Systems.1155machine # [ 31.731651] systemd[1]: Starting linger-users.service...1156machine # [ 31.745378] systemd[1]: Reached target Local File Systems.1157machine # [ 31.746249] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1158machine # [ 31.747764] systemd[1]: Starting Create SUID/SGID Wrappers...1159machine # [ 31.762475] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1160machine # [ 31.763855] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671161machine # [ 31.777646] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1162machine # [ 31.779639] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1163machine # [ 31.793003] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1164machine # [ 31.801456] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1165machine # [ 31.802881] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1166machine # [ 31.885942] systemd[1]: linger-users.service: Deactivated successfully.1167machine # [ 31.889545] systemd[1]: Finished linger-users.service.1168machine # [ 32.025713] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1169machine # [ 32.029497] systemd[1]: Finished Create SUID/SGID Wrappers.1170machine # [ 32.286956] nixos[1594]: finished switching to system configuration /nix/store/pxk52rvva355wpm5k41573w2s5170ws7-nixos-system-machine-test1171machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.97 seconds)1172machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&11173machine # [ 32.594392] nixos[1735]: switching to system configuration /nix/store/dvc9pfh46sckyx671swi23mv626ycjkq-nixos-system-machine-test1174machine # [ 32.596929] systemd[1]: Stopped target Local File Systems.1175machine # [ 32.599271] systemd[1]: Stopped target Remote File Systems.1176machine # [ 32.893608] systemd[1]: Reload requested from client PID 1735 ('.switch-to-conf') (unit backdoor.service)...1177machine # [ 32.895536] systemd[1]: Reloading...1178machine # [ 33.281438] systemd[1]: Reloading finished in 384 ms.1179machine # [ 33.368089] systemd[568]: Reexecution requested from client PID 1804 ('switch-to-confi')...1180machine # [ 33.369484] systemd[568]: Reexecuting.1181machine # [ 33.436182] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1182machine # [ 33.561982] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1183machine # [ 33.568671] systemd[568]: Reload requested from client PID 1804 ('switch-to-confi')...1184machine # [ 33.571287] systemd[568]: Reloading...1185machine # [ 33.685357] systemd[568]: Reloading finished in 113 ms.1186machine # [ 33.700215] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1187machine # [ 33.711131] systemd[568]: Stopped Run user-specific NixOS activation.1188machine # [ 33.712249] systemd[568]: Stopping Run user-specific NixOS activation...1189machine # [ 33.714343] systemd[568]: Starting Run user-specific NixOS activation...1190machine # [ 33.743806] systemd[568]: Finished Run user-specific NixOS activation.1191machine # [ 33.747880] systemd[1]: Stopped target Reactivate sysinit units.1192machine # [ 33.749633] systemd[1]: Stopping Reactivate sysinit units...1193machine # [ 33.750457] systemd[1]: Reached target Reactivate sysinit units.1194machine # [ 33.754223] systemd[1]: Reached target Remote File Systems.1195machine # [ 33.758469] systemd[1]: Starting linger-users.service...1196machine # [ 33.767795] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1197machine # [ 33.771060] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1198machine # [ 33.774214] systemd[1]: Reached target Local File Systems.1199machine # [ 33.780835] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1200machine # [ 33.788239] systemd[1]: Starting Create SUID/SGID Wrappers...1201machine # [ 33.789175] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1202machine # [ 33.790407] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671203machine # [ 33.799235] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1204machine # [ 33.803901] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1205machine # [ 33.806048] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1206machine # [ 33.843106] systemd[1]: linger-users.service: Deactivated successfully.1207machine # [ 33.847236] systemd[1]: Finished linger-users.service.1208machine # [ 33.987125] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1209machine # [ 33.990514] systemd[1]: Finished Create SUID/SGID Wrappers.1210machine # [ 34.247645] nixos[1735]: finished switching to system configuration /nix/store/dvc9pfh46sckyx671swi23mv626ycjkq-nixos-system-machine-test1211machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 1.96 seconds)1212machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11213machine # [ 34.559711] nixos[1875]: switching to system configuration /nix/store/b8v4dzxsp98n1mrz3y8s56yix8lk2gz1-nixos-system-machine-test1214machine # [ 34.562768] systemd[1]: Stopped target Local File Systems.1215machine # [ 34.566634] systemd[1]: Stopped target Remote File Systems.1216machine # [ 34.568004] systemd[1]: test.service: Deactivated successfully.1217machine # [ 34.569252] systemd[1]: Stopped Test unit.1218machine # [ 34.866732] systemd[1]: Reload requested from client PID 1875 ('.switch-to-conf') (unit backdoor.service)...1219machine # [ 34.868866] systemd[1]: Reloading...1220machine # [ 35.217722] systemd[1]: Reloading finished in 347 ms.1221machine # [ 35.340336] systemd[568]: Reexecution requested from client PID 1944 ('switch-to-confi')...1222machine # [ 35.344499] systemd[568]: Reexecuting.1223machine # [ 35.399257] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1224machine # [ 35.511568] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1225machine # [ 35.519085] systemd[568]: Reload requested from client PID 1944 ('switch-to-confi')...1226machine # [ 35.522326] systemd[568]: Reloading...1227machine # [ 35.633959] systemd[568]: Reloading finished in 111 ms.1228machine # [ 35.648183] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1229machine # [ 35.656879] systemd[568]: Stopped Run user-specific NixOS activation.1230machine # [ 35.659178] systemd[568]: Stopping Run user-specific NixOS activation...1231machine # [ 35.661278] systemd[568]: Starting Run user-specific NixOS activation...1232machine # [ 35.692230] systemd[568]: Finished Run user-specific NixOS activation.1233machine # [ 35.697500] systemd[1]: Stopped target Reactivate sysinit units.1234machine # [ 35.698724] systemd[1]: Stopping Reactivate sysinit units...1235machine # [ 35.699540] systemd[1]: Reached target Reactivate sysinit units.1236machine # [ 35.704594] systemd[1]: Reached target Remote File Systems.1237machine # [ 35.708205] systemd[1]: Starting linger-users.service...1238machine # [ 35.713048] systemd[1]: Starting test.service...1239machine # [ 35.713868] systemd[1]: Reached target Local File Systems.1240machine # [ 35.724731] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1241machine # [ 35.726082] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1242machine # [ 35.734988] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1243machine # [ 35.745870] systemd[1]: Starting Create SUID/SGID Wrappers...1244machine # [ 35.746755] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1245machine # [ 35.756584] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671246machine # [ 35.758894] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1247machine # [ 35.769163] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1248machine # [ 35.770450] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1249machine # [ 35.788307] systemd[1]: Finished test.service.1250machine # [ 35.814819] systemd[1]: linger-users.service: Deactivated successfully.1251machine # [ 35.816714] systemd[1]: Finished linger-users.service.1252machine # [ 35.967956] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1253machine # [ 35.970737] systemd[1]: Finished Create SUID/SGID Wrappers.1254machine # [ 36.230277] nixos[1875]: finished switching to system configuration /nix/store/b8v4dzxsp98n1mrz3y8s56yix8lk2gz1-nixos-system-machine-test1255machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.98 seconds)1256machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&11257machine # [ 36.520172] nixos[2018]: switching to system configuration /nix/store/14nf8m8wg6yp4k3p9hj90zq8a1cmn3ji-nixos-system-machine-test1258machine # [ 36.523006] systemd[1]: Stopped target Remote File Systems.1259machine # [ 36.525238] systemd[1]: Stopped target Local File Systems.1260machine # [ 36.809836] systemd[1]: Reload requested from client PID 2018 ('.switch-to-conf') (unit backdoor.service)...1261machine # [ 36.811754] systemd[1]: Reloading...1262machine # [ 37.142142] systemd[1]: Reloading finished in 328 ms.1263machine # [ 37.234810] systemd[568]: Reexecution requested from client PID 2087 ('switch-to-confi')...1264machine # [ 37.238794] systemd[568]: Reexecuting.1265machine # [ 37.304083] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1266machine # [ 37.429947] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1267machine # [ 37.436744] systemd[568]: Reload requested from client PID 2087 ('switch-to-confi')...1268machine # [ 37.439350] systemd[568]: Reloading...1269machine # [ 37.553576] systemd[568]: Reloading finished in 113 ms.1270machine # [ 37.568198] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1271machine # [ 37.577080] systemd[568]: Stopped Run user-specific NixOS activation.1272machine # [ 37.579384] systemd[568]: Stopping Run user-specific NixOS activation...1273machine # [ 37.581507] systemd[568]: Starting Run user-specific NixOS activation...1274machine # [ 37.612823] systemd[568]: Finished Run user-specific NixOS activation.1275machine # [ 37.617102] systemd[1]: Stopped target Reactivate sysinit units.1276machine # [ 37.619048] systemd[1]: Stopping Reactivate sysinit units...1277machine # [ 37.619904] systemd[1]: Reached target Reactivate sysinit units.1278machine # [ 37.624377] systemd[1]: test.service: Deactivated successfully.1279machine # [ 37.625253] systemd[1]: Stopped test.service.1280machine # [ 37.625883] systemd[1]: Stopping test.service...1281machine # [ 37.632214] systemd[1]: Starting test.service...1282machine # [ 37.654969] systemd[1]: Finished test.service.1283machine # [ 37.656672] systemd[1]: Reached target Local File Systems.1284machine # [ 37.664002] systemd[1]: Reached target Remote File Systems.1285machine # [ 37.668992] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1286machine # [ 37.670384] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1287machine # [ 37.671674] systemd[1]: Starting linger-users.service...1288machine # [ 37.685426] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1289machine # [ 37.686959] systemd[1]: Starting Create SUID/SGID Wrappers...1290machine # [ 37.687788] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1291machine # [ 37.695985] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671292machine # [ 37.699333] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1293machine # [ 37.708635] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1294machine # [ 37.714258] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1295machine # [ 37.754233] systemd[1]: linger-users.service: Deactivated successfully.1296machine # [ 37.757353] systemd[1]: Finished linger-users.service.1297machine # [ 37.898068] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1298machine # [ 37.901347] systemd[1]: Finished Create SUID/SGID Wrappers.1299machine # [ 38.158148] nixos[2018]: finished switching to system configuration /nix/store/14nf8m8wg6yp4k3p9hj90zq8a1cmn3ji-nixos-system-machine-test1300machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.93 seconds)1301machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&11302machine # [ 38.503984] nixos[2160]: switching to system configuration /nix/store/7r00hf5az34vqskj8rc0bls1ghg87nnw-nixos-system-machine-test1303machine # [ 38.506604] systemd[1]: Stopped target Local File Systems.1304machine # [ 38.508667] systemd[1]: Stopped target Remote File Systems.1305machine # [ 38.828734] systemd[1]: Reload requested from client PID 2160 ('.switch-to-conf') (unit backdoor.service)...1306machine # [ 38.830363] systemd[1]: Reloading...1307machine # [ 39.190362] systemd[1]: Reloading finished in 358 ms.1308machine # [ 39.288473] systemd[568]: Reexecution requested from client PID 2230 ('switch-to-confi')...1309machine # [ 39.291227] systemd[568]: Reexecuting.1310machine # [ 39.352149] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1311machine # [ 39.477057] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1312machine # [ 39.483822] systemd[568]: Reload requested from client PID 2230 ('switch-to-confi')...1313machine # [ 39.487560] systemd[568]: Reloading...1314machine # [ 39.601042] systemd[568]: Reloading finished in 114 ms.1315machine # [ 39.620192] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1316machine # [ 39.629486] systemd[568]: Stopped Run user-specific NixOS activation.1317machine # [ 39.631975] systemd[568]: Stopping Run user-specific NixOS activation...1318machine # [ 39.635969] systemd[568]: Starting Run user-specific NixOS activation...1319machine # [ 39.666125] systemd[568]: Finished Run user-specific NixOS activation.1320machine # [ 39.670609] systemd[1]: Stopped target Reactivate sysinit units.1321machine # [ 39.675326] systemd[1]: Stopping Reactivate sysinit units...1322machine # [ 39.676737] systemd[1]: Reached target Reactivate sysinit units.1323machine # [ 39.678947] systemd[1]: Reloading test.service...1324machine # [ 39.706680] systemd[1]: Reloaded test.service.1325machine # [ 39.709369] systemd[1]: Reached target Remote File Systems.1326machine # [ 39.714919] systemd[1]: Starting linger-users.service...1327machine # [ 39.724395] systemd[1]: Reached target Local File Systems.1328machine # [ 39.725379] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1329machine # [ 39.736837] systemd[1]: Starting Create SUID/SGID Wrappers...1330machine # [ 39.737866] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1331machine # [ 39.739137] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671332machine # [ 39.754046] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1333machine # [ 39.755799] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1334machine # [ 39.765934] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1335machine # [ 39.770458] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1336machine # [ 39.771910] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1337machine # [ 39.815635] systemd[1]: linger-users.service: Deactivated successfully.1338machine # [ 39.820711] systemd[1]: Finished linger-users.service.1339machine # [ 39.963182] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1340machine # [ 39.966959] systemd[1]: Finished Create SUID/SGID Wrappers.1341machine # [ 40.226360] nixos[2160]: finished switching to system configuration /nix/store/7r00hf5az34vqskj8rc0bls1ghg87nnw-nixos-system-machine-test1342machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 2.07 seconds)1343machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&11344machine # [ 40.553218] nixos[2303]: switching to system configuration /nix/store/bs0kln4r7xwqnmnna8jpd8gxfxca8r6q-nixos-system-machine-test1345machine # [ 40.555794] systemd[1]: Stopped target Remote File Systems.1346machine # [ 40.558383] systemd[1]: Stopped target Local File Systems.1347machine # [ 40.855806] systemd[1]: Reload requested from client PID 2303 ('.switch-to-conf') (unit backdoor.service)...1348machine # [ 40.857918] systemd[1]: Reloading...1349machine # [ 41.209947] systemd[1]: Reloading finished in 349 ms.1350machine # [ 41.298560] systemd[568]: Reexecution requested from client PID 2372 ('switch-to-confi')...1351machine # [ 41.299974] systemd[568]: Reexecuting.1352machine # [ 41.360060] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1353machine # [ 41.482810] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1354machine # [ 41.489639] systemd[568]: Reload requested from client PID 2372 ('switch-to-confi')...1355machine # [ 41.491761] systemd[568]: Reloading...1356machine # [ 41.603616] systemd[568]: Reloading finished in 110 ms.1357machine # [ 41.620181] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1358machine # [ 41.629462] systemd[568]: Stopped Run user-specific NixOS activation.1359machine # [ 41.631811] systemd[568]: Stopping Run user-specific NixOS activation...1360machine # [ 41.633885] systemd[568]: Starting Run user-specific NixOS activation...1361machine # [ 41.664109] systemd[568]: Finished Run user-specific NixOS activation.1362machine # [ 41.667798] systemd[1]: Stopped target Reactivate sysinit units.1363machine # [ 41.670528] systemd[1]: Stopping Reactivate sysinit units...1364machine # [ 41.671400] systemd[1]: Reached target Reactivate sysinit units.1365machine # [ 41.675612] systemd[1]: Reached target Remote File Systems.1366machine # [ 41.678813] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1367machine # [ 41.681606] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1368machine # [ 41.684881] systemd[1]: Reached target Local File Systems.1369machine # [ 41.690440] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1370machine # [ 41.697883] systemd[1]: Starting Create SUID/SGID Wrappers...1371machine # [ 41.698786] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1372machine # [ 41.707622] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671373machine # [ 41.713330] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1374machine # [ 41.714923] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1375machine # [ 41.716594] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1376machine # [ 41.915324] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1377machine # [ 41.920426] systemd[1]: Finished Create SUID/SGID Wrappers.1378machine # [ 41.922631] systemd[1]: Starting linger-users.service...1379machine # [ 41.966641] systemd[1]: linger-users.service: Deactivated successfully.1380machine # [ 41.969326] systemd[1]: Finished linger-users.service.1381machine # [ 42.229276] nixos[2303]: finished switching to system configuration /nix/store/bs0kln4r7xwqnmnna8jpd8gxfxca8r6q-nixos-system-machine-test1382machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 2.00 seconds)1383machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&11384machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.36 seconds)1385machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/bin/switch-to-configuration test 2>&11386machine # [ 42.811635] nixos[2454]: switching to system configuration /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test1387machine # [ 42.814539] systemd[1]: Stopped target Remote File Systems.1388machine # [ 42.818310] systemd[1]: test.service: Deactivated successfully.1389machine # [ 42.819575] systemd[1]: Stopped test.service.1390machine # [ 42.821064] systemd[1]: Stopped target Local File Systems.1391machine # [ 43.106129] systemd[1]: Reload requested from client PID 2454 ('.switch-to-conf') (unit backdoor.service)...1392machine # [ 43.108256] systemd[1]: Reloading...1393machine # [ 43.453921] systemd[1]: Reloading finished in 344 ms.1394machine # [ 43.552367] systemd[568]: Reexecution requested from client PID 2523 ('switch-to-confi')...1395machine # [ 43.553788] systemd[568]: Reexecuting.1396machine # [ 43.616394] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1397machine # [ 43.740994] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1398machine # [ 43.748115] systemd[568]: Reload requested from client PID 2523 ('switch-to-confi')...1399machine # [ 43.749469] systemd[568]: Reloading...1400machine # [ 43.865308] systemd[568]: Reloading finished in 114 ms.1401machine # [ 43.880173] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1402machine # [ 43.890337] systemd[568]: Stopped Run user-specific NixOS activation.1403machine # [ 43.892835] systemd[568]: Stopping Run user-specific NixOS activation...1404machine # [ 43.894977] systemd[568]: Starting Run user-specific NixOS activation...1405machine # [ 43.930059] systemd[568]: Finished Run user-specific NixOS activation.1406machine # [ 43.934644] systemd[1]: Stopped target Reactivate sysinit units.1407machine # [ 43.938077] systemd[1]: Stopping Reactivate sysinit units...1408machine # [ 43.938979] systemd[1]: Reached target Reactivate sysinit units.1409machine # [ 43.942823] systemd[1]: Reached target Local File Systems.1410machine # [ 43.946722] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1411machine # [ 43.951347] systemd[1]: Starting Create SUID/SGID Wrappers...1412machine # [ 43.954809] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1413machine # [ 43.961329] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671414machine # [ 43.963613] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1415machine # [ 43.969953] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1416machine # [ 43.971327] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1417machine # [ 43.974405] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1418machine # [ 43.975731] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1419machine # [ 43.978067] systemd[1]: Reached target Remote File Systems.1420machine # [ 44.146177] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1421machine # [ 44.151057] systemd[1]: Finished Create SUID/SGID Wrappers.1422machine # [ 44.153504] systemd[1]: Starting linger-users.service...1423machine # [ 44.196177] systemd[1]: linger-users.service: Deactivated successfully.1424machine # [ 44.198891] systemd[1]: Finished linger-users.service.1425machine # [ 44.458140] nixos[2454]: finished switching to system configuration /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test1426machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.87 seconds)1427machine: must succeed: /nix/store/3srgvgzzlxwkafi9bn5xxv8l14l87k3z-separate-activation-script/bin/switch-to-configuration test 2>&11428machine # [ 44.754897] nixos[2594]: switching to system configuration /nix/store/1bv29wfflkn9clfg2wriq926b4x2k8j4-nixos-system-machine-test1429machine # [ 44.757613] systemd[1]: Stopped target Remote File Systems.1430machine # [ 44.759840] systemd[1]: Stopped target Local File Systems.1431machine # [ 45.097013] systemd[1]: Reload requested from client PID 2594 ('.switch-to-conf') (unit backdoor.service)...1432machine # [ 45.099308] systemd[1]: Reloading...1433machine # [ 45.445773] systemd[1]: Reloading finished in 344 ms.1434machine # [ 45.539674] systemd[568]: Stopped Run user-specific NixOS activation.1435machine # [ 45.541793] systemd[568]: Reexecution requested from client PID 2664 ('switch-to-confi')...1436machine # [ 45.545493] systemd[568]: Reexecuting.1437machine # [ 45.603598] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1438machine # [ 45.727238] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1439machine # [ 45.733994] systemd[568]: Reload requested from client PID 2664 ('switch-to-confi')...1440machine # [ 45.736491] systemd[568]: Reloading...1441machine # [ 45.848058] systemd[568]: Reloading finished in 110 ms.1442machine # [ 45.864244] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1443machine # [ 45.876228] systemd[1]: Stopped target Reactivate sysinit units.1444machine # [ 45.878559] systemd[1]: Stopping Reactivate sysinit units...1445machine # [ 45.879467] systemd[1]: Reached target Reactivate sysinit units.1446machine # [ 45.882400] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1447machine # [ 45.883804] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1448machine # [ 45.887020] systemd[1]: Reached target Local File Systems.1449machine # [ 45.891633] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1450machine # [ 45.900691] systemd[1]: Starting Create SUID/SGID Wrappers...1451machine # [ 45.901605] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1452machine # [ 45.902832] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671453machine # [ 45.912639] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1454machine # [ 45.914360] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1455machine # [ 45.915662] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1456machine # [ 45.919311] systemd[1]: Reached target Remote File Systems.1457machine # [ 46.085094] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1458machine # [ 46.088504] systemd[1]: Finished Create SUID/SGID Wrappers.1459machine # [ 46.092475] systemd[1]: Starting linger-users.service...1460machine # [ 46.100672] systemd[1]: Starting test.service...1461machine # [ 46.135909] systemd[1]: Finished test.service.1462machine # [ 46.155622] systemd[1]: linger-users.service: Deactivated successfully.1463machine # [ 46.159188] systemd[1]: Finished linger-users.service.1464machine # [ 46.419004] nixos[2594]: finished switching to system configuration /nix/store/1bv29wfflkn9clfg2wriq926b4x2k8j4-nixos-system-machine-test1465machine: (finished: must succeed: /nix/store/3srgvgzzlxwkafi9bn5xxv8l14l87k3z-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.96 seconds)1466machine: must succeed: ! test -e /run/current-system/activate1467machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.04 seconds)1468machine: must succeed: ! test -e /run/current-system/dry-activate1469machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.03 seconds)1470machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration1471machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.03 seconds)1472machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&11473machine # [ 46.797460] nixos[2743]: switching to system configuration /nix/store/bj671x7sizpfcqslphs57rdwq73bclv9-nixos-system-machine-test1474machine # [ 46.800448] systemd[1]: Stopped target Remote File Systems.1475machine # [ 46.803671] systemd[1]: test.service: Deactivated successfully.1476machine # [ 46.806550] systemd[1]: Stopped test.service.1477machine # [ 46.807390] systemd[1]: Stopped target Local File Systems.1478machine # [ 47.142931] systemd[1]: Reload requested from client PID 2743 ('.switch-to-conf') (unit backdoor.service)...1479machine # [ 47.145287] systemd[1]: Reloading...1480machine # [ 47.505833] systemd[1]: Reloading finished in 358 ms.1481machine # [ 47.601359] systemd[568]: Reexecution requested from client PID 2812 ('switch-to-confi')...1482machine # [ 47.605652] systemd[568]: Reexecuting.1483machine # [ 47.651309] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1484machine # [ 47.772321] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1485machine # [ 47.779106] systemd[568]: Reload requested from client PID 2812 ('switch-to-confi')...1486machine # [ 47.783008] systemd[568]: Reloading...1487machine # [ 47.899325] systemd[568]: Reloading finished in 117 ms.1488machine # [ 47.912179] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1489machine # [ 47.922387] systemd[568]: Starting Run user-specific NixOS activation...1490machine # [ 47.959435] systemd[568]: Finished Run user-specific NixOS activation.1491machine # [ 47.964126] systemd[568]: Stopped Run user-specific NixOS activation.1492machine # [ 47.965164] systemd[568]: Stopping Run user-specific NixOS activation...1493machine # [ 47.967591] systemd[568]: Starting Run user-specific NixOS activation...1494machine # [ 47.973265] systemd[1]: Stopped target Reactivate sysinit units.1495machine # [ 47.976257] systemd[1]: Stopping Reactivate sysinit units...1496machine # [ 47.977162] systemd[1]: Reached target Reactivate sysinit units.1497machine # [ 47.980081] systemd[1]: Reached target Local File Systems.1498machine # [ 47.982808] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1499machine # [ 47.992282] systemd[1]: Starting Create SUID/SGID Wrappers...1500machine # [ 47.993215] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1501machine # [ 47.994498] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671502machine # [ 48.016904] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1503machine # [ 48.018692] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1504machine # [ 48.021596] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1505machine # [ 48.024930] systemd[1]: Reached target Remote File Systems.1506machine # [ 48.045127] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1507machine # [ 48.046630] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1508machine # [ 48.052401] systemd[568]: Finished Run user-specific NixOS activation.1509machine # [ 48.218383] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1510machine # [ 48.223335] systemd[1]: Finished Create SUID/SGID Wrappers.1511machine # [ 48.227126] systemd[1]: Starting linger-users.service...1512machine # [ 48.230288] systemd[1]: Started test.service.1513machine # [ 48.272585] systemd[1]: test.service: Deactivated successfully.1514machine # [ 48.293497] systemd[1]: linger-users.service: Deactivated successfully.1515machine # [ 48.295220] systemd[1]: Finished linger-users.service.1516machine # [ 48.555442] nixos[2743]: finished switching to system configuration /nix/store/bj671x7sizpfcqslphs57rdwq73bclv9-nixos-system-machine-test1517machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 2.04 seconds)1518machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&11519machine # [ 48.900121] nixos[2888]: switching to system configuration /nix/store/vzw9w24k9yy39f5zmr7ap7gg4skj4dqk-nixos-system-machine-test1520machine # [ 48.902744] systemd[1]: Stopped target Remote File Systems.1521machine # [ 48.905496] systemd[1]: Stopped target Local File Systems.1522machine # [ 49.229379] systemd[1]: Reload requested from client PID 2888 ('.switch-to-conf') (unit backdoor.service)...1523machine # [ 49.231398] systemd[1]: Reloading...1524machine # [ 49.592805] systemd[1]: Reloading finished in 359 ms.1525machine # [ 49.684566] systemd[568]: Reexecution requested from client PID 2957 ('switch-to-confi')...1526machine # [ 49.688427] systemd[568]: Reexecuting.1527machine # [ 49.743409] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1528machine # [ 49.872088] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1529machine # [ 49.879279] systemd[568]: Reload requested from client PID 2957 ('switch-to-confi')...1530machine # [ 49.883362] systemd[568]: Reloading...1531machine # [ 50.004068] systemd[568]: Reloading finished in 121 ms.1532machine # [ 50.020185] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1533machine # [ 50.031719] systemd[568]: Stopped Run user-specific NixOS activation.1534machine # [ 50.034258] systemd[568]: Stopping Run user-specific NixOS activation...1535machine # [ 50.036309] systemd[568]: Starting Run user-specific NixOS activation...1536machine # [ 50.070050] systemd[568]: Finished Run user-specific NixOS activation.1537machine # [ 50.074372] systemd[1]: Stopped target Reactivate sysinit units.1538machine # [ 50.077173] systemd[1]: Stopping Reactivate sysinit units...1539machine # [ 50.078073] systemd[1]: Reached target Reactivate sysinit units.1540machine # [ 50.078961] systemd[1]: Reached target Remote File Systems.1541machine # [ 50.084102] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1542machine # [ 50.085567] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1543machine # [ 50.090860] systemd[1]: Reached target Local File Systems.1544machine # [ 50.094426] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1545machine # [ 50.098710] systemd[1]: Starting Create SUID/SGID Wrappers...1546machine # [ 50.099648] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1547machine # [ 50.108974] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671548machine # [ 50.111266] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1549machine # [ 50.114521] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1550machine # [ 50.115839] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1551machine # [ 50.287412] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1552machine # [ 50.294349] systemd[1]: Finished Create SUID/SGID Wrappers.1553machine # [ 50.295252] systemd[1]: Starting escaped\x2ddash.service...1554machine # [ 50.297970] systemd[1]: Starting linger-users.service...1555machine # [ 50.337339] systemd[1]: Finished escaped\x2ddash.service.1556machine # [ 50.356166] systemd[1]: linger-users.service: Deactivated successfully.1557machine # [ 50.359153] systemd[1]: Finished linger-users.service.1558machine # [ 50.619058] nixos[2888]: finished switching to system configuration /nix/store/vzw9w24k9yy39f5zmr7ap7gg4skj4dqk-nixos-system-machine-test1559machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 2.06 seconds)1560machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&11561machine # [ 50.936600] nixos[3030]: switching to system configuration /nix/store/nwaj0js2z1i8qwp3cw3y4lgacda53v1r-nixos-system-machine-test1562machine # [ 50.939176] systemd[1]: Stopped target Remote File Systems.1563machine # [ 50.942711] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1564machine # [ 50.943792] systemd[1]: Stopped escaped\x2ddash.service.1565machine # [ 50.945358] systemd[1]: Stopped target Local File Systems.1566machine # [ 51.255471] systemd[1]: Reload requested from client PID 3030 ('.switch-to-conf') (unit backdoor.service)...1567machine # [ 51.257655] systemd[1]: Reloading...1568machine # [ 51.615946] systemd[1]: Reloading finished in 356 ms.1569machine # [ 51.708885] systemd[568]: Reexecution requested from client PID 3099 ('switch-to-confi')...1570machine # [ 51.713332] systemd[568]: Reexecuting.1571machine # [ 51.776155] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1572machine # [ 51.901438] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1573machine # [ 51.908467] systemd[568]: Reload requested from client PID 3099 ('switch-to-confi')...1574machine # [ 51.912092] systemd[568]: Reloading...1575machine # [ 52.031398] systemd[568]: Reloading finished in 118 ms.1576machine # [ 52.045786] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1577machine # [ 52.053505] systemd[568]: Stopped Run user-specific NixOS activation.1578machine # [ 52.056212] systemd[568]: Stopping Run user-specific NixOS activation...1579machine # [ 52.058557] systemd[568]: Starting Run user-specific NixOS activation...1580machine # [ 52.094702] systemd[568]: Finished Run user-specific NixOS activation.1581machine # [ 52.098964] systemd[1]: Stopped target Reactivate sysinit units.1582machine # [ 52.101792] systemd[1]: Stopping Reactivate sysinit units...1583machine # [ 52.102699] systemd[1]: Reached target Reactivate sysinit units.1584machine # [ 52.108082] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1585machine # [ 52.109442] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1586machine # [ 52.116198] systemd[1]: Reached target Remote File Systems.1587machine # [ 52.120221] systemd[1]: Starting escaped\x2ddash.service...1588machine # [ 52.123858] systemd[1]: Starting linger-users.service...1589machine # [ 52.128665] systemd[1]: Reached target Local File Systems.1590machine # [ 52.132193] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1591machine # [ 52.144589] systemd[1]: Starting Create SUID/SGID Wrappers...1592machine # [ 52.149496] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1593machine # [ 52.150853] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671594machine # [ 52.157991] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1595machine # [ 52.159662] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1596machine # [ 52.161037] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1597machine # [ 52.202450] systemd[1]: Finished escaped\x2ddash.service.1598machine # [ 52.234349] systemd[1]: linger-users.service: Deactivated successfully.1599machine # [ 52.237844] systemd[1]: Finished linger-users.service.1600machine # [ 52.381104] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1601machine # [ 52.383294] systemd[1]: Finished Create SUID/SGID Wrappers.1602machine # [ 52.645408] nixos[3030]: finished switching to system configuration /nix/store/nwaj0js2z1i8qwp3cw3y4lgacda53v1r-nixos-system-machine-test1603machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 2.03 seconds)1604machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&11605machine # [ 52.982581] nixos[3172]: switching to system configuration /nix/store/wnhr7ax9mz909pc8dzp75sycwi38azqz-nixos-system-machine-test1606machine # [ 52.985755] systemd[1]: Stopped target Local File Systems.1607machine # [ 52.987406] systemd[1]: Stopped target Remote File Systems.1608machine # [ 52.990254] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1609machine # [ 52.991284] systemd[1]: Stopped escaped\x2ddash.service.1610machine # [ 53.278407] systemd[1]: Reload requested from client PID 3172 ('.switch-to-conf') (unit backdoor.service)...1611machine # [ 53.280513] systemd[1]: Reloading...1612machine # [ 53.621845] systemd[1]: Reloading finished in 339 ms.1613machine # [ 53.715864] systemd[568]: Reexecution requested from client PID 3241 ('switch-to-confi')...1614machine # [ 53.719799] systemd[568]: Reexecuting.1615machine # [ 53.764139] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1616machine # [ 53.881058] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1617machine # [ 53.887513] systemd[568]: Reload requested from client PID 3241 ('switch-to-confi')...1618machine # [ 53.891589] systemd[568]: Reloading...1619machine # [ 54.005853] systemd[568]: Reloading finished in 115 ms.1620machine # [ 54.024326] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1621machine # [ 54.034193] systemd[568]: Stopped Run user-specific NixOS activation.1622machine # [ 54.037033] systemd[568]: Stopping Run user-specific NixOS activation...1623machine # [ 54.039291] systemd[568]: Starting Run user-specific NixOS activation...1624machine # [ 54.077644] systemd[568]: Finished Run user-specific NixOS activation.1625machine # [ 54.082073] systemd[1]: Stopped target Reactivate sysinit units.1626machine # [ 54.085842] systemd[1]: Stopping Reactivate sysinit units...1627machine # [ 54.086790] systemd[1]: Reached target Reactivate sysinit units.1628machine # [ 54.090782] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1629machine # [ 54.094239] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1630machine # [ 54.097032] systemd[1]: Reached target Local File Systems.1631machine # [ 54.101915] systemd[1]: Reached target Remote File Systems.1632machine # [ 54.104328] systemd[1]: Starting -.service...1633machine # [ 54.108726] systemd[1]: Starting linger-users.service...1634machine # [ 54.124801] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1635machine # [ 54.133712] systemd[1]: Starting Create SUID/SGID Wrappers...1636machine # [ 54.134708] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1637machine # [ 54.136005] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671638machine # [ 54.143791] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1639machine # [ 54.149224] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1640machine # [ 54.154483] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1641machine # [ 54.186428] systemd[1]: Finished -.service.1642machine # [ 54.226038] systemd[1]: linger-users.service: Deactivated successfully.1643machine # [ 54.230679] systemd[1]: Finished linger-users.service.1644machine # [ 54.375512] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1645machine # [ 54.379171] systemd[1]: Finished Create SUID/SGID Wrappers.1646machine # [ 54.638351] nixos[3172]: finished switching to system configuration /nix/store/wnhr7ax9mz909pc8dzp75sycwi38azqz-nixos-system-machine-test1647machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.99 seconds)1648machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&11649machine # [ 54.929596] nixos[3314]: switching to system configuration /nix/store/6972bllwsvw66pyj58igbh91sjywwij6-nixos-system-machine-test1650machine # [ 54.933368] systemd[1]: Stopped target Local File Systems.1651machine # [ 54.935133] systemd[1]: Stopped target Remote File Systems.1652machine # [ 55.231600] systemd[1]: Reload requested from client PID 3314 ('.switch-to-conf') (unit backdoor.service)...1653machine # [ 55.233750] systemd[1]: Reloading...1654machine # [ 55.614689] systemd[1]: Reloading finished in 379 ms.1655machine # [ 55.706293] systemd[568]: Reexecution requested from client PID 3383 ('switch-to-confi')...1656machine # [ 55.710076] systemd[568]: Reexecuting.1657machine # [ 55.759632] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1658machine # [ 55.875405] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1659machine # [ 55.882332] systemd[568]: Reload requested from client PID 3383 ('switch-to-confi')...1660machine # [ 55.886345] systemd[568]: Reloading...1661machine # [ 56.000765] systemd[568]: Reloading finished in 115 ms.1662machine # [ 56.016192] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1663machine # [ 56.025341] systemd[568]: Stopped Run user-specific NixOS activation.1664machine # [ 56.027944] systemd[568]: Stopping Run user-specific NixOS activation...1665machine # [ 56.030362] systemd[568]: Starting Run user-specific NixOS activation...1666machine # [ 56.061214] systemd[568]: Finished Run user-specific NixOS activation.1667machine # [ 56.065135] systemd[1]: Stopped target Reactivate sysinit units.1668machine # [ 56.068329] systemd[1]: Stopping Reactivate sysinit units...1669machine # [ 56.069228] systemd[1]: Reached target Reactivate sysinit units.1670machine # [ 56.072736] systemd[1]: Reloading -.service...1671machine # [ 56.098569] systemd[1]: Reloaded -.service.1672machine # [ 56.102626] systemd[1]: Reached target Remote File Systems.1673machine # [ 56.105277] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1674machine # [ 56.109451] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1675machine # [ 56.112928] systemd[1]: Reached target Local File Systems.1676machine # [ 56.116543] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1677machine # [ 56.119935] systemd[1]: Starting Create SUID/SGID Wrappers...1678machine # [ 56.124494] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1679machine # [ 56.125776] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671680machine # [ 56.127973] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1681machine # [ 56.137100] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1682machine # [ 56.138419] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1683machine # [ 56.305955] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1684machine # [ 56.310833] systemd[1]: Finished Create SUID/SGID Wrappers.1685machine # [ 56.313043] systemd[1]: Starting linger-users.service...1686machine # [ 56.353995] systemd[1]: linger-users.service: Deactivated successfully.1687machine # [ 56.357124] systemd[1]: Finished linger-users.service.1688machine # [ 56.614213] nixos[3314]: finished switching to system configuration /nix/store/6972bllwsvw66pyj58igbh91sjywwij6-nixos-system-machine-test1689machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.98 seconds)1690machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&11691machine # [ 56.916890] nixos[3456]: switching to system configuration /nix/store/mxjwscichssschxcpch8hnyn0ykj96rr-nixos-system-machine-test1692machine # [ 56.919455] systemd[1]: Stopped target Local File Systems.1693machine # [ 56.922054] systemd[1]: -.service: Deactivated successfully.1694machine # [ 56.923000] systemd[1]: Stopped -.service.1695machine # [ 56.924631] systemd[1]: Stopped target Remote File Systems.1696machine # [ 57.211962] systemd[1]: Reload requested from client PID 3456 ('.switch-to-conf') (unit backdoor.service)...1697machine # [ 57.214568] systemd[1]: Reloading...1698machine # [ 57.555536] systemd[1]: Reloading finished in 339 ms.1699machine # [ 57.644464] systemd[568]: Reexecution requested from client PID 3525 ('switch-to-confi')...1700machine # [ 57.648295] systemd[568]: Reexecuting.1701machine # [ 57.703980] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1702machine # [ 57.825787] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1703machine # [ 57.832433] systemd[568]: Reload requested from client PID 3525 ('switch-to-confi')...1704machine # [ 57.836100] systemd[568]: Reloading...1705machine # [ 57.948172] systemd[568]: Reloading finished in 112 ms.1706machine # [ 57.964256] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1707machine # [ 57.973633] systemd[568]: Stopped Run user-specific NixOS activation.1708machine # [ 57.976146] systemd[568]: Stopping Run user-specific NixOS activation...1709machine # [ 57.978604] systemd[568]: Starting Run user-specific NixOS activation...1710machine # [ 58.018023] systemd[568]: Finished Run user-specific NixOS activation.1711machine # [ 58.022904] systemd[1]: Stopped target Reactivate sysinit units.1712machine # [ 58.025045] systemd[1]: Stopping Reactivate sysinit units...1713machine # [ 58.025988] systemd[1]: Reached target Reactivate sysinit units.1714machine # [ 58.031325] systemd[1]: Reached target Local File Systems.1715machine # [ 58.036191] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1716machine # [ 58.040984] systemd[1]: Starting Create SUID/SGID Wrappers...1717machine # [ 58.042025] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1718machine # [ 58.043316] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671719machine # [ 58.061915] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1720machine # [ 58.063706] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1721machine # [ 58.066739] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1722machine # [ 58.068227] systemd[1]: Reached target Remote File Systems.1723machine # [ 58.069030] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1724machine # [ 58.070339] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1725machine # [ 58.281258] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1726machine # [ 58.283164] systemd[1]: Finished Create SUID/SGID Wrappers.1727machine # [ 58.290640] systemd[1]: Starting linger-users.service...1728machine # [ 58.295250] systemd[1]: Starting required-service.service...1729machine # [ 58.298391] systemd[1]: Starting test-service.service...1730machine # [ 58.362926] systemd[1]: Finished required-service.service.1731machine # [ 58.367313] systemd[1]: Finished test-service.service.1732machine # [ 58.389922] systemd[1]: linger-users.service: Deactivated successfully.1733machine # [ 58.391762] systemd[1]: Finished linger-users.service.1734machine # [ 58.654041] nixos[3456]: finished switching to system configuration /nix/store/mxjwscichssschxcpch8hnyn0ykj96rr-nixos-system-machine-test1735machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 2.04 seconds)1736machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&11737machine # [ 58.965721] nixos[3600]: switching to system configuration /nix/store/xbn1p6vyrcfrr4dvrpjg110bmjq6vfba-nixos-system-machine-test1738machine # [ 58.968651] systemd[1]: Stopped target Remote File Systems.1739machine # [ 58.973673] systemd[1]: Stopped target Local File Systems.1740machine # [ 58.974801] systemd[1]: required-service.service: Deactivated successfully.1741machine # [ 58.975830] systemd[1]: Stopped required-service.service.1742machine # [ 58.977756] systemd[1]: test-service.service: Deactivated successfully.1743machine # [ 58.980146] systemd[1]: Stopped test-service.service.1744machine # [ 59.286830] systemd[1]: Reload requested from client PID 3600 ('.switch-to-conf') (unit backdoor.service)...1745machine # [ 59.288996] systemd[1]: Reloading...1746machine # [ 59.642885] systemd[1]: Reloading finished in 352 ms.1747machine # [ 59.739961] systemd[568]: Reexecution requested from client PID 3669 ('switch-to-confi')...1748machine # [ 59.744633] systemd[568]: Reexecuting.1749machine # [ 59.799986] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1750machine # [ 59.927277] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1751machine # [ 59.935352] systemd[568]: Reload requested from client PID 3669 ('switch-to-confi')...1752machine # [ 59.938774] systemd[568]: Reloading...1753machine # [ 60.053903] systemd[568]: Reloading finished in 116 ms.1754machine # [ 60.068440] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1755machine # [ 60.080110] systemd[568]: Stopped Run user-specific NixOS activation.1756machine # [ 60.081253] systemd[568]: Stopping Run user-specific NixOS activation...1757machine # [ 60.084449] systemd[568]: Starting Run user-specific NixOS activation...1758machine # [ 60.127917] systemd[568]: Finished Run user-specific NixOS activation.1759machine # [ 60.133728] systemd[1]: Stopped target Reactivate sysinit units.1760machine # [ 60.136691] systemd[1]: Stopping Reactivate sysinit units...1761machine # [ 60.137684] systemd[1]: Reached target Reactivate sysinit units.1762machine # [ 60.145158] systemd[1]: Starting required-service.service...1763machine # [ 60.150289] systemd[1]: Starting test-service.service...1764machine # [ 60.157832] systemd[1]: Reached target Remote File Systems.1765machine # [ 60.171734] systemd[1]: Reached target Local File Systems.1766machine # [ 60.176267] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1767machine # [ 60.177850] systemd[1]: Starting Create SUID/SGID Wrappers...1768machine # [ 60.178678] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1769machine # [ 60.179979] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671770machine # [ 60.204389] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1771machine # [ 60.206170] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1772machine # [ 60.219767] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1773machine # [ 60.227613] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1774machine # [ 60.235178] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1775machine # [ 60.251726] systemd[1]: Finished test-service.service.1776machine # [ 60.254056] systemd[1]: Finished required-service.service.1777machine # [ 60.433918] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1778machine # [ 60.437110] systemd[1]: Finished Create SUID/SGID Wrappers.1779machine # [ 60.441760] systemd[1]: Starting linger-users.service...1780machine # [ 60.496803] systemd[1]: linger-users.service: Deactivated successfully.1781machine # [ 60.499785] systemd[1]: Finished linger-users.service.1782machine # [ 60.756603] nixos[3600]: finished switching to system configuration /nix/store/xbn1p6vyrcfrr4dvrpjg110bmjq6vfba-nixos-system-machine-test1783machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 2.10 seconds)1784machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&11785machine # [ 61.038315] nixos[3744]: switching to system configuration /nix/store/s50bi1p0h5d9cyjrv2jcf8kc77qbkbic-nixos-system-machine-test1786machine # [ 61.040997] systemd[1]: Stopped target Local File Systems.1787machine # [ 61.045623] systemd[1]: Stopped target Remote File Systems.1788machine # [ 61.046544] systemd[1]: required-service.service: Deactivated successfully.1789machine # [ 61.047596] systemd[1]: Stopped required-service.service.1790machine # [ 61.048888] systemd[1]: test-service.service: Deactivated successfully.1791machine # [ 61.050914] systemd[1]: Stopped test-service.service.1792machine # [ 61.349958] systemd[1]: Reload requested from client PID 3744 ('.switch-to-conf') (unit backdoor.service)...1793machine # [ 61.351944] systemd[1]: Reloading...1794machine # [ 61.694357] systemd[1]: Reloading finished in 340 ms.1795machine # [ 61.783881] systemd[568]: Reexecution requested from client PID 3813 ('switch-to-confi')...1796machine # [ 61.787585] systemd[568]: Reexecuting.1797machine # [ 61.839452] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1798machine # [ 61.956833] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1799machine # [ 61.963359] systemd[568]: Reload requested from client PID 3813 ('switch-to-confi')...1800machine # [ 61.966702] systemd[568]: Reloading...1801machine # [ 62.075996] systemd[568]: Reloading finished in 110 ms.1802machine # [ 62.088153] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1803machine # [ 62.098379] systemd[568]: Stopped Run user-specific NixOS activation.1804machine # [ 62.100664] systemd[568]: Stopping Run user-specific NixOS activation...1805machine # [ 62.102717] systemd[568]: Starting Run user-specific NixOS activation...1806machine # [ 62.135680] systemd[568]: Finished Run user-specific NixOS activation.1807machine # [ 62.139575] systemd[1]: Stopped target Reactivate sysinit units.1808machine # [ 62.141458] systemd[1]: Stopping Reactivate sysinit units...1809machine # [ 62.142283] systemd[1]: Reached target Reactivate sysinit units.1810machine # [ 62.146387] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1811machine # [ 62.147755] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1812machine # [ 62.150020] systemd[1]: Reached target Remote File Systems.1813machine # [ 62.155645] systemd[1]: Reached target Local File Systems.1814machine # [ 62.159077] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1815machine # [ 62.162852] systemd[1]: Starting Create SUID/SGID Wrappers...1816machine # [ 62.163707] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1817machine # [ 62.172794] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671818machine # [ 62.174999] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1819machine # [ 62.179859] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1820machine # [ 62.181312] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1821machine # [ 62.340105] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1822machine # [ 62.344472] systemd[1]: Finished Create SUID/SGID Wrappers.1823machine # [ 62.347669] systemd[1]: Starting linger-users.service...1824machine # [ 62.351665] systemd[1]: Starting required-service.service...1825machine # [ 62.356533] systemd[1]: Starting test-service.service...1826machine # [ 62.403972] systemd[1]: Finished required-service.service.1827machine # [ 62.407372] systemd[1]: Finished test-service.service.1828machine # [ 62.423586] systemd[1]: linger-users.service: Deactivated successfully.1829machine # [ 62.426457] systemd[1]: Finished linger-users.service.1830machine # [ 62.683182] nixos[3744]: finished switching to system configuration /nix/store/s50bi1p0h5d9cyjrv2jcf8kc77qbkbic-nixos-system-machine-test1831machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.93 seconds)1832machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&11833machine # [ 62.977549] nixos[3888]: switching to system configuration /nix/store/j7f25ik3lp1zxlvv502y7qydkcvkm6h6-nixos-system-machine-test1834machine # [ 62.980066] systemd[1]: Stopped target Local File Systems.1835machine # [ 62.982511] systemd[1]: test-service.service: Deactivated successfully.1836machine # [ 62.983520] systemd[1]: Stopped test-service.service.1837machine # [ 62.986166] systemd[1]: Stopped target Remote File Systems.1838machine # [ 62.987004] systemd[1]: required-service.service: Deactivated successfully.1839machine # [ 62.987937] systemd[1]: Stopped required-service.service.1840machine # [ 63.267845] systemd[1]: Reload requested from client PID 3888 ('.switch-to-conf') (unit backdoor.service)...1841machine # [ 63.269988] systemd[1]: Reloading...1842machine # [ 63.598466] systemd[1]: Reloading finished in 326 ms.1843machine # [ 63.686009] systemd[568]: Reexecution requested from client PID 3956 ('switch-to-confi')...1844machine # [ 63.687393] systemd[568]: Reexecuting.1845machine # [ 63.743431] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1846machine # [ 63.858240] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1847machine # [ 63.864453] systemd[568]: Reload requested from client PID 3956 ('switch-to-confi')...1848machine # [ 63.866573] systemd[568]: Reloading...1849machine # [ 63.975085] systemd[568]: Reloading finished in 108 ms.1850machine # [ 63.996170] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1851machine # [ 64.006125] systemd[568]: Stopped Run user-specific NixOS activation.1852machine # [ 64.008476] systemd[568]: Stopping Run user-specific NixOS activation...1853machine # [ 64.010522] systemd[568]: Starting Run user-specific NixOS activation...1854machine # [ 64.043484] systemd[568]: Finished Run user-specific NixOS activation.1855machine # [ 64.046956] systemd[1]: Stopped target Reactivate sysinit units.1856machine # [ 64.048854] systemd[1]: Stopping Reactivate sysinit units...1857machine # [ 64.049686] systemd[1]: Reached target Reactivate sysinit units.1858machine # [ 64.053719] systemd[1]: Reached target Local File Systems.1859machine # [ 64.056463] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1860machine # [ 64.060600] systemd[1]: Starting Create SUID/SGID Wrappers...1861machine # [ 64.061469] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1862machine # [ 64.062652] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671863machine # [ 64.078830] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1864machine # [ 64.081892] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1865machine # [ 64.083191] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1866machine # [ 64.084430] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1867machine # [ 64.085672] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1868machine # [ 64.086950] systemd[1]: Reached target Remote File Systems.1869machine # [ 64.087722] systemd[1]: Created slice Slice /system/instantiated.1870machine # [ 64.241152] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1871machine # [ 64.245952] systemd[1]: Finished Create SUID/SGID Wrappers.1872machine # [ 64.248286] systemd[1]: Starting instantiated@one.service...1873machine # [ 64.252601] systemd[1]: Starting instantiated@two.service...1874machine # [ 64.263426] systemd[1]: Starting linger-users.service...1875machine # [ 64.305581] systemd[1]: Finished instantiated@one.service.1876machine # [ 64.308118] systemd[1]: Finished instantiated@two.service.1877machine # [ 64.326259] systemd[1]: linger-users.service: Deactivated successfully.1878machine # [ 64.327870] systemd[1]: Finished linger-users.service.1879machine # [ 64.588810] nixos[3888]: finished switching to system configuration /nix/store/j7f25ik3lp1zxlvv502y7qydkcvkm6h6-nixos-system-machine-test1880machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.90 seconds)1881machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&11882machine # [ 64.913208] nixos[4032]: switching to system configuration /nix/store/bf57wrym2alqassxmh77vbp369n3wb9d-nixos-system-machine-test1883machine # [ 64.916308] systemd[1]: Stopped target Local File Systems.1884machine # [ 64.919641] systemd[1]: Stopped target Remote File Systems.1885machine # [ 64.922428] systemd[1]: instantiated@one.service: Deactivated successfully.1886machine # [ 64.923479] systemd[1]: Stopped instantiated@one.service.1887machine # [ 64.924929] systemd[1]: instantiated@two.service: Deactivated successfully.1888machine # [ 64.925943] systemd[1]: Stopped instantiated@two.service.1889machine # [ 65.226128] systemd[1]: Reload requested from client PID 4032 ('.switch-to-conf') (unit backdoor.service)...1890machine # [ 65.228421] systemd[1]: Reloading...1891machine # [ 65.587950] systemd[1]: Reloading finished in 357 ms.1892machine # [ 65.680454] systemd[568]: Reexecution requested from client PID 4101 ('switch-to-confi')...1893machine # [ 65.684333] systemd[568]: Reexecuting.1894machine # [ 65.734989] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1895machine # [ 65.856923] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1896machine # [ 65.863713] systemd[568]: Reload requested from client PID 4101 ('switch-to-confi')...1897machine # [ 65.868070] systemd[568]: Reloading...1898machine # [ 65.982998] systemd[568]: Reloading finished in 116 ms.1899machine # [ 66.000190] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1900machine # [ 66.009570] systemd[568]: Stopped Run user-specific NixOS activation.1901machine # [ 66.012279] systemd[568]: Stopping Run user-specific NixOS activation...1902machine # [ 66.014578] systemd[568]: Starting Run user-specific NixOS activation...1903machine # [ 66.052340] systemd[568]: Finished Run user-specific NixOS activation.1904machine # [ 66.057487] systemd[1]: Stopped target Reactivate sysinit units.1905machine # [ 66.061058] systemd[1]: Stopping Reactivate sysinit units...1906machine # [ 66.062626] systemd[1]: Reached target Reactivate sysinit units.1907machine # [ 66.065084] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1908machine # [ 66.066439] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1909machine # [ 66.069504] systemd[1]: Reached target Remote File Systems.1910machine # [ 66.074998] systemd[1]: Starting instantiated@two.service...1911machine # [ 66.097409] systemd[1]: Starting instantiated@one.service...1912machine # [ 66.104673] systemd[1]: Starting linger-users.service...1913machine # [ 66.119362] systemd[1]: Reached target Local File Systems.1914machine # [ 66.129951] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1915machine # [ 66.131499] systemd[1]: Starting Create SUID/SGID Wrappers...1916machine # [ 66.137731] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1917machine # [ 66.139034] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671918machine # [ 66.156371] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1919machine # [ 66.158165] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1920machine # [ 66.159607] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1921machine # [ 66.172547] systemd[1]: Finished instantiated@two.service.1922machine # [ 66.173450] systemd[1]: Finished instantiated@one.service.1923machine # [ 66.211114] systemd[1]: linger-users.service: Deactivated successfully.1924machine # [ 66.216277] systemd[1]: Finished linger-users.service.1925machine # [ 66.353594] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1926machine # [ 66.355408] systemd[1]: Finished Create SUID/SGID Wrappers.1927machine # [ 66.614989] nixos[4032]: finished switching to system configuration /nix/store/bf57wrym2alqassxmh77vbp369n3wb9d-nixos-system-machine-test1928machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 2.03 seconds)1929(finished: subtest: services, in 42.19 seconds)1930subtest: failing units1931machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11932machine # [ 66.900644] nixos[4176]: switching to system configuration /nix/store/b8v4dzxsp98n1mrz3y8s56yix8lk2gz1-nixos-system-machine-test1933machine # [ 66.903243] systemd[1]: instantiated@two.service: Deactivated successfully.1934machine # [ 66.908300] systemd[1]: Stopped instantiated@two.service.1935machine # [ 66.909197] systemd[1]: Stopped target Remote File Systems.1936machine # [ 66.910021] systemd[1]: Stopped target Local File Systems.1937machine # [ 66.910795] systemd[1]: instantiated@one.service: Deactivated successfully.1938machine # [ 66.911772] systemd[1]: Stopped instantiated@one.service.1939machine # [ 67.184526] systemd[1]: Reload requested from client PID 4176 ('.switch-to-conf') (unit backdoor.service)...1940machine # [ 67.186128] systemd[1]: Reloading...1941machine # [ 67.518507] systemd[1]: Reloading finished in 331 ms.1942machine # [ 67.612442] systemd[568]: Reexecution requested from client PID 4245 ('switch-to-confi')...1943machine # [ 67.616436] systemd[568]: Reexecuting.1944machine # [ 67.675798] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1945machine # [ 67.797144] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1946machine # [ 67.803706] systemd[568]: Reload requested from client PID 4245 ('switch-to-confi')...1947machine # [ 67.807754] systemd[568]: Reloading...1948machine # [ 67.921737] systemd[568]: Reloading finished in 113 ms.1949machine # [ 67.936235] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1950machine # [ 67.946966] systemd[568]: Stopped Run user-specific NixOS activation.1951machine # [ 67.949614] systemd[568]: Stopping Run user-specific NixOS activation...1952machine # [ 67.951983] systemd[568]: Starting Run user-specific NixOS activation...1953machine # [ 67.986517] systemd[568]: Finished Run user-specific NixOS activation.1954machine # [ 67.990769] systemd[1]: Stopped target Reactivate sysinit units.1955machine # [ 67.994378] systemd[1]: Stopping Reactivate sysinit units...1956machine # [ 67.995402] systemd[1]: Reached target Reactivate sysinit units.1957machine # [ 67.997915] systemd[1]: Reached target Remote File Systems.1958machine # [ 68.001848] systemd[1]: Reached target Local File Systems.1959machine # [ 68.005926] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1960machine # [ 68.007377] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1961machine # [ 68.008910] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1962machine # [ 68.012440] systemd[1]: Starting Create SUID/SGID Wrappers...1963machine # [ 68.013359] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1964machine # [ 68.014677] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671965machine # [ 68.030313] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1966machine # [ 68.033044] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1967machine # [ 68.034391] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1968machine # [ 68.218107] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1969machine # [ 68.221380] systemd[1]: Finished Create SUID/SGID Wrappers.1970machine # [ 68.227702] systemd[1]: Starting linger-users.service...1971machine # [ 68.230642] systemd[1]: Starting test.service...1972machine # [ 68.278548] systemd[1]: Finished test.service.1973machine # [ 68.301235] systemd[1]: linger-users.service: Deactivated successfully.1974machine # [ 68.303080] systemd[1]: Finished linger-users.service.1975machine # [ 68.566308] nixos[4176]: finished switching to system configuration /nix/store/b8v4dzxsp98n1mrz3y8s56yix8lk2gz1-nixos-system-machine-test1976machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.95 seconds)1977machine: must fail: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&11978machine # [ 68.881858] nixos[4318]: switching to system configuration /nix/store/dva9cqx7c1l6n124nf4jnf6n0q8g22i0-nixos-system-machine-test1979machine # [ 68.884709] systemd[1]: Stopped target Remote File Systems.1980machine # [ 68.887583] systemd[1]: test.service: Deactivated successfully.1981machine # [ 68.890097] systemd[1]: Stopped test.service.1982machine # [ 68.891169] systemd[1]: Stopped target Local File Systems.1983machine # [ 69.187654] systemd[1]: Reload requested from client PID 4318 ('.switch-to-conf') (unit backdoor.service)...1984machine # [ 69.189797] systemd[1]: Reloading...1985machine # [ 69.535089] systemd[1]: Reloading finished in 343 ms.1986machine # [ 69.628532] systemd[568]: Reexecution requested from client PID 4387 ('switch-to-confi')...1987machine # [ 69.629934] systemd[568]: Reexecuting.1988machine # [ 69.695986] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1989machine # [ 69.818825] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1990machine # [ 69.825736] systemd[568]: Reload requested from client PID 4387 ('switch-to-confi')...1991machine # [ 69.829845] systemd[568]: Reloading...1992machine # [ 69.938940] systemd[568]: Reloading finished in 110 ms.1993machine # [ 69.953980] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1994machine # [ 69.963649] systemd[568]: Stopped Run user-specific NixOS activation.1995machine # [ 69.966213] systemd[568]: Stopping Run user-specific NixOS activation...1996machine # [ 69.968601] systemd[568]: Starting Run user-specific NixOS activation...1997machine # [ 70.006956] systemd[568]: Finished Run user-specific NixOS activation.1998machine # [ 70.011559] systemd[1]: Stopped target Reactivate sysinit units.1999machine # [ 70.013915] systemd[1]: Stopping Reactivate sysinit units...2000machine # [ 70.014882] systemd[1]: Reached target Reactivate sysinit units.2001machine # [ 70.018240] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2002machine # [ 70.021780] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2003machine # [ 70.023817] systemd[1]: Reached target Local File Systems.2004machine # [ 70.028304] systemd[1]: Reached target Remote File Systems.2005machine # [ 70.034756] systemd[1]: Starting test.service...2006machine # [ 70.044455] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2007machine # [ 70.053459] systemd[1]: Starting Create SUID/SGID Wrappers...2008machine # [ 70.054459] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2009machine # [ 70.055759] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672010machine # [ 70.071468] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2011machine # [ 70.076790] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2012machine # [ 70.082380] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2013machine # [ 70.099006] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE2014machine # [ 70.104336] systemd[1]: test.service: Failed with result 'exit-code'.2015machine # [ 70.105666] systemd[1]: Failed to start test.service.2016machine # [ 70.277663] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2017machine # [ 70.281176] systemd[1]: Finished Create SUID/SGID Wrappers.2018machine # [ 70.286298] systemd[1]: Starting linger-users.service...2019machine # [ 70.335660] systemd[1]: linger-users.service: Deactivated successfully.2020machine # [ 70.337912] systemd[1]: Finished linger-users.service.2021machine # [ 70.641390] nixos[4318]: switching to system configuration /nix/store/dva9cqx7c1l6n124nf4jnf6n0q8g22i0-nixos-system-machine-test failed (status 4)2022machine: (finished: must fail: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 2.07 seconds)2023machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12024machine # [ 70.922343] nixos[4461]: switching to system configuration /nix/store/5048fp8gd4ljaj0maxh10i1j8m5gw7s6-nixos-system-machine-test2025machine # [ 70.925331] systemd[1]: Stopped target Local File Systems.2026machine # [ 70.927773] systemd[1]: Stopped target Remote File Systems.2027machine # [ 71.230001] systemd[1]: Reload requested from client PID 4461 ('.switch-to-conf') (unit backdoor.service)...2028machine # [ 71.231993] systemd[1]: Reloading...2029machine # [ 71.579282] systemd[1]: Reloading finished in 345 ms.2030machine # [ 71.676541] systemd[568]: Reexecution requested from client PID 4530 ('switch-to-confi')...2031machine # [ 71.680749] systemd[568]: Reexecuting.2032machine # [ 71.735223] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2033machine # [ 71.856213] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2034machine # [ 71.863239] systemd[568]: Reload requested from client PID 4530 ('switch-to-confi')...2035machine # [ 71.867290] systemd[568]: Reloading...2036machine # [ 71.985178] systemd[568]: Reloading finished in 119 ms.2037machine # [ 72.001772] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2038machine # [ 72.009948] systemd[568]: Stopped Run user-specific NixOS activation.2039machine # [ 72.012639] systemd[568]: Stopping Run user-specific NixOS activation...2040machine # [ 72.015026] systemd[568]: Starting Run user-specific NixOS activation...2041machine # [ 72.050469] systemd[568]: Finished Run user-specific NixOS activation.2042machine # [ 72.055313] systemd[1]: Stopped target Reactivate sysinit units.2043machine # [ 72.058529] systemd[1]: Stopping Reactivate sysinit units...2044machine # [ 72.059518] systemd[1]: Reached target Reactivate sysinit units.2045machine # [ 72.065338] systemd[1]: Reached target Local File Systems.2046machine # [ 72.066262] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2047machine # [ 72.070575] systemd[1]: Starting Create SUID/SGID Wrappers...2048machine # [ 72.071633] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2049machine # [ 72.081936] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672050machine # [ 72.091292] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2051machine # [ 72.094397] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2052machine # [ 72.095729] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2053machine # [ 72.097102] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2054machine # [ 72.098400] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2055machine # [ 72.099703] systemd[1]: Reached target Remote File Systems.2056machine # [ 72.277198] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2057machine # [ 72.282620] systemd[1]: Finished Create SUID/SGID Wrappers.2058machine # [ 72.284903] systemd[1]: Started autorestart.service.2059machine # [ 72.290602] systemd[1]: Starting linger-users.service...2060machine # [ 72.340952] systemd[1]: autorestart.service: Deactivated successfully.2061machine # [ 72.367435] systemd[1]: linger-users.service: Deactivated successfully.2062machine # [ 72.369413] systemd[1]: Finished linger-users.service.2063machine # [ 72.631828] nixos[4461]: finished switching to system configuration /nix/store/5048fp8gd4ljaj0maxh10i1j8m5gw7s6-nixos-system-machine-test2064machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.99 seconds)2065machine # [ 72.709400] systemd[1]: Stopped autorestart.service.2066machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12067machine # [ 72.955594] nixos[4608]: switching to system configuration /nix/store/5048fp8gd4ljaj0maxh10i1j8m5gw7s6-nixos-system-machine-test2068machine # [ 72.958238] systemd[1]: Stopped target Local File Systems.2069machine # [ 72.960533] systemd[1]: Stopped target Remote File Systems.2070machine # [ 73.235958] systemd[1]: Reload requested from client PID 4608 ('.switch-to-conf') (unit backdoor.service)...2071machine # [ 73.238078] systemd[1]: Reloading...2072machine # [ 73.558479] systemd[1]: Reloading finished in 318 ms.2073machine # [ 73.648426] systemd[568]: Reexecution requested from client PID 4677 ('switch-to-confi')...2074machine # [ 73.651896] systemd[568]: Reexecuting.2075machine # [ 73.715780] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2076machine # [ 73.835565] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2077machine # [ 73.842333] systemd[568]: Reload requested from client PID 4677 ('switch-to-confi')...2078machine # [ 73.844752] systemd[568]: Reloading...2079machine # [ 73.957503] systemd[568]: Reloading finished in 111 ms.2080machine # [ 73.972184] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2081machine # [ 73.981595] systemd[568]: Stopped Run user-specific NixOS activation.2082machine # [ 73.984064] systemd[568]: Stopping Run user-specific NixOS activation...2083machine # [ 73.986291] systemd[568]: Starting Run user-specific NixOS activation...2084machine # [ 74.016878] systemd[568]: Finished Run user-specific NixOS activation.2085machine # [ 74.020859] systemd[1]: Stopped target Reactivate sysinit units.2086machine # [ 74.023950] systemd[1]: Stopping Reactivate sysinit units...2087machine # [ 74.025664] systemd[1]: Reached target Reactivate sysinit units.2088machine # [ 74.026545] systemd[1]: Reached target Local File Systems.2089machine # [ 74.028310] systemd[1]: Reached target Remote File Systems.2090machine # [ 74.037282] systemd[1]: Started autorestart.service.2091machine # [ 74.042199] systemd[1]: Starting linger-users.service...2092machine # [ 74.056447] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2093machine # [ 74.065808] systemd[1]: Starting Create SUID/SGID Wrappers...2094machine # [ 74.066777] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2095machine # [ 74.068006] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672096machine # [ 74.078106] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2097machine # [ 74.079785] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2098machine # [ 74.092625] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2099machine # [ 74.100474] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2100machine # [ 74.102935] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2101machine # [ 74.127310] systemd[1]: autorestart.service: Deactivated successfully.2102machine # [ 74.154150] systemd[1]: linger-users.service: Deactivated successfully.2103machine # [ 74.157185] systemd[1]: Finished linger-users.service.2104machine # [ 74.296558] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2105machine # [ 74.299849] systemd[1]: Finished Create SUID/SGID Wrappers.2106machine # [ 74.559561] nixos[4608]: finished switching to system configuration /nix/store/5048fp8gd4ljaj0maxh10i1j8m5gw7s6-nixos-system-machine-test2107machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.84 seconds)2108machine # [ 74.634442] systemd[1]: Stopped autorestart.service.2109machine: must fail: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&12110machine # [ 74.896582] nixos[4755]: switching to system configuration /nix/store/ld1wdavl0cngk4wh8znf17wx824qbabg-nixos-system-machine-test2111machine # [ 74.899046] systemd[1]: Stopped target Remote File Systems.2112machine # [ 74.901208] systemd[1]: Stopped target Local File Systems.2113machine # [ 75.191329] systemd[1]: Reload requested from client PID 4755 ('.switch-to-conf') (unit backdoor.service)...2114machine # [ 75.193403] systemd[1]: Reloading...2115machine # [ 75.532194] systemd[1]: Reloading finished in 337 ms.2116machine # [ 75.623566] systemd[568]: Reexecution requested from client PID 4824 ('switch-to-confi')...2117machine # [ 75.627271] systemd[568]: Reexecuting.2118machine # [ 75.687557] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2119machine # [ 75.808817] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2120machine # [ 75.815727] systemd[568]: Reload requested from client PID 4824 ('switch-to-confi')...2121machine # [ 75.818943] systemd[568]: Reloading...2122machine # [ 75.929966] systemd[568]: Reloading finished in 112 ms.2123machine # [ 75.944180] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2124machine # [ 75.952947] systemd[568]: Stopped Run user-specific NixOS activation.2125machine # [ 75.955465] systemd[568]: Stopping Run user-specific NixOS activation...2126machine # [ 75.957646] systemd[568]: Starting Run user-specific NixOS activation...2127machine # [ 75.988094] systemd[568]: Finished Run user-specific NixOS activation.2128machine # [ 75.991524] systemd[1]: Stopped target Reactivate sysinit units.2129machine # [ 75.993971] systemd[1]: Stopping Reactivate sysinit units...2130machine # [ 75.994787] systemd[1]: Reached target Reactivate sysinit units.2131machine # [ 75.997299] systemd[1]: Reached target Local File Systems.2132machine # [ 76.002666] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2133machine # [ 76.008660] systemd[1]: Starting Create SUID/SGID Wrappers...2134machine # [ 76.009509] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2135machine # [ 76.010714] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672136machine # [ 76.022963] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2137machine # [ 76.026612] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2138machine # [ 76.028616] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2139machine # [ 76.031141] systemd[1]: Reached target Remote File Systems.2140machine # [ 76.031963] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2141machine # [ 76.033561] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2142machine # [ 76.188690] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2143machine # [ 76.192612] systemd[1]: Finished Create SUID/SGID Wrappers.2144machine # [ 76.196404] systemd[1]: Started autorestart.service.2145machine # [ 76.200558] systemd[1]: Starting linger-users.service...2146machine # [ 76.234995] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE2147machine # [ 76.239699] systemd[1]: autorestart.service: Failed with result 'exit-code'.2148machine # [ 76.256853] systemd[1]: linger-users.service: Deactivated successfully.2149machine # [ 76.258567] systemd[1]: Finished linger-users.service.2150machine # [ 76.554731] nixos[4755]: switching to system configuration /nix/store/ld1wdavl0cngk4wh8znf17wx824qbabg-nixos-system-machine-test failed (status 4)2151machine: (finished: must fail: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.92 seconds)2152(finished: subtest: failing units, in 9.94 seconds)2153subtest: unit file parser2154machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12155machine # [ 76.797820] nixos[4898]: switching to system configuration /nix/store/14nf8m8wg6yp4k3p9hj90zq8a1cmn3ji-nixos-system-machine-test2156machine # [ 76.800678] systemd[1]: Stopped target Local File Systems.2157machine # [ 76.803682] systemd[1]: Stopped autorestart.service.2158machine # [ 76.805305] systemd[1]: Stopped target Remote File Systems.2159machine # [ 77.068796] systemd[1]: Reload requested from client PID 4898 ('.switch-to-conf') (unit backdoor.service)...2160machine # [ 77.070672] systemd[1]: Reloading...2161machine # [ 77.390731] systemd[1]: Reloading finished in 318 ms.2162machine # [ 77.482759] systemd[568]: Reexecution requested from client PID 4967 ('switch-to-confi')...2163machine # [ 77.486710] systemd[568]: Reexecuting.2164machine # [ 77.535852] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2165machine # [ 77.650743] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2166machine # [ 77.657659] systemd[568]: Reload requested from client PID 4967 ('switch-to-confi')...2167machine # [ 77.659822] systemd[568]: Reloading...2168machine # [ 77.773175] systemd[568]: Reloading finished in 112 ms.2169machine # [ 77.784174] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2170machine # [ 77.794080] systemd[568]: Stopped Run user-specific NixOS activation.2171machine # [ 77.796420] systemd[568]: Stopping Run user-specific NixOS activation...2172machine # [ 77.798514] systemd[568]: Starting Run user-specific NixOS activation...2173machine # [ 77.832425] systemd[568]: Finished Run user-specific NixOS activation.2174machine # [ 77.836743] systemd[1]: Stopped target Reactivate sysinit units.2175machine # [ 77.839796] systemd[1]: Stopping Reactivate sysinit units...2176machine # [ 77.841184] systemd[1]: Reached target Reactivate sysinit units.2177machine # [ 77.842030] systemd[1]: Reached target Local File Systems.2178machine # [ 77.843855] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2179machine # [ 77.847925] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2180machine # [ 77.852990] systemd[1]: Reached target Remote File Systems.2181machine # [ 77.858208] systemd[1]: Starting linger-users.service...2182machine # [ 77.864626] systemd[1]: Starting test.service...2183machine # [ 77.865416] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2184machine # [ 77.880114] systemd[1]: Starting Create SUID/SGID Wrappers...2185machine # [ 77.881074] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2186machine # [ 77.882292] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672187machine # [ 77.887015] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2188machine # [ 77.894410] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2189machine # [ 77.895727] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2190machine # [ 77.926265] systemd[1]: Finished test.service.2191machine # [ 77.954919] systemd[1]: linger-users.service: Deactivated successfully.2192machine # [ 77.957724] systemd[1]: Finished linger-users.service.2193machine # [ 78.090453] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2194machine # [ 78.093829] systemd[1]: Finished Create SUID/SGID Wrappers.2195machine # [ 78.352588] nixos[4898]: finished switching to system configuration /nix/store/14nf8m8wg6yp4k3p9hj90zq8a1cmn3ji-nixos-system-machine-test2196machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.80 seconds)2197machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&12198machine # [ 78.645797] nixos[5040]: switching to system configuration /nix/store/fwj8mana5a8rq0l988jxvy9m51ck80zj-nixos-system-machine-test2199machine # [ 78.649596] systemd[1]: Stopped target Local File Systems.2200machine # [ 78.651817] systemd[1]: Stopped target Remote File Systems.2201machine # [ 78.928823] systemd[1]: Reload requested from client PID 5040 ('.switch-to-conf') (unit backdoor.service)...2202machine # [ 78.930689] systemd[1]: Reloading...2203machine # [ 79.252085] systemd[1]: Reloading finished in 319 ms.2204machine # [ 79.343937] systemd[568]: Reexecution requested from client PID 5109 ('switch-to-confi')...2205machine # [ 79.346178] systemd[568]: Reexecuting.2206machine # [ 79.395164] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2207machine # [ 79.512099] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2208machine # [ 79.518393] systemd[568]: Reload requested from client PID 5109 ('switch-to-confi')...2209machine # [ 79.521828] systemd[568]: Reloading...2210machine # [ 79.631789] systemd[568]: Reloading finished in 110 ms.2211machine # [ 79.648166] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2212machine # [ 79.656707] systemd[568]: Stopped Run user-specific NixOS activation.2213machine # [ 79.658998] systemd[568]: Stopping Run user-specific NixOS activation...2214machine # [ 79.661020] systemd[568]: Starting Run user-specific NixOS activation...2215machine # [ 79.691398] systemd[568]: Finished Run user-specific NixOS activation.2216machine # [ 79.694666] systemd[1]: Stopped target Reactivate sysinit units.2217machine # [ 79.696648] systemd[1]: Stopping Reactivate sysinit units...2218machine # [ 79.697474] systemd[1]: Reached target Reactivate sysinit units.2219machine # [ 79.700439] systemd[1]: test.service: Deactivated successfully.2220machine # [ 79.701353] systemd[1]: Stopped test.service.2221machine # [ 79.701972] systemd[1]: Stopping test.service...2222machine # [ 79.704770] systemd[1]: Starting test.service...2223machine # [ 79.728811] systemd[1]: Finished test.service.2224machine # [ 79.733198] systemd[1]: Reached target Remote File Systems.2225machine # [ 79.737152] systemd[1]: Starting linger-users.service...2226machine # [ 79.748939] systemd[1]: Reached target Local File Systems.2227machine # [ 79.749777] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2228machine # [ 79.756222] systemd[1]: Starting Create SUID/SGID Wrappers...2229machine # [ 79.757126] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2230machine # [ 79.758343] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672231machine # [ 79.772513] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2232machine # [ 79.774220] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2233machine # [ 79.782474] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2234machine # [ 79.787852] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2235machine # [ 79.791396] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2236machine # [ 79.823130] systemd[1]: linger-users.service: Deactivated successfully.2237machine # [ 79.827416] systemd[1]: Finished linger-users.service.2238machine # [ 79.955976] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2239machine # [ 79.959256] systemd[1]: Finished Create SUID/SGID Wrappers.2240machine # [ 80.218350] nixos[5040]: finished switching to system configuration /nix/store/fwj8mana5a8rq0l988jxvy9m51ck80zj-nixos-system-machine-test2241machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.87 seconds)2242machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&12243machine # [ 80.520425] nixos[5182]: switching to system configuration /nix/store/azrmqa7q6pqcdiq78rbpv3yiyp7dxvrz-nixos-system-machine-test2244machine # [ 80.522919] systemd[1]: Stopped target Remote File Systems.2245machine # [ 80.525256] systemd[1]: Stopped target Local File Systems.2246machine # [ 80.810149] systemd[1]: Reload requested from client PID 5182 ('.switch-to-conf') (unit backdoor.service)...2247machine # [ 80.812204] systemd[1]: Reloading...2248machine # [ 81.148943] systemd[1]: Reloading finished in 335 ms.2249machine # [ 81.243130] systemd[568]: Reexecution requested from client PID 5251 ('switch-to-confi')...2250machine # [ 81.245354] systemd[568]: Reexecuting.2251machine # [ 81.303389] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2252machine # [ 81.430375] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2253machine # [ 81.437507] systemd[568]: Reload requested from client PID 5251 ('switch-to-confi')...2254machine # [ 81.438963] systemd[568]: Reloading...2255machine # [ 81.553614] systemd[568]: Reloading finished in 112 ms.2256machine # [ 81.569906] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2257machine # [ 81.579243] systemd[568]: Stopped Run user-specific NixOS activation.2258machine # [ 81.582076] systemd[568]: Stopping Run user-specific NixOS activation...2259machine # [ 81.584724] systemd[568]: Starting Run user-specific NixOS activation...2260machine # [ 81.624528] systemd[568]: Finished Run user-specific NixOS activation.2261machine # [ 81.630090] systemd[1]: Stopped target Reactivate sysinit units.2262machine # [ 81.631152] systemd[1]: Stopping Reactivate sysinit units...2263machine # [ 81.631945] systemd[1]: Reached target Reactivate sysinit units.2264machine # [ 81.635121] systemd[1]: test.service: Deactivated successfully.2265machine # [ 81.639041] systemd[1]: Stopped test.service.2266machine # [ 81.639824] systemd[1]: Stopping test.service...2267machine # [ 81.643387] systemd[1]: Starting test.service...2268machine # [ 81.677114] systemd[1]: Finished test.service.2269machine # [ 81.680613] systemd[1]: Reached target Remote File Systems.2270machine # [ 81.687387] systemd[1]: Reached target Local File Systems.2271machine # [ 81.691712] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2272machine # [ 81.696672] systemd[1]: Starting Create SUID/SGID Wrappers...2273machine # [ 81.697622] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2274machine # [ 81.698952] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672275machine # [ 81.708451] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2276machine # [ 81.710156] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2277machine # [ 81.711445] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2278machine # [ 81.718975] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2279machine # [ 81.721600] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2280machine # [ 81.930522] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2281machine # [ 81.932603] systemd[1]: Finished Create SUID/SGID Wrappers.2282machine # [ 81.938235] systemd[1]: Starting linger-users.service...2283machine # [ 81.988436] systemd[1]: linger-users.service: Deactivated successfully.2284machine # [ 81.991479] systemd[1]: Finished linger-users.service.2285machine # [ 82.250131] nixos[5182]: finished switching to system configuration /nix/store/azrmqa7q6pqcdiq78rbpv3yiyp7dxvrz-nixos-system-machine-test2286machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 2.03 seconds)2287machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12288machine # [ 82.535613] nixos[5324]: switching to system configuration /nix/store/14nf8m8wg6yp4k3p9hj90zq8a1cmn3ji-nixos-system-machine-test2289machine # [ 82.541022] systemd[1]: Stopped target Local File Systems.2290machine # [ 82.541907] systemd[1]: Stopped target Remote File Systems.2291machine # [ 82.801253] systemd[1]: Reload requested from client PID 5324 ('.switch-to-conf') (unit backdoor.service)...2292machine # [ 82.803120] systemd[1]: Reloading...2293machine # [ 83.117581] systemd[1]: Reloading finished in 311 ms.2294machine # [ 83.206301] systemd[568]: Reexecution requested from client PID 5393 ('switch-to-confi')...2295machine # [ 83.210048] systemd[568]: Reexecuting.2296machine # [ 83.255109] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2297machine # [ 83.367637] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2298machine # [ 83.374209] systemd[568]: Reload requested from client PID 5393 ('switch-to-confi')...2299machine # [ 83.377661] systemd[568]: Reloading...2300machine # [ 83.486216] systemd[568]: Reloading finished in 109 ms.2301machine # [ 83.500161] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2302machine # [ 83.510306] systemd[568]: Stopped Run user-specific NixOS activation.2303machine # [ 83.511367] systemd[568]: Stopping Run user-specific NixOS activation...2304machine # [ 83.514116] systemd[568]: Starting Run user-specific NixOS activation...2305machine # [ 83.544515] systemd[568]: Finished Run user-specific NixOS activation.2306machine # [ 83.548838] systemd[1]: Stopped target Reactivate sysinit units.2307machine # [ 83.550718] systemd[1]: Stopping Reactivate sysinit units...2308machine # [ 83.551618] systemd[1]: Reached target Reactivate sysinit units.2309machine # [ 83.556502] systemd[1]: test.service: Deactivated successfully.2310machine # [ 83.557398] systemd[1]: Stopped test.service.2311machine # [ 83.558027] systemd[1]: Stopping test.service...2312machine # [ 83.558693] systemd[1]: Starting test.service...2313machine # [ 83.585577] systemd[1]: Finished test.service.2314machine # [ 83.590269] systemd[1]: Reached target Remote File Systems.2315machine # [ 83.592120] systemd[1]: Reached target Local File Systems.2316machine # [ 83.595065] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2317machine # [ 83.600795] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2318machine # [ 83.602076] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2319machine # [ 83.606329] systemd[1]: Starting Create SUID/SGID Wrappers...2320machine # [ 83.607212] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2321machine # [ 83.615359] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672322machine # [ 83.619980] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2323machine # [ 83.621630] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2324machine # [ 83.622878] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2325machine # [ 83.792902] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2326machine # [ 83.794721] systemd[1]: Finished Create SUID/SGID Wrappers.2327machine # [ 83.799434] systemd[1]: Starting linger-users.service...2328machine # [ 83.841581] systemd[1]: linger-users.service: Deactivated successfully.2329machine # [ 83.844376] systemd[1]: Finished linger-users.service.2330machine # [ 84.102575] nixos[5324]: finished switching to system configuration /nix/store/14nf8m8wg6yp4k3p9hj90zq8a1cmn3ji-nixos-system-machine-test2331machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.85 seconds)2332machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&12333machine # [ 84.407772] nixos[5466]: switching to system configuration /nix/store/hkmg6vgwyb2bkwnbr0j7namf2n6nf2ls-nixos-system-machine-test2334machine # [ 84.410217] systemd[1]: Stopped target Remote File Systems.2335machine # [ 84.412722] systemd[1]: Stopped target Local File Systems.2336machine # [ 84.734357] systemd[1]: Reload requested from client PID 5466 ('.switch-to-conf') (unit backdoor.service)...2337machine # [ 84.736503] systemd[1]: Reloading...2338machine # [ 85.103477] systemd[1]: Reloading finished in 365 ms.2339machine # [ 85.202191] systemd[568]: Reexecution requested from client PID 5535 ('switch-to-confi')...2340machine # [ 85.203632] systemd[568]: Reexecuting.2341machine # [ 85.263773] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2342machine # [ 85.389325] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2343machine # [ 85.395692] systemd[568]: Reload requested from client PID 5535 ('switch-to-confi')...2344machine # [ 85.399515] systemd[568]: Reloading...2345machine # [ 85.510487] systemd[568]: Reloading finished in 112 ms.2346machine # [ 85.524216] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2347machine # [ 85.534062] systemd[568]: Stopped Run user-specific NixOS activation.2348machine # [ 85.536409] systemd[568]: Stopping Run user-specific NixOS activation...2349machine # [ 85.538539] systemd[568]: Starting Run user-specific NixOS activation...2350machine # [ 85.572685] systemd[568]: Finished Run user-specific NixOS activation.2351machine # [ 85.576549] systemd[1]: Stopped target Reactivate sysinit units.2352machine # [ 85.578516] systemd[1]: Stopping Reactivate sysinit units...2353machine # [ 85.579438] systemd[1]: Reached target Reactivate sysinit units.2354machine # [ 85.582615] systemd[1]: Reached target Local File Systems.2355machine # [ 85.587361] systemd[1]: Reached target Remote File Systems.2356machine # [ 85.589535] systemd[1]: Starting linger-users.service...2357machine # [ 85.600651] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2358machine # [ 85.602044] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2359machine # [ 85.609823] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2360machine # [ 85.613479] systemd[1]: Starting Create SUID/SGID Wrappers...2361machine # [ 85.614386] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2362machine # [ 85.620382] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672363machine # [ 85.626343] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2364machine # [ 85.630497] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2365machine # [ 85.631819] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2366machine # [ 85.673297] systemd[1]: linger-users.service: Deactivated successfully.2367machine # [ 85.677601] systemd[1]: Finished linger-users.service.2368machine # [ 85.820722] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2369machine # [ 85.824355] systemd[1]: Finished Create SUID/SGID Wrappers.2370machine # [ 86.083359] nixos[5466]: finished switching to system configuration /nix/store/hkmg6vgwyb2bkwnbr0j7namf2n6nf2ls-nixos-system-machine-test2371machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.98 seconds)2372machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&12373machine # [ 86.386743] nixos[5606]: switching to system configuration /nix/store/zhjnaiq0nqqgb9aw6vnp4bm3pky1jaa2-nixos-system-machine-test2374machine # [ 86.389260] systemd[1]: Stopped target Remote File Systems.2375machine # [ 86.391492] systemd[1]: Stopped target Local File Systems.2376machine # [ 86.705548] systemd[1]: Reload requested from client PID 5606 ('.switch-to-conf') (unit backdoor.service)...2377machine # [ 86.707636] systemd[1]: Reloading...2378machine # [ 87.181303] systemd[1]: Reloading finished in 471 ms.2379machine # [ 87.280895] systemd[568]: Reexecution requested from client PID 5675 ('switch-to-confi')...2380machine # [ 87.284267] systemd[568]: Reexecuting.2381machine # [ 87.347870] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2382machine # [ 87.472759] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2383machine # [ 87.479629] systemd[568]: Reload requested from client PID 5675 ('switch-to-confi')...2384machine # [ 87.483273] systemd[568]: Reloading...2385machine # [ 87.598755] systemd[568]: Reloading finished in 116 ms.2386machine # [ 87.616223] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2387machine # [ 87.626458] systemd[568]: Stopped Run user-specific NixOS activation.2388machine # [ 87.629316] systemd[568]: Stopping Run user-specific NixOS activation...2389machine # [ 87.631768] systemd[568]: Starting Run user-specific NixOS activation...2390machine # [ 87.668397] systemd[568]: Finished Run user-specific NixOS activation.2391machine # [ 87.673114] systemd[1]: Stopped target Reactivate sysinit units.2392machine # [ 87.675869] systemd[1]: Stopping Reactivate sysinit units...2393machine # [ 87.680313] systemd[1]: Reached target Reactivate sysinit units.2394machine # [ 87.681281] systemd[1]: test.service: Deactivated successfully.2395machine # [ 87.682112] systemd[1]: Stopped test.service.2396machine # [ 87.682848] systemd[1]: Stopping test.service...2397machine # [ 87.685037] systemd[1]: Starting test.service...2398machine # [ 87.716603] systemd[1]: Finished test.service.2399machine # [ 87.724234] systemd[1]: Reached target Remote File Systems.2400machine # [ 87.730177] systemd[1]: Starting linger-users.service...2401machine # [ 87.737124] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2402machine # [ 87.738689] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2403machine # [ 87.749042] systemd[1]: Reached target Local File Systems.2404machine # [ 87.750089] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2405machine # [ 87.760378] systemd[1]: Starting Create SUID/SGID Wrappers...2406machine # [ 87.761459] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2407machine # [ 87.762764] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672408machine # [ 87.775224] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2409machine # [ 87.779671] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2410machine # [ 87.785456] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2411machine # [ 87.836469] systemd[1]: linger-users.service: Deactivated successfully.2412machine # [ 87.840223] systemd[1]: Finished linger-users.service.2413machine # [ 88.003825] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2414machine # [ 88.007380] systemd[1]: Finished Create SUID/SGID Wrappers.2415machine # [ 88.263763] nixos[5606]: finished switching to system configuration /nix/store/zhjnaiq0nqqgb9aw6vnp4bm3pky1jaa2-nixos-system-machine-test2416machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 2.18 seconds)2417machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&12418machine # [ 88.579061] nixos[5748]: switching to system configuration /nix/store/kp0ijpkps26xv9lck91h497val077dzn-nixos-system-machine-test2419machine # [ 88.581952] systemd[1]: Stopped target Remote File Systems.2420machine # [ 88.584681] systemd[1]: Stopped target Local File Systems.2421machine # [ 88.902953] systemd[1]: Reload requested from client PID 5748 ('.switch-to-conf') (unit backdoor.service)...2422machine # [ 88.905030] systemd[1]: Reloading...2423machine # [ 89.257831] systemd[1]: Reloading finished in 350 ms.2424machine # [ 89.348447] systemd[568]: Reexecution requested from client PID 5817 ('switch-to-confi')...2425machine # [ 89.352217] systemd[568]: Reexecuting.2426machine # [ 89.415913] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2427machine # [ 89.545168] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2428machine # [ 89.551465] systemd[568]: Reload requested from client PID 5817 ('switch-to-confi')...2429machine # [ 89.555418] systemd[568]: Reloading...2430machine # [ 89.670019] systemd[568]: Reloading finished in 114 ms.2431machine # [ 89.686062] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2432machine # [ 89.693814] systemd[568]: Stopped Run user-specific NixOS activation.2433machine # [ 89.696117] systemd[568]: Stopping Run user-specific NixOS activation...2434machine # [ 89.698516] systemd[568]: Starting Run user-specific NixOS activation...2435machine # [ 89.735290] systemd[568]: Finished Run user-specific NixOS activation.2436machine # [ 89.739582] systemd[1]: Stopped target Reactivate sysinit units.2437machine # [ 89.741667] systemd[1]: Stopping Reactivate sysinit units...2438machine # [ 89.742548] systemd[1]: Reached target Reactivate sysinit units.2439machine # [ 89.746439] systemd[1]: test.service: Deactivated successfully.2440machine # [ 89.747429] systemd[1]: Stopped test.service.2441machine # [ 89.749808] systemd[1]: Stopping test.service...2442machine # [ 89.750653] systemd[1]: Starting test.service...2443machine # [ 89.774655] systemd[1]: Finished test.service.2444machine # [ 89.782212] systemd[1]: Reached target Remote File Systems.2445machine # [ 89.784687] systemd[1]: Starting linger-users.service...2446machine # [ 89.793028] systemd[1]: Reached target Local File Systems.2447machine # [ 89.800177] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2448machine # [ 89.805292] systemd[1]: Starting Create SUID/SGID Wrappers...2449machine # [ 89.806199] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2450machine # [ 89.807423] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672451machine # [ 89.818308] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2452machine # [ 89.820000] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2453machine # [ 89.828708] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2454machine # [ 89.832175] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2455machine # [ 89.837543] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2456machine # [ 89.876263] systemd[1]: linger-users.service: Deactivated successfully.2457machine # [ 89.879532] systemd[1]: Finished linger-users.service.2458machine # [ 90.022275] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2459machine # [ 90.025567] systemd[1]: Finished Create SUID/SGID Wrappers.2460machine # [ 90.283210] nixos[5748]: finished switching to system configuration /nix/store/kp0ijpkps26xv9lck91h497val077dzn-nixos-system-machine-test2461machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 2.02 seconds)2462machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&12463machine # [ 90.638280] nixos[5890]: switching to system configuration /nix/store/bpyfh2lgj6a9rafq2mwhv4v79scz7a6g-nixos-system-machine-test2464machine # [ 90.642868] systemd[1]: Stopped target Local File Systems.2465machine # [ 90.644735] systemd[1]: Stopped target Remote File Systems.2466machine # [ 90.951217] systemd[1]: Reload requested from client PID 5890 ('.switch-to-conf') (unit backdoor.service)...2467machine # [ 90.953329] systemd[1]: Reloading...2468machine # [ 91.307350] systemd[1]: Reloading finished in 352 ms.2469machine # [ 91.404556] systemd[568]: Reexecution requested from client PID 5959 ('switch-to-confi')...2470machine # [ 91.408122] systemd[568]: Reexecuting.2471machine # [ 91.468170] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2472machine # [ 91.592539] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2473machine # [ 91.599628] systemd[568]: Reload requested from client PID 5959 ('switch-to-confi')...2474machine # [ 91.603360] systemd[568]: Reloading...2475machine # [ 91.722135] systemd[568]: Reloading finished in 119 ms.2476machine # [ 91.736191] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2477machine # [ 91.745708] systemd[568]: Stopped Run user-specific NixOS activation.2478machine # [ 91.748100] systemd[568]: Stopping Run user-specific NixOS activation...2479machine # [ 91.750726] systemd[568]: Starting Run user-specific NixOS activation...2480machine # [ 91.788709] systemd[568]: Finished Run user-specific NixOS activation.2481machine # [ 91.792917] systemd[1]: Stopped target Reactivate sysinit units.2482machine # [ 91.794937] systemd[1]: Stopping Reactivate sysinit units...2483machine # [ 91.795826] systemd[1]: Reached target Reactivate sysinit units.2484machine # [ 91.800528] systemd[1]: test.service: Deactivated successfully.2485machine # [ 91.801444] systemd[1]: Stopped test.service.2486machine # [ 91.802095] systemd[1]: Stopping test.service...2487machine # [ 91.804091] systemd[1]: Starting test.service...2488machine # [ 91.833163] systemd[1]: Finished test.service.2489machine # [ 91.838371] systemd[1]: Reached target Remote File Systems.2490machine # [ 91.843417] systemd[1]: Starting linger-users.service...2491machine # [ 91.849642] systemd[1]: Reached target Local File Systems.2492machine # [ 91.856709] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2493machine # [ 91.860791] systemd[1]: Starting Create SUID/SGID Wrappers...2494machine # [ 91.861711] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2495machine # [ 91.862999] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672496machine # [ 91.878872] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2497machine # [ 91.884262] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2498machine # [ 91.890429] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2499machine # [ 91.893148] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2500machine # [ 91.898415] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2501machine # [ 91.939555] systemd[1]: linger-users.service: Deactivated successfully.2502machine # [ 91.943362] systemd[1]: Finished linger-users.service.2503machine # [ 92.091391] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2504machine # [ 92.094891] systemd[1]: Finished Create SUID/SGID Wrappers.2505machine # [ 92.355256] nixos[5890]: finished switching to system configuration /nix/store/bpyfh2lgj6a9rafq2mwhv4v79scz7a6g-nixos-system-machine-test2506machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 2.07 seconds)2507machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12508machine # [ 92.639762] nixos[6032]: switching to system configuration /nix/store/14nf8m8wg6yp4k3p9hj90zq8a1cmn3ji-nixos-system-machine-test2509machine # [ 92.642476] systemd[1]: Stopped target Local File Systems.2510machine # [ 92.644893] systemd[1]: Stopped target Remote File Systems.2511machine # [ 92.918477] systemd[1]: Reload requested from client PID 6032 ('.switch-to-conf') (unit backdoor.service)...2512machine # [ 92.920585] systemd[1]: Reloading...2513machine # [ 93.250045] systemd[1]: Reloading finished in 327 ms.2514machine # [ 93.344449] systemd[568]: Reexecution requested from client PID 6101 ('switch-to-confi')...2515machine # [ 93.345862] systemd[568]: Reexecuting.2516machine # [ 93.404502] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2517machine # [ 93.529879] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2518machine # [ 93.536512] systemd[568]: Reload requested from client PID 6101 ('switch-to-confi')...2519machine # [ 93.538892] systemd[568]: Reloading...2520machine # [ 93.653518] systemd[568]: Reloading finished in 113 ms.2521machine # [ 93.668183] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2522machine # [ 93.679466] systemd[568]: Stopped Run user-specific NixOS activation.2523machine # [ 93.680695] systemd[568]: Stopping Run user-specific NixOS activation...2524machine # [ 93.682996] systemd[568]: Starting Run user-specific NixOS activation...2525machine # [ 93.716995] systemd[568]: Finished Run user-specific NixOS activation.2526machine # [ 93.721014] systemd[1]: Stopped target Reactivate sysinit units.2527machine # [ 93.724367] systemd[1]: Stopping Reactivate sysinit units...2528machine # [ 93.725303] systemd[1]: Reached target Reactivate sysinit units.2529machine # [ 93.726151] systemd[1]: test.service: Deactivated successfully.2530machine # [ 93.727018] systemd[1]: Stopped test.service.2531machine # [ 93.727655] systemd[1]: Stopping test.service...2532machine # [ 93.731305] systemd[1]: Starting test.service...2533machine # [ 93.761779] systemd[1]: Finished test.service.2534machine # [ 93.765417] systemd[1]: Reached target Remote File Systems.2535machine # [ 93.770824] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2536machine # [ 93.773466] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2537machine # [ 93.780339] systemd[1]: Starting linger-users.service...2538machine # [ 93.783868] systemd[1]: Reached target Local File Systems.2539machine # [ 93.793881] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2540machine # [ 93.795536] systemd[1]: Starting Create SUID/SGID Wrappers...2541machine # [ 93.806313] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2542machine # [ 93.807712] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672543machine # [ 93.812267] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2544machine # [ 93.814000] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2545machine # [ 93.815313] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2546machine # [ 93.873473] systemd[1]: linger-users.service: Deactivated successfully.2547machine # [ 93.878088] systemd[1]: Finished linger-users.service.2548machine # [ 94.025381] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2549machine # [ 94.028772] systemd[1]: Finished Create SUID/SGID Wrappers.2550machine # [ 94.287507] nixos[6032]: finished switching to system configuration /nix/store/14nf8m8wg6yp4k3p9hj90zq8a1cmn3ji-nixos-system-machine-test2551machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.93 seconds)2552machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&12553machine # [ 94.594845] nixos[6174]: switching to system configuration /nix/store/apnvky55swibdpp6k0zwdiqbk1d3nvw9-nixos-system-machine-test2554machine # [ 94.597837] systemd[1]: Stopped target Local File Systems.2555machine # [ 94.601049] systemd[1]: Stopped target Remote File Systems.2556machine # [ 94.919285] systemd[1]: Reload requested from client PID 6174 ('.switch-to-conf') (unit backdoor.service)...2557machine # [ 94.921605] systemd[1]: Reloading...2558machine # [ 95.290441] systemd[1]: Reloading finished in 367 ms.2559machine # [ 95.382941] systemd[568]: Reexecution requested from client PID 6243 ('switch-to-confi')...2560machine # [ 95.386668] systemd[568]: Reexecuting.2561machine # [ 95.444091] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2562machine # [ 95.565385] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2563machine # [ 95.571850] systemd[568]: Reload requested from client PID 6243 ('switch-to-confi')...2564machine # [ 95.575818] systemd[568]: Reloading...2565machine # [ 95.690210] systemd[568]: Reloading finished in 115 ms.2566machine # [ 95.704178] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2567machine # [ 95.713074] systemd[568]: Stopped Run user-specific NixOS activation.2568machine # [ 95.715423] systemd[568]: Stopping Run user-specific NixOS activation...2569machine # [ 95.717576] systemd[568]: Starting Run user-specific NixOS activation...2570machine # [ 95.749113] systemd[568]: Finished Run user-specific NixOS activation.2571machine # [ 95.753345] systemd[1]: Stopped target Reactivate sysinit units.2572machine # [ 95.757576] systemd[1]: Stopping Reactivate sysinit units...2573machine # [ 95.758501] systemd[1]: Reached target Reactivate sysinit units.2574machine # [ 95.760510] systemd[1]: Reloading test.service...2575machine # [ 95.785849] systemd[1]: Reloaded test.service.2576machine # [ 95.793518] systemd[1]: Reached target Local File Systems.2577machine # [ 95.796885] systemd[1]: Reached target Remote File Systems.2578machine # [ 95.797787] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2579machine # [ 95.802149] systemd[1]: Starting Create SUID/SGID Wrappers...2580machine # [ 95.803093] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2581machine # [ 95.808466] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672582machine # [ 95.810679] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2583machine # [ 95.819932] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2584machine # [ 95.822126] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2585machine # [ 95.823852] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2586machine # [ 95.825856] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2587machine # [ 95.990713] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2588machine # [ 95.995615] systemd[1]: Finished Create SUID/SGID Wrappers.2589machine # [ 95.997900] systemd[1]: Starting linger-users.service...2590machine # [ 96.039752] systemd[1]: linger-users.service: Deactivated successfully.2591machine # [ 96.042752] systemd[1]: Finished linger-users.service.2592machine # [ 96.301119] nixos[6174]: finished switching to system configuration /nix/store/apnvky55swibdpp6k0zwdiqbk1d3nvw9-nixos-system-machine-test2593machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 2.01 seconds)2594machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&12595machine # [ 96.608407] nixos[6316]: switching to system configuration /nix/store/5nyqmz89ws9mwqi9p5djq02n3hjldxd4-nixos-system-machine-test2596machine # [ 96.610927] systemd[1]: Stopped target Remote File Systems.2597machine # [ 96.612903] systemd[1]: Stopped target Local File Systems.2598machine # [ 96.905389] systemd[1]: Reload requested from client PID 6316 ('.switch-to-conf') (unit backdoor.service)...2599machine # [ 96.907308] systemd[1]: Reloading...2600machine # [ 97.246195] systemd[1]: Reloading finished in 337 ms.2601machine # [ 97.336328] systemd[568]: Reexecution requested from client PID 6385 ('switch-to-confi')...2602machine # [ 97.340483] systemd[568]: Reexecuting.2603machine # [ 97.395446] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2604machine # [ 97.515255] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2605machine # [ 97.522236] systemd[568]: Reload requested from client PID 6385 ('switch-to-confi')...2606machine # [ 97.525979] systemd[568]: Reloading...2607machine # [ 97.637215] systemd[568]: Reloading finished in 112 ms.2608machine # [ 97.652197] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2609machine # [ 97.661545] systemd[568]: Stopped Run user-specific NixOS activation.2610machine # [ 97.663891] systemd[568]: Stopping Run user-specific NixOS activation...2611machine # [ 97.666163] systemd[568]: Starting Run user-specific NixOS activation...2612machine # [ 97.697299] systemd[568]: Finished Run user-specific NixOS activation.2613machine # [ 97.701206] systemd[1]: Stopped target Reactivate sysinit units.2614machine # [ 97.705409] systemd[1]: Stopping Reactivate sysinit units...2615machine # [ 97.706342] systemd[1]: Reached target Reactivate sysinit units.2616machine # [ 97.708829] systemd[1]: Reloading test.service...2617machine # [ 97.734224] systemd[1]: Reloaded test.service.2618machine # [ 97.739803] systemd[1]: Reached target Local File Systems.2619machine # [ 97.743929] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2620machine # [ 97.753349] systemd[1]: Starting Create SUID/SGID Wrappers...2621machine # [ 97.754357] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2622machine # [ 97.755643] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672623machine # [ 97.764853] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2624machine # [ 97.766571] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2625machine # [ 97.767869] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2626machine # [ 97.771529] systemd[1]: Reached target Remote File Systems.2627machine # [ 97.772780] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2628machine # [ 97.774115] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2629machine # [ 97.936433] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2630machine # [ 97.940585] systemd[1]: Finished Create SUID/SGID Wrappers.2631machine # [ 97.943422] systemd[1]: Starting linger-users.service...2632machine # [ 97.986999] systemd[1]: linger-users.service: Deactivated successfully.2633machine # [ 97.990430] systemd[1]: Finished linger-users.service.2634machine # [ 98.247594] nixos[6316]: finished switching to system configuration /nix/store/5nyqmz89ws9mwqi9p5djq02n3hjldxd4-nixos-system-machine-test2635machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.95 seconds)2636machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&12637machine # [ 98.563774] nixos[6458]: switching to system configuration /nix/store/av1bi4ls17jw3rin7b191bnwir1wqswg-nixos-system-machine-test2638machine # [ 98.567793] systemd[1]: Stopped target Remote File Systems.2639machine # [ 98.569985] systemd[1]: Stopped target Local File Systems.2640machine # [ 98.883752] systemd[1]: Reload requested from client PID 6458 ('.switch-to-conf') (unit backdoor.service)...2641machine # [ 98.886017] systemd[1]: Reloading...2642machine # [ 99.255095] systemd[1]: Reloading finished in 367 ms.2643machine # [ 99.343299] systemd[568]: Reexecution requested from client PID 6527 ('switch-to-confi')...2644machine # [ 99.346921] systemd[568]: Reexecuting.2645machine # [ 99.403474] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2646machine # [ 99.521137] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2647machine # [ 99.527591] systemd[568]: Reload requested from client PID 6527 ('switch-to-confi')...2648machine # [ 99.531543] systemd[568]: Reloading...2649machine # [ 99.643497] systemd[568]: Reloading finished in 113 ms.2650machine # [ 99.660495] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2651machine # [ 99.671216] systemd[568]: Stopped Run user-specific NixOS activation.2652machine # [ 99.672513] systemd[568]: Stopping Run user-specific NixOS activation...2653machine # [ 99.674953] systemd[568]: Starting Run user-specific NixOS activation...2654machine # [ 99.713910] systemd[568]: Finished Run user-specific NixOS activation.2655machine # [ 99.718661] systemd[1]: Stopped target Reactivate sysinit units.2656machine # [ 99.721281] systemd[1]: Stopping Reactivate sysinit units...2657machine # [ 99.722217] systemd[1]: Reached target Reactivate sysinit units.2658machine # [ 99.726265] systemd[1]: test.service: Deactivated successfully.2659machine # [ 99.727285] systemd[1]: Stopped test.service.2660machine # [ 99.727963] systemd[1]: Stopping test.service...2661machine # [ 99.731326] systemd[1]: Starting test.service...2662machine # [ 99.760369] systemd[1]: Finished test.service.2663machine # [ 99.767588] systemd[1]: Reached target Local File Systems.2664machine # [ 99.772220] systemd[1]: Reached target Remote File Systems.2665machine # [ 99.773153] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2666machine # [ 99.777309] systemd[1]: Starting Create SUID/SGID Wrappers...2667machine # [ 99.778279] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2668machine # [ 99.779606] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672669machine # [ 99.788983] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2670machine # [ 99.790677] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2671machine # [ 99.791973] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2672machine # [ 99.800346] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2673machine # [ 99.802128] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2674machine # [ 100.000701] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2675machine # [ 100.004802] systemd[1]: Finished Create SUID/SGID Wrappers.2676machine # [ 100.008226] systemd[1]: Starting linger-users.service...2677machine # [ 100.051266] systemd[1]: linger-users.service: Deactivated successfully.2678machine # [ 100.053306] systemd[1]: Finished linger-users.service.2679machine # [ 100.312977] nixos[6458]: finished switching to system configuration /nix/store/av1bi4ls17jw3rin7b191bnwir1wqswg-nixos-system-machine-test2680machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 2.07 seconds)2681machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&12682machine # [ 100.585431] nixos[6600]: switching to system configuration /nix/store/zhjnaiq0nqqgb9aw6vnp4bm3pky1jaa2-nixos-system-machine-test2683machine # [ 100.589064] systemd[1]: Stopped target Remote File Systems.2684machine # [ 100.591232] systemd[1]: Stopped target Local File Systems.2685machine # [ 100.863002] systemd[1]: Reload requested from client PID 6600 ('.switch-to-conf') (unit backdoor.service)...2686machine # [ 100.865186] systemd[1]: Reloading...2687machine # [ 101.191090] systemd[1]: Reloading finished in 324 ms.2688machine # [ 101.281898] systemd[568]: Reexecution requested from client PID 6669 ('switch-to-confi')...2689machine # [ 101.283278] systemd[568]: Reexecuting.2690machine # [ 101.344090] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2691machine # [ 101.470253] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2692machine # [ 101.477318] systemd[568]: Reload requested from client PID 6669 ('switch-to-confi')...2693machine # [ 101.481447] systemd[568]: Reloading...2694machine # [ 101.599269] systemd[568]: Reloading finished in 118 ms.2695machine # [ 101.616189] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2696machine # [ 101.624917] systemd[568]: Stopped Run user-specific NixOS activation.2697machine # [ 101.627303] systemd[568]: Stopping Run user-specific NixOS activation...2698machine # [ 101.629505] systemd[568]: Starting Run user-specific NixOS activation...2699machine # [ 101.661493] systemd[568]: Finished Run user-specific NixOS activation.2700machine # [ 101.666027] systemd[1]: Stopped target Reactivate sysinit units.2701machine # [ 101.668919] systemd[1]: Stopping Reactivate sysinit units...2702machine # [ 101.669849] systemd[1]: Reached target Reactivate sysinit units.2703machine # [ 101.673435] systemd[1]: Reached target Remote File Systems.2704machine # [ 101.677749] systemd[1]: Starting linger-users.service...2705machine # [ 101.678671] systemd[1]: Reached target Local File Systems.2706machine # [ 101.688717] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2707machine # [ 101.696787] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2708machine # [ 101.698280] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2709machine # [ 101.703584] systemd[1]: Starting Create SUID/SGID Wrappers...2710machine # [ 101.705560] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2711machine # [ 101.706883] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672712machine # [ 101.719234] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2713machine # [ 101.723528] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2714machine # [ 101.727380] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2715machine # [ 101.767006] systemd[1]: linger-users.service: Deactivated successfully.2716machine # [ 101.769696] systemd[1]: Finished linger-users.service.2717machine # [ 101.927611] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2718machine # [ 101.929938] systemd[1]: Finished Create SUID/SGID Wrappers.2719machine # [ 102.191098] nixos[6600]: finished switching to system configuration /nix/store/zhjnaiq0nqqgb9aw6vnp4bm3pky1jaa2-nixos-system-machine-test2720machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.87 seconds)2721(finished: subtest: unit file parser, in 25.64 seconds)2722subtest: restart and reload by activation script2723machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&12724machine # [ 102.480213] nixos[6740]: switching to system configuration /nix/store/bs0kln4r7xwqnmnna8jpd8gxfxca8r6q-nixos-system-machine-test2725machine # [ 102.482811] systemd[1]: Stopped target Remote File Systems.2726machine # [ 102.485022] systemd[1]: Stopped target Local File Systems.2727machine # [ 102.751625] systemd[1]: Reload requested from client PID 6740 ('.switch-to-conf') (unit backdoor.service)...2728machine # [ 102.753767] systemd[1]: Reloading...2729machine # [ 103.080218] systemd[1]: Reloading finished in 324 ms.2730machine # [ 103.171185] systemd[568]: Reexecution requested from client PID 6809 ('switch-to-confi')...2731machine # [ 103.175410] systemd[568]: Reexecuting.2732machine # [ 103.236564] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2733machine # [ 103.361457] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2734machine # [ 103.368313] systemd[568]: Reload requested from client PID 6809 ('switch-to-confi')...2735machine # [ 103.372164] systemd[568]: Reloading...2736machine # [ 103.493672] systemd[568]: Reloading finished in 122 ms.2737machine # [ 103.508198] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2738machine # [ 103.517399] systemd[568]: Stopped Run user-specific NixOS activation.2739machine # [ 103.519972] systemd[568]: Stopping Run user-specific NixOS activation...2740machine # [ 103.522407] systemd[568]: Starting Run user-specific NixOS activation...2741machine # [ 103.558173] systemd[568]: Finished Run user-specific NixOS activation.2742machine # [ 103.563692] systemd[1]: Stopped target Reactivate sysinit units.2743machine # [ 103.567285] systemd[1]: Stopping Reactivate sysinit units...2744machine # [ 103.572592] systemd[1]: Reached target Reactivate sysinit units.2745machine # [ 103.573640] systemd[1]: Reached target Remote File Systems.2746machine # [ 103.574452] systemd[1]: Reached target Local File Systems.2747machine # [ 103.575323] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2748machine # [ 103.589826] systemd[1]: Starting Create SUID/SGID Wrappers...2749machine # [ 103.590829] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2750machine # [ 103.600481] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672751machine # [ 103.602944] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2752machine # [ 103.605132] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2753machine # [ 103.606443] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2754machine # [ 103.607630] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2755machine # [ 103.609763] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2756machine # [ 103.814158] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2757machine # [ 103.819864] systemd[1]: Finished Create SUID/SGID Wrappers.2758machine # [ 103.822256] systemd[1]: Starting linger-users.service...2759machine # [ 103.871499] systemd[1]: linger-users.service: Deactivated successfully.2760machine # [ 103.874819] systemd[1]: Finished linger-users.service.2761machine # [ 104.130630] nixos[6740]: finished switching to system configuration /nix/store/bs0kln4r7xwqnmnna8jpd8gxfxca8r6q-nixos-system-machine-test2762machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.94 seconds)2763machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12764machine # [ 104.418773] nixos[6880]: switching to system configuration /nix/store/gkikzr2zn9ldl90ifzn67hbs5jmsa8rs-nixos-system-machine-test2765machine # [ 104.421966] systemd[1]: test.service: Deactivated successfully.2766machine # [ 104.422943] systemd[1]: Stopped test.service.2767machine # [ 104.424463] systemd[1]: Stopped target Local File Systems.2768machine # [ 104.426796] systemd[1]: Stopped target Remote File Systems.2769machine # [ 104.725671] systemd[1]: Reload requested from client PID 6880 ('.switch-to-conf') (unit backdoor.service)...2770machine # [ 104.727286] systemd[1]: Reloading...2771machine # [ 105.079042] systemd[1]: Reloading finished in 349 ms.2772machine # [ 105.171663] systemd[568]: Reexecution requested from client PID 6951 ('switch-to-confi')...2773machine # [ 105.173683] systemd[568]: Reexecuting.2774machine # [ 105.231725] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2775machine # [ 105.353393] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2776machine # [ 105.360113] systemd[568]: Reload requested from client PID 6951 ('switch-to-confi')...2777machine # [ 105.363753] systemd[568]: Reloading...2778machine # [ 105.477248] systemd[568]: Reloading finished in 114 ms.2779machine # [ 105.492179] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2780machine # [ 105.501570] systemd[568]: Stopped Run user-specific NixOS activation.2781machine # [ 105.504053] systemd[568]: Stopping Run user-specific NixOS activation...2782machine # [ 105.506233] systemd[568]: Starting Run user-specific NixOS activation...2783machine # [ 105.536379] systemd[568]: Finished Run user-specific NixOS activation.2784machine # [ 105.540515] systemd[1]: Stopped target Reactivate sysinit units.2785machine # [ 105.541493] systemd[1]: Stopping Reactivate sysinit units...2786machine # [ 105.543307] systemd[1]: Reached target Reactivate sysinit units.2787machine # [ 105.546731] systemd[1]: Reached target Local File Systems.2788machine # [ 105.550926] systemd[1]: Reached target Remote File Systems.2789machine # [ 105.553671] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2790machine # [ 105.555977] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2791machine # [ 105.562319] systemd[1]: Starting simple-reload-service.service...2792machine # [ 105.578575] systemd[1]: Created slice Slice /system/templated-simple-reload-service.2793machine # [ 105.582793] systemd[1]: Starting templated-simple-reload-service@instance.service...2794machine # [ 105.600123] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as.2795machine # [ 105.601509] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2796machine # [ 105.620646] systemd[1]: Starting no-restart-service.service...2797machine # [ 105.638471] systemd[1]: Created slice Slice /system/templated-simple-service.2798machine # [ 105.639634] systemd[1]: Starting templated-simple-service@instance.service...2799machine # [ 105.659699] systemd[1]: Created slice Slice /system/templated-simple-restart-service.2800machine # [ 105.674415] systemd[1]: Starting templated-simple-restart-service@instance.service...2801machine # [ 105.675648] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2802machine # [ 105.701470] systemd[1]: Finished simple-reload-service.service.2803machine # [ 105.702419] systemd[1]: Created slice Slice /system/templated-no-restart-service.2804machine # [ 105.703627] systemd[1]: Starting templated-no-restart-service@instance.service...2805machine # [ 105.744737] systemd[1]: Created slice Slice /system/templated-reload-triggers.2806machine # [ 105.745935] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart.2807machine # [ 105.747241] systemd[1]: Starting linger-users.service...2808machine # [ 105.747988] systemd[1]: Starting reload-triggers-and-restart.service...2809machine # [ 105.818968] systemd[1]: Starting reload-triggers.service...2810machine # [ 105.819943] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2811machine # [ 105.849806] systemd[1]: Starting templated-reload-triggers@instance.service...2812machine # [ 105.867449] systemd[1]: Finished templated-simple-reload-service@instance.service.2813machine # [ 105.885353] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2814machine # [ 105.905728] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2815machine # [ 105.925701] systemd[1]: Starting Create SUID/SGID Wrappers...2816machine # [ 105.935625] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2817machine # [ 105.950119] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672818machine # [ 105.962776] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2819machine # [ 105.967703] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2820machine # [ 105.972473] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2821machine # [ 105.973756] systemd[1]: Finished templated-simple-service@instance.service.2822machine # [ 105.974737] systemd[1]: Finished no-restart-service.service.2823machine # [ 105.975508] systemd[1]: Finished templated-simple-restart-service@instance.service.2824machine # [ 105.984329] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2825machine # [ 105.985418] systemd[1]: Finished templated-no-restart-service@instance.service.2826machine # [ 105.986391] systemd[1]: Finished reload-triggers-and-restart.service.2827machine # [ 105.987306] systemd[1]: Finished reload-triggers.service.2828machine # [ 105.995268] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2829machine # [ 106.000334] systemd[1]: Finished templated-reload-triggers@instance.service.2830machine # [ 106.001378] systemd[1]: linger-users.service: Deactivated successfully.2831machine # [ 106.002285] systemd[1]: Finished linger-users.service.2832machine # [ 106.144659] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2833machine # [ 106.148555] systemd[1]: Finished Create SUID/SGID Wrappers.2834machine # [ 106.152288] systemd[1]: Starting simple-restart-service.service...2835machine # [ 106.156430] systemd[1]: Starting simple-service.service...2836machine # [ 106.193689] systemd[1]: Finished simple-restart-service.service.2837machine # [ 106.195987] systemd[1]: Finished simple-service.service.2838machine # [ 106.457216] nixos[6880]: finished switching to system configuration /nix/store/gkikzr2zn9ldl90ifzn67hbs5jmsa8rs-nixos-system-machine-test2839machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.33 seconds)2840machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12841machine # [ 106.773922] nixos[7050]: switching to system configuration /nix/store/gkikzr2zn9ldl90ifzn67hbs5jmsa8rs-nixos-system-machine-test2842machine # [ 106.776486] systemd[1]: Stopped target Remote File Systems.2843machine # [ 106.778863] systemd[1]: Stopped target Local File Systems.2844machine # [ 107.062472] systemd[1]: Reload requested from client PID 7050 ('.switch-to-conf') (unit backdoor.service)...2845machine # [ 107.064479] systemd[1]: Reloading...2846machine # [ 107.396489] systemd[1]: Reloading finished in 330 ms.2847machine # [ 107.490382] systemd[568]: Reexecution requested from client PID 7121 ('switch-to-confi')...2848machine # [ 107.491765] systemd[568]: Reexecuting.2849machine # [ 107.555704] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2850machine # [ 107.679195] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2851machine # [ 107.685658] systemd[568]: Reload requested from client PID 7121 ('switch-to-confi')...2852machine # [ 107.689436] systemd[568]: Reloading...2853machine # [ 107.799674] systemd[568]: Reloading finished in 111 ms.2854machine # [ 107.816188] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2855machine # [ 107.826693] systemd[568]: Stopped Run user-specific NixOS activation.2856machine # [ 107.829045] systemd[568]: Stopping Run user-specific NixOS activation...2857machine # [ 107.831303] systemd[568]: Starting Run user-specific NixOS activation...2858machine # [ 107.865517] systemd[568]: Finished Run user-specific NixOS activation.2859machine # [ 107.868962] systemd[1]: Stopped target Reactivate sysinit units.2860machine # [ 107.871854] systemd[1]: Stopping Reactivate sysinit units...2861machine # [ 107.875331] systemd[1]: Reached target Reactivate sysinit units.2862machine # [ 107.877991] systemd[1]: Reloading reload-triggers-and-restart.service...2863machine # [ 107.891811] systemd[1]: Reloading reload-triggers.service...2864machine # [ 107.905272] systemd[1]: Reloading simple-reload-service.service...2865machine # [ 107.911650] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service...2866machine # [ 107.931374] systemd[1]: Reloading templated-reload-triggers@instance.service...2867machine # [ 107.941041] systemd[1]: Reloading templated-simple-reload-service@instance.service...2868machine # [ 107.972938] systemd[1]: Reloaded reload-triggers.service.2869machine # [ 107.981243] systemd[1]: Reloaded reload-triggers-and-restart.service.2870machine # [ 108.006860] systemd[1]: Reloaded simple-reload-service.service.2871machine # [ 108.010627] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service.2872machine # [ 108.011827] systemd[1]: Reloaded templated-reload-triggers@instance.service.2873machine # [ 108.014179] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2874machine # [ 108.018326] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2875machine # [ 108.019578] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2876machine # [ 108.024792] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2877machine # [ 108.029324] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2878machine # [ 108.030378] systemd[1]: simple-restart-service.service: Deactivated successfully.2879machine # [ 108.031439] systemd[1]: Stopped simple-restart-service.service.2880machine # [ 108.052875] systemd[1]: Stopping simple-restart-service.service...2881machine # [ 108.053865] systemd[1]: Starting simple-restart-service.service...2882machine # [ 108.054756] systemd[1]: simple-service.service: Deactivated successfully.2883machine # [ 108.055673] systemd[1]: Stopped simple-service.service.2884machine # [ 108.077637] systemd[1]: Stopping simple-service.service...2885machine # [ 108.078578] systemd[1]: Starting simple-service.service...2886machine # [ 108.091558] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2887machine # [ 108.103079] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2888machine # [ 108.114661] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2889machine # [ 108.125742] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2890machine # [ 108.127207] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2891machine # [ 108.155026] systemd[1]: Stopped templated-simple-restart-service@instance.service.2892machine # [ 108.159068] systemd[1]: Stopping templated-simple-restart-service@instance.service...2893machine # [ 108.160542] systemd[1]: Starting templated-simple-restart-service@instance.service...2894machine # [ 108.161582] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2895machine # [ 108.162743] systemd[1]: Stopped templated-simple-service@instance.service.2896machine # [ 108.163697] systemd[1]: Stopping templated-simple-service@instance.service...2897machine # [ 108.165923] systemd[1]: Starting templated-simple-service@instance.service...2898machine # [ 108.168757] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2899machine # [ 108.169792] systemd[1]: Finished simple-restart-service.service.2900machine # [ 108.170658] systemd[1]: Finished simple-service.service.2901machine # [ 108.171438] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2902machine # [ 108.172867] systemd[1]: Finished templated-simple-restart-service@instance.service.2903machine # [ 108.178791] systemd[1]: Finished templated-simple-service@instance.service.2904machine # [ 108.186344] systemd[1]: Reached target Remote File Systems.2905machine # [ 108.190764] systemd[1]: Starting linger-users.service...2906machine # [ 108.196338] systemd[1]: Reached target Local File Systems.2907machine # [ 108.197255] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2908machine # [ 108.212368] systemd[1]: Starting Create SUID/SGID Wrappers...2909machine # [ 108.213327] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2910machine # [ 108.214594] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672911machine # [ 108.221446] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2912machine # [ 108.223158] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2913machine # [ 108.224473] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2914machine # [ 108.225676] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2915machine # [ 108.226932] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2916machine # [ 108.280203] systemd[1]: linger-users.service: Deactivated successfully.2917machine # [ 108.284291] systemd[1]: Finished linger-users.service.2918machine # [ 108.421380] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2919machine # [ 108.424800] systemd[1]: Finished Create SUID/SGID Wrappers.2920machine # [ 108.682671] nixos[7050]: finished switching to system configuration /nix/store/gkikzr2zn9ldl90ifzn67hbs5jmsa8rs-nixos-system-machine-test2921machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.23 seconds)2922machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&12923machine # [ 109.021703] nixos[7216]: switching to system configuration /nix/store/xins467n16xp6jadjl86mkk54qcb75nf-nixos-system-machine-test2924machine # [ 109.024320] systemd[1]: Stopped target Local File Systems.2925machine # [ 109.026695] systemd[1]: Stopped target Remote File Systems.2926machine # [ 109.349843] systemd[1]: Reload requested from client PID 7216 ('.switch-to-conf') (unit backdoor.service)...2927machine # [ 109.351791] systemd[1]: Reloading...2928machine # [ 109.714316] systemd[1]: Reloading finished in 360 ms.2929machine # [ 109.809371] systemd[568]: Reexecution requested from client PID 7287 ('switch-to-confi')...2930machine # [ 109.813400] systemd[568]: Reexecuting.2931machine # [ 109.867581] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2932machine # [ 109.977888] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2933machine # [ 109.984552] systemd[568]: Reload requested from client PID 7287 ('switch-to-confi')...2934machine # [ 109.988076] systemd[568]: Reloading...2935machine # [ 110.096165] systemd[568]: Reloading finished in 108 ms.2936machine # [ 110.112167] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2937machine # [ 110.121173] systemd[568]: Stopped Run user-specific NixOS activation.2938machine # [ 110.123514] systemd[568]: Stopping Run user-specific NixOS activation...2939machine # [ 110.125705] systemd[568]: Starting Run user-specific NixOS activation...2940machine # [ 110.156899] systemd[568]: Finished Run user-specific NixOS activation.2941machine # [ 110.161615] systemd[1]: Stopped target Reactivate sysinit units.2942machine # [ 110.166284] systemd[1]: Stopping Reactivate sysinit units...2943machine # [ 110.167254] systemd[1]: Reached target Reactivate sysinit units.2944machine # [ 110.169670] systemd[1]: Reloading reload-triggers.service...2945machine # [ 110.174785] systemd[1]: Reloading simple-reload-service.service...2946machine # [ 110.187568] systemd[1]: Reloading templated-reload-triggers@instance.service...2947machine # [ 110.199744] systemd[1]: Reloading templated-simple-reload-service@instance.service...2948machine # [ 110.249847] systemd[1]: Reloaded reload-triggers.service.2949machine # [ 110.252148] systemd[1]: Reloaded simple-reload-service.service.2950machine # [ 110.255011] systemd[1]: Reloaded templated-reload-triggers@instance.service.2951machine # [ 110.256993] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2952machine # [ 110.260454] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2953machine # [ 110.261658] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2954machine # [ 110.262728] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2955machine # [ 110.267012] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2956machine # [ 110.270918] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully.2957machine # [ 110.283423] systemd[1]: Stopped reload-triggers-and-restart.service.2958machine # [ 110.292755] systemd[1]: Stopping reload-triggers-and-restart.service...2959machine # [ 110.293765] systemd[1]: Starting reload-triggers-and-restart.service...2960machine # [ 110.294746] systemd[1]: simple-restart-service.service: Deactivated successfully.2961machine # [ 110.295777] systemd[1]: Stopped simple-restart-service.service.2962machine # [ 110.329257] systemd[1]: Stopping simple-restart-service.service...2963machine # [ 110.330228] systemd[1]: Starting simple-restart-service.service...2964machine # [ 110.331292] systemd[1]: simple-service.service: Deactivated successfully.2965machine # [ 110.353482] systemd[1]: Stopped simple-service.service.2966machine # [ 110.354354] systemd[1]: Stopping simple-service.service...2967machine # [ 110.372695] systemd[1]: Starting simple-service.service...2968machine # [ 110.386055] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2969machine # [ 110.399261] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2970machine # [ 110.422106] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2971machine # [ 110.436749] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2972machine # [ 110.443687] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully.2973machine # [ 110.449739] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service.2974machine # [ 110.450963] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service...2975machine # [ 110.456381] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2976machine # [ 110.457923] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2977machine # [ 110.459564] systemd[1]: Stopped templated-simple-restart-service@instance.service.2978machine # [ 110.461047] systemd[1]: Stopping templated-simple-restart-service@instance.service...2979machine # [ 110.463824] systemd[1]: Starting templated-simple-restart-service@instance.service...2980machine # [ 110.468122] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2981machine # [ 110.469365] systemd[1]: Stopped templated-simple-service@instance.service.2982machine # [ 110.470327] systemd[1]: Stopping templated-simple-service@instance.service...2983machine # [ 110.471312] systemd[1]: Starting templated-simple-service@instance.service...2984machine # [ 110.478057] systemd[1]: Finished reload-triggers-and-restart.service.2985machine # [ 110.479130] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2986machine # [ 110.484611] systemd[1]: Finished simple-service.service.2987machine # [ 110.485432] systemd[1]: Finished simple-restart-service.service.2988machine # [ 110.486282] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2989machine # [ 110.487372] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2990machine # [ 110.508699] systemd[1]: Finished templated-simple-restart-service@instance.service.2991machine # [ 110.509907] systemd[1]: Finished templated-simple-service@instance.service.2992machine # [ 110.511949] systemd[1]: Reached target Local File Systems.2993machine # [ 110.515880] systemd[1]: Reached target Remote File Systems.2994machine # [ 110.519596] systemd[1]: Starting linger-users.service...2995machine # [ 110.520572] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2996machine # [ 110.522010] systemd[1]: Starting Create SUID/SGID Wrappers...2997machine # [ 110.522909] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2998machine # [ 110.529060] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672999machine # [ 110.535647] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore3000machine # [ 110.542301] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3001machine # [ 110.543686] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3002machine # [ 110.549187] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os3003machine # [ 110.550560] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki3004machine # [ 110.575806] systemd[1]: linger-users.service: Deactivated successfully.3005machine # [ 110.579616] systemd[1]: Finished linger-users.service.3006machine # [ 110.724284] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.3007machine # [ 110.727662] systemd[1]: Finished Create SUID/SGID Wrappers.3008machine # [ 110.985131] nixos[7216]: finished switching to system configuration /nix/store/xins467n16xp6jadjl86mkk54qcb75nf-nixos-system-machine-test3009machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.30 seconds)3010machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&13011machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.38 seconds)3012(finished: subtest: restart and reload by activation script, in 9.18 seconds)3013(finished: run the VM test script, in 112.19 seconds)3014test script finished in 113.37s3015cleanup3016kill QemuMachine (pid 45)3017machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14)3018machine # [2026-09-15T21:19:32Z INFO virtiofsd] Client disconnected, shutting down3019machine # [2026-09-15T21:19:32Z INFO virtiofsd] Client disconnected, shutting down3020machine # [2026-09-15T21:19:32Z INFO virtiofsd] Client disconnected, shutting down3021(finished: cleanup, in 0.20 seconds)3022additionally exposed symbols:3023 machine, other,3024 vlan1,3025 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