vm-test-run-switch-test-services
checks.aarch64-linux.switchTest
· build #50
· raw
1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.01 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7machine: waiting for unit multi-user.target8machine: waiting for the VM to finish booting9machine: starting vm10machine # Disk image does not exist, creating the virtualisation disk image...11machine: QEMU running (pid 45)12machine # Formatting '/build/vm-state-machine/tmp.TcoEMsUlXC', 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: e5fb7b1c-1358-44cd-adf4-7e178c35731617machine # Superblock backups stored on blocks:18machine # 32768, 98304, 163840, 22937619machine # 20machine # Allocating group tables: 0/8 done21machine # Writing inode tables: 0/8 done22machine # Creating journal (8192 blocks): done23machine # Writing superblocks and filesystem accounting information: 0/8 done24machine # 25machine # Virtualisation disk image created.26machine # Starting virtiofs daemons...27machine # [2026-10-01T03:46:09Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)28machine # [2026-10-01T03:46:09Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether29machine # [2026-10-01T03:46:09Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)30machine # [2026-10-01T03:46:09Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether31machine # [2026-10-01T03:46:09Z INFO virtiofsd] Waiting for vhost-user socket connection...32machine # [2026-10-01T03:46:09Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)33machine # [2026-10-01T03:46:09Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether34machine # [2026-10-01T03:46:09Z INFO virtiofsd] Waiting for vhost-user socket connection...35machine # [2026-10-01T03:46:09Z INFO virtiofsd] Waiting for vhost-user socket connection...36machine # [2026-10-01T03:46:09Z INFO virtiofsd] Client connected, servicing requests37machine # [2026-10-01T03:46:09Z INFO virtiofsd] Client connected, servicing requests38machine # [2026-10-01T03:46:09Z INFO virtiofsd] Client connected, servicing requests39machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]40machine # [ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 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 s186776 r8192 d116328 u31129665machine # [ 0.000000] Detected PIPT I-cache on CPU066machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)67machine # [ 0.000000] CPU features: detected: GICv3 CPU interface68machine # [ 0.000000] CPU features: detected: Spectre-v469machine # [ 0.000000] CPU features: detected: Spectre-BHB70machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_3871machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_2372machine # [ 0.000000] alternatives: applying boot alternatives73machine # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/init regInfo=/nix/.ro-store/7snk21cif5fc9kvnpgs1sarawmyf4kkf-closure-info/registration console=ttyAMA0,115200n8 console=tty074machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/7snk21cif5fc9kvnpgs1sarawmyf4kkf-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 75026 entries in 294 pages88machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups89machine # [ 0.000000] rcu: Hierarchical RCU implementation.90machine # [ 0.000000] rcu: RCU event tracing is enabled.91machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.92machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.93machine # [ 0.000000] Rude variant of Tasks RCU enabled.94machine # [ 0.000000] Tracing variant of Tasks RCU enabled.95machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.96machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=197machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.98machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.99machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.100machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0101machine # [ 0.000000] GICv3: 256 SPIs implemented102machine # [ 0.000000] GICv3: 0 Extended SPIs implemented103machine # [ 0.000000] Root IRQ handler: gic_handle_irq104machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI105machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0106machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000107machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]108machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)109machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)110machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000111machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000112machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.113machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns114machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).115machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns116machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns117machine # [ 0.000077] arm-pv: using stolen time PV118machine # [ 0.002826] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)119machine # [ 0.003029] Console: colour dummy device 80x25120machine # [ 0.003038] printk: legacy console [tty0] enabled121machine # [ 0.003248] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)122machine # [ 0.003255] pid_max: default: 32768 minimum: 301123machine # [ 0.003370] LSM: initializing lsm=capability,landlock,yama,bpf,ima124machine # [ 0.003894] landlock: Up and running.125machine # [ 0.003897] Yama: becoming mindful.126machine # [ 0.006583] LSM support for eBPF active127machine # [ 0.006911] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)128machine # [ 0.006944] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)129machine # [ 0.009127] rcu: Hierarchical SRCU implementation.130machine # [ 0.009135] rcu: Max phase no-delay instances is 1000.131machine # [ 0.010534] fsl-mc MSI: its@8080000 domain created132machine # [ 0.010666] EFI services will not be available.133machine # [ 0.010792] smp: Bringing up secondary CPUs ...134machine # [ 0.010803] smp: Brought up 1 node, 1 CPU135machine # [ 0.010806] SMP: Total of 1 processors activated.136machine # [ 0.010809] CPU: All CPU(s) started at EL1137machine # [ 0.010820] CPU features: detected: Branch Target Identification138machine # [ 0.010828] CPU features: detected: ARMv8.4 Translation Table Level139machine # [ 0.010831] CPU features: detected: Instruction cache invalidation not required for I/D coherence140machine # [ 0.010835] CPU features: detected: Data cache clean to the PoU not required for I/D coherence141machine # [ 0.010839] CPU features: detected: Common not Private translations142machine # [ 0.010842] CPU features: detected: CRC32 instructions143machine # [ 0.010845] CPU features: detected: Data cache clean to Point of Deep Persistence144machine # [ 0.010848] CPU features: detected: Data cache clean to Point of Persistence145machine # [ 0.010852] CPU features: detected: Data independent timing control (DIT)146machine # [ 0.010855] CPU features: detected: E0PD147machine # [ 0.010857] CPU features: detected: Enhanced Counter Virtualization148machine # [ 0.010860] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)149machine # [ 0.010864] CPU features: detected: Enhanced Virtualization Traps150machine # [ 0.010867] CPU features: detected: Fine Grained Traps151machine # [ 0.010871] CPU features: detected: Generic authentication (architected QARMA5 algorithm)152machine # [ 0.010875] CPU features: detected: RCpc load-acquire (LDAPR)153machine # [ 0.010878] CPU features: detected: LSE atomic instructions154machine # [ 0.010881] CPU features: detected: Privileged Access Never155machine # [ 0.010883] CPU features: detected: PMUv3156machine # [ 0.010886] CPU features: detected: RAS Extension Support157machine # [ 0.010889] CPU features: detected: RASv1p1 Extension Support158machine # [ 0.010892] CPU features: detected: Random Number Generator159machine # [ 0.010894] CPU features: detected: Speculation barrier (SB)160machine # [ 0.010897] CPU features: detected: Stage-2 Force Write-Back161machine # [ 0.010899] CPU features: detected: TLB range maintenance instructions162machine # [ 0.010904] CPU features: detected: Speculative Store Bypassing Safe (SSBS)163machine # [ 0.010963] alternatives: applying system-wide alternatives164machine # [ 0.014298] CPU features: detected: BBM Level 2 without TLB conflict abort165machine # [ 0.014564] Memory: 893460K/1048576K available (24512K kernel code, 7094K rwdata, 26568K rodata, 4736K init, 1106K bss, 113608K reserved, 32768K cma-reserved)166machine # [ 0.014967] devtmpfs: initialized167machine # [ 0.016856] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)168machine # [ 0.016882] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).169machine # [ 0.017099] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL170machine # [ 0.017104] 0 pages in range for non-PLT usage171machine # [ 0.017105] 508208 pages in range for PLT usage172machine # [ 0.017228] pinctrl core: initialized pinctrl subsystem173machine # [ 0.018201] DMI not present or invalid.174machine # [ 0.025138] NET: Registered PF_NETLINK/PF_ROUTE protocol family175machine # [ 0.027829] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations176machine # [ 0.027999] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations177machine # [ 0.028164] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations178machine # [ 0.028199] audit: initializing netlink subsys (disabled)179machine # [ 0.028915] thermal_sys: Registered thermal governor 'fair_share'180machine # [ 0.028917] thermal_sys: Registered thermal governor 'bang_bang'181machine # [ 0.028921] thermal_sys: Registered thermal governor 'step_wise'182machine # [ 0.028924] thermal_sys: Registered thermal governor 'user_space'183machine # [ 0.028926] thermal_sys: Registered thermal governor 'power_allocator'184machine # [ 0.028959] audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1185machine # [ 0.028967] cpuidle: using governor ladder186machine # [ 0.028973] cpuidle: using governor menu187machine # [ 0.029198] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.188machine # [ 0.029215] ASID allocator initialised with 65536 entries189machine # [ 0.030645] Serial: AMBA PL011 UART driver190machine # [ 0.036650] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1191machine # [ 0.036848] printk: console [ttyAMA0] enabled192machine # [ 0.178144] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages193machine # [ 0.178157] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page194machine # [ 0.178161] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages195machine # [ 0.178164] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page196machine # [ 0.178167] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages197machine # [ 0.178170] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page198machine # [ 0.178173] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages199machine # [ 0.178175] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page200machine # [ 0.179754] fbcon: Taking over console201machine # [ 0.179767] ACPI: Interpreter disabled.202machine # [ 0.189940] iommu: Default domain type: Translated203machine # [ 0.189948] iommu: DMA domain TLB invalidation policy: strict mode204machine # [ 0.190454] SCSI subsystem initialized205machine # [ 0.192632] usbcore: registered new interface driver usbfs206machine # [ 0.192672] usbcore: registered new interface driver hub207machine # [ 0.192696] usbcore: registered new device driver usb208machine # [ 0.193025] pps_core: LinuxPPS API ver. 1 registered209machine # [ 0.193029] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>210machine # [ 0.193038] PTP clock support registered211machine # [ 0.193080] EDAC MC: Ver: 3.0.0212machine # [ 0.194408] scmi_core: SCMI protocol bus registered213machine # [ 0.200517] FPGA manager framework214machine # [ 0.203284] vgaarb: loaded215machine # [ 0.203613] clocksource: Switched to clocksource arch_sys_counter216machine # [ 0.209365] VFS: Disk quotas dquot_6.6.0217machine # [ 0.209398] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)218machine # [ 0.213352] netfs: FS-Cache loaded219machine # [ 0.213525] pnp: PnP ACPI: disabled220machine # [ 0.218754] NET: Registered PF_INET protocol family221machine # [ 0.218938] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)222machine # [ 0.251898] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)223machine # [ 0.251945] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)224machine # [ 0.251975] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)225machine # [ 0.252023] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)226machine # [ 0.252095] TCP: Hash tables configured (established 8192 bind 8192)227machine # [ 0.252188] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)228machine # [ 0.252253] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)229machine # [ 0.252301] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)230machine # [ 0.252397] NET: Registered PF_UNIX/PF_LOCAL protocol family231machine # [ 0.252415] NET: Registered PF_XDP protocol family232machine # [ 0.252433] PCI: CLS 0 bytes, default 64233machine # [ 0.252723] Trying to unpack rootfs image as initramfs...234machine # [ 0.271657] kvm [1]: HYP mode not available235machine # [ 0.432256] Initialise system trusted keyrings236machine # [ 0.432406] workingset: timestamp_bits=42 max_order=18 bucket_order=0237machine # [ 0.432814] squashfs: version 4.0 (2009/01/31) Phillip Lougher238machine # [ 0.432865] 9p: Installing v9fs 9p2000 file system support239machine # [ 0.461103] Key type asymmetric registered240machine # [ 0.461123] Asymmetric key parser 'x509' registered241machine # [ 0.461216] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)242machine # [ 0.461525] io scheduler mq-deadline registered243machine # [ 0.461530] io scheduler kyber registered244machine # [ 0.474431] pl061_gpio 9030000.pl061: PL061 GPIO chip registered245machine # [ 0.475050] ledtrig-cpu: registered to indicate activity on CPUs246machine # [ 0.475453] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:247machine # [ 0.475468] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000248machine # [ 0.475478] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000249machine # [ 0.475483] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000250machine # [ 0.475506] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits251machine # [ 0.475527] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]252machine # [ 0.475603] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00253machine # [ 0.475610] pci_bus 0000:00: root bus resource [bus 00-ff]254machine # [ 0.475613] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]255machine # [ 0.475617] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]256machine # [ 0.495745] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]257machine # [ 0.495877] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint258machine # [ 0.496413] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint259machine # [ 0.496607] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]260machine # [ 0.496619] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]261machine # [ 0.496646] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]262machine # [ 0.496658] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]263machine # [ 0.497147] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint264machine # [ 0.497349] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]265machine # [ 0.497361] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]266machine # [ 0.497388] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]267machine # [ 0.497922] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint268machine # [ 0.498112] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]269machine # [ 0.498124] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]270machine # [ 0.498151] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]271machine # [ 0.498644] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint272machine # [ 0.498835] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]273machine # [ 0.498847] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]274machine # [ 0.498874] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]275machine # [ 0.498886] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]276machine # [ 0.499388] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint277machine # [ 0.499588] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]278machine # [ 0.499640] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]279machine # [ 0.500131] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint280machine # [ 0.500325] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]281machine # [ 0.500351] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]282machine # [ 0.500770] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint283machine # [ 0.500961] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]284machine # [ 0.501267] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint285machine # [ 0.501467] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]286machine # [ 0.501494] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]287machine # [ 0.502092] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint288machine # [ 0.502299] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]289machine # [ 0.502326] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]290machine # [ 0.502828] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint291machine # [ 0.503025] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]292machine # [ 0.503052] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]293machine # [ 0.503564] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint294machine # [ 0.503892] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]295machine # [ 0.503905] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]296machine # [ 0.503932] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]297machine # [ 0.504445] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint298machine # [ 0.504643] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]299machine # [ 0.504655] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]300machine # [ 0.504682] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]301machine # [ 0.505340] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned302machine # [ 0.505346] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned303machine # [ 0.505350] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned304machine # [ 0.505395] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned305machine # [ 0.505438] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned306machine # [ 0.505482] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned307machine # [ 0.505531] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned308machine # [ 0.505576] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned309machine # [ 0.505621] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned310machine # [ 0.505665] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned311machine # [ 0.505710] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned312machine # [ 0.505754] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned313machine # [ 0.505835] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned314machine # [ 0.505889] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned315machine # [ 0.505908] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned316machine # [ 0.505926] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned317machine # [ 0.505945] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned318machine # [ 0.505963] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned319machine # [ 0.505984] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned320machine # [ 0.506003] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned321machine # [ 0.506021] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned322machine # [ 0.506040] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned323machine # [ 0.506062] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned324machine # [ 0.506081] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned325machine # [ 0.506101] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned326machine # [ 0.506120] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned327machine # [ 0.506139] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned328machine # [ 0.506156] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned329machine # [ 0.506174] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned330machine # [ 0.506192] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned331machine # [ 0.506210] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned332machine # [ 0.506235] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]333machine # [ 0.506244] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]334machine # [ 0.506246] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]335machine # [ 0.507203] pci 0000:00:07.0: enabling device (0000 -> 0002)336machine # [ 0.615888] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)337machine # [ 0.618041] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)338machine # [ 0.627916] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)339machine # [ 0.630283] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)340machine # [ 0.640844] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)341machine # [ 0.643107] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)342machine # [ 0.646809] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)343machine # [ 0.657087] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)344machine # [ 0.659323] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)345machine # [ 0.663134] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)346machine # [ 0.673283] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)347machine # [ 0.685104] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled348machine # [ 0.687336] msm_serial: driver initialized349machine # [ 0.687480] SuperH (H)SCI(F) driver initialized350machine # [ 0.687543] STM32 USART driver initialized351machine # [ 0.726207] loop: module loaded352machine # [ 0.726418] virtio_blk virtio2: 1/0/0 default/read/poll queues353machine # [ 0.727328] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)354machine # [ 0.740475] megasas: 07.734.00.00-rc1355machine # [ 0.741314] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]356machine # [ 0.743530] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000357machine # [ 0.743551] Intel/Sharp Extended Query Table at 0x0031358machine # [ 0.749240] Using buffer write method359machine # [ 0.749291] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]360machine # [ 0.751155] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000361machine # [ 0.751177] Intel/Sharp Extended Query Table at 0x0031362machine # [ 0.766144] Using buffer write method363machine # [ 0.766173] Concatenating MTD devices:364machine # [ 0.766176] (0): "0.flash"365machine # [ 0.766178] (1): "0.flash"366machine # [ 0.766180] into device "0.flash"367machine # [ 1.076977] Freeing initrd memory: 26428K368machine # [ 1.083985] tun: Universal TUN/TAP device driver, 1.6369machine # [ 1.087531] thunder_xcv, ver 1.0370machine # [ 1.087562] thunder_bgx, ver 1.0371machine # [ 1.087581] nicpf, ver 1.0372machine # [ 1.090272] e1000: Intel(R) PRO/1000 Network Driver373machine # [ 1.090279] e1000: Copyright (c) 1999-2006 Intel Corporation.374machine # [ 1.090304] e1000e: Intel(R) PRO/1000 Network Driver375machine # [ 1.090315] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.376machine # [ 1.090338] igb: Intel(R) Gigabit Ethernet Network Driver377machine # [ 1.090342] igb: Copyright (c) 2007-2014 Intel Corporation.378machine # [ 1.090361] igbvf: Intel(R) Gigabit Virtual Function Network Driver379machine # [ 1.090364] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.380machine # [ 1.090499] sky2: driver version 1.30381machine # [ 1.098972] usbcore: registered new interface driver usb-storage382machine # [ 1.099144] usbcore: registered new interface driver usbserial_generic383machine # [ 1.099157] usbserial: USB Serial support registered for generic384machine # [ 1.100470] ehci-pci 0000:00:07.0: EHCI Host Controller385machine # [ 1.100496] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1386machine # [ 1.100673] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000387machine # [ 1.106210] hv_vmbus: registering driver hyperv_keyboard388machine # [ 1.107217] rtc-pl031 9010000.pl031: registered as rtc0389machine # [ 1.107239] rtc-pl031 9010000.pl031: setting system clock to 2026-10-01T03:46:12 UTC (1790826372)390machine # [ 1.107555] i2c_dev: i2c /dev entries driver391machine # [ 1.111863] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00392machine # [ 1.112171] hub 1-0:1.0: USB hub found393machine # [ 1.112189] hub 1-0:1.0: 6 ports detected394machine # [ 1.115182] sdhci: Secure Digital Host Controller Interface driver395machine # [ 1.115189] sdhci: Copyright(c) Pierre Ossman396machine # [ 1.115480] Synopsys Designware Multimedia Card Interface Driver397machine # [ 1.120028] sdhci-pltfm: SDHCI platform and OF driver helper398machine # [ 1.121737] hid: raw HID events driver (C) Jiri Kosina399machine # [ 1.122007] usbcore: registered new interface driver usbhid400machine # [ 1.122011] usbhid: USB HID core driver401machine # [ 1.123249] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available402machine # [ 1.124900] drop_monitor: Initializing network drop monitor service403machine # [ 1.125097] NET: Registered PF_INET6 protocol family404machine # [ 1.131156] Segment Routing with IPv6405machine # [ 1.131182] In-situ OAM (IOAM) with IPv6406machine # [ 1.131212] NET: Registered PF_PACKET protocol family407machine # [ 1.131283] 9pnet: Installing 9P2000 support408machine # [ 1.131330] Key type dns_resolver registered409machine # [ 1.140337] registered taskstats version 1410machine # [ 1.140501] Loading compiled-in X.509 certificates411machine # [ 1.149789] Demotion targets for Node 0: null412machine # [ 1.149964] Key type .fscrypt registered413machine # [ 1.149968] Key type fscrypt-provisioning registered414machine # [ 1.150074] ima: No TPM chip found, activating TPM-bypass!415machine # [ 1.150092] ima: Allocated hash algorithm: sha1416machine # [ 1.150115] ima: No architecture policies found417machine # [ 1.150932] input: gpio-keys as /devices/platform/gpio-keys/input/input0418machine # [ 1.175973] clk: Disabling unused clocks419machine # [ 1.175993] PM: genpd: Disabling unused power domains420machine # [ 1.179068] Freeing unused kernel memory: 4736K421machine # [ 1.179271] Run /init as init process422machine # [ 1.198826] systemd[1]: Successfully made /usr/ read-only.423machine # [ 1.199326] systemd[1]: systemd 263-889bc48 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)424machine # [ 1.199342] systemd[1]: Detected virtualization qemu.425machine # [ 1.199384] systemd[1]: Detected architecture arm64.426machine # [ 1.199389] systemd[1]: Running in initrd.427machine # [ 1.206741] systemd[1]: Initializing machine ID from random generator.428machine # [ 1.206878] systemd[1]: Hostname set to <machine>.429machine # [ 1.309451] systemd[1]: bpf-restrict-fs: LSM BPF program attached430machine # [ 1.367737] usb 1-1: new high-speed USB device number 2 using ehci-pci431machine # [ 1.373318] systemd[1]: Queued start job for default target Initrd Default Target.432machine # [ 1.379118] systemd[1]: Created slice Slice /system/modprobe.433machine # [ 1.379322] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.434machine # [ 1.379352] systemd[1]: Expecting device /dev/disk/by-label/nixos...435machine # [ 1.379374] systemd[1]: Reached target Path Units.436machine # [ 1.379387] systemd[1]: Reached target Slice Units.437machine # [ 1.379403] systemd[1]: Reached target Swaps.438machine # [ 1.379418] systemd[1]: Reached target Timer Units.439machine # [ 1.379569] systemd[1]: Listening on D-Bus System Message Bus Socket.440machine # [ 1.386003] systemd[1]: Listening on Journal Socket (/dev/log).441machine # [ 1.386164] systemd[1]: Listening on Journal Sockets.442machine # [ 1.386250] systemd[1]: Listening on udev Kernel Socket.443machine # [ 1.386266] systemd[1]: Reached target Socket Units.444machine # [ 1.391871] systemd[1]: Starting Create List of Static Device Nodes...445machine # [ 1.391954] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs446machine # [ 1.399901] systemd[1]: Mounting Kernel Configuration File System...447machine # [ 1.410074] systemd[1]: Starting Journal Service...448machine # [ 1.424091] systemd[1]: Starting Load Kernel Modules...449machine # [ 1.424215] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os450machine # [ 1.455889] systemd[1]: Starting Coldplug All udev Devices...451machine # [ 1.464409] systemd-journald[71]: Collecting audit messages is disabled.452machine # [ 1.470753] systemd[1]: Finished Create List of Static Device Nodes.453machine # [ 1.504398] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...454machine # [ 1.505129] systemd[1]: Mounted Kernel Configuration File System.455machine # [ 1.545137] 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/input1456machine # [ 1.561247] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.457machine # [ 1.565527] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev458machine # [ 1.572564] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.459machine # [ 1.577101] systemd[1]: Starting Create Static Device Nodes in /dev...460machine # [ 1.587964] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0461machine # [ 1.588214] [drm] features: -virgl +edid -resource_blob -host_visible462machine # [ 1.588217] [drm] features: -context_init463machine # [ 1.589002] [drm] number of scanouts: 1464machine # [ 1.589013] [drm] number of cap sets: 0465machine # [ 1.608102] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic466machine # [ 1.608119] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0467machine # [ 1.639979] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0468machine # [ 1.640526] Console: switching to colour frame buffer device 160x50469machine # [ 1.651056] systemd[1]: Started Journal Service.470machine # [ 1.636559] systemd-modules-load[73]: Inserted module 'dm_mod'471machine # [ 1.640387] systemd-modules-load[73]: Module 'virtio_balloon' is built in472machine # [ 1.661599] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device473machine # [ 1.648503] systemd-modules-load[73]: Module 'virtio_console' is built in474machine # [ 1.652863] systemd[1]: Finished Create Static Device Nodes in /dev.475machine # [ 1.655162] systemd[1]: Reached target Preparation for Local File Systems.476machine # [ 1.661815] systemd[1]: Reached target Local File Systems.477machine # [ 1.662904] systemd[1]: Starting Create System Files and Directories...478machine # [ 1.663946] systemd-modules-load[73]: Inserted module 'virtio_gpu'479machine # [ 1.675469] systemd-modules-load[73]: Module 'virtio_rng' is built in480machine # [ 1.676637] systemd[1]: Starting Rule-based Manager for Device Events and Files...481machine # [ 1.678003] systemd[1]: Finished Load Kernel Modules.482machine # [ 1.708619] systemd[1]: Starting Apply Kernel Variables...483machine # [ 1.743173] systemd[1]: Finished Create System Files and Directories.[ 1.759987] usb 1-2: new high-speed USB device number 3 using ehci-pci484machine # 485machine # [ 1.761976] systemd[1]: Finished Apply Kernel Variables.486machine # [ 1.781534] systemd-udevd[79]: Using default interface naming scheme 'v261'.487machine # [ 1.820115] systemd[1]: Started Rule-based Manager for Device Events and Files.488machine # [ 1.895484] systemd[1]: Starting Virtual Console Setup...489machine # [ 1.926994] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2490machine # [ 1.927294] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0491machine # [ 1.994619] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones.492machine # [ 2.004466] systemd[1]: Finished Virtual Console Setup.493machine # [ 2.715227] systemd[1]: Finished Coldplug All udev Devices.494machine # [ 2.716285] systemd[1]: Reached target System Initialization.495machine # [ 2.717153] systemd[1]: Reached target Basic System.496machine # [ 2.923342] (udev-worker)[90]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.497machine # [ 2.928209] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line.498machine # [ 2.988995] systemd[1]: Found device /dev/disk/by-label/nixos.499machine # [ 2.995481] systemd[1]: Reached target Initrd Root Device.500machine # [ 3.001886] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...501machine # [ 3.058656] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks502machine # [ 3.067300] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.503machine # [ 3.069243] systemd[1]: Mounting /sysroot...504machine # [ 3.128934] EXT4-fs (vda): mounted filesystem e5fb7b1c-1358-44cd-adf4-7e178c357316 r/w with ordered data mode. Quota mode: none.505machine # [ 3.115028] systemd[1]: Mounted /sysroot.506machine # [ 3.117042] systemd[1]: Reached target Initrd Root File System.507machine # [ 3.123373] systemd[1]: Starting Mountpoints Configured in the Real Root...508machine # [ 3.152492] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload.509machine # [ 3.161661] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)...510machine # [ 3.164921] systemd[1]: Reloading...511machine # [ 3.379792] systemd[1]: Reloading finished in 214 ms.512machine # [ 3.412266] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace...513machine # [ 3.417129] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace...514machine # [ 3.427344] systemd[1]: initrd-parse-etc.service: Deactivated successfully.515machine # [ 3.430591] systemd[1]: Finished Mountpoints Configured in the Real Root.516machine # [ 3.432795] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.517machine # [ 3.448262] systemd[1]: Mounting /sysroot/nix/.ro-store...518machine # [ 3.453105] systemd[1]: Mounting /sysroot/nix/.rw-store...519machine # [ 3.460194] systemd[1]: Mounting /sysroot/run...520machine # [ 3.480338] systemd[1]: Mounting /sysroot/tmp/shared...521machine # [ 3.516416] systemd[1]: Mounting /sysroot/tmp/xchg...522machine # [ 3.598920] fuse: init (API version 7.45)523machine # [ 3.616400] virtiofs virtio6: discovered new tag: nix-store524machine # [ 3.617257] virtiofs virtio6: virtio_fs_setup_dax: No cache capability525machine # [ 3.610649] systemd[1]: Mounted /sysroot/nix/.rw-store.526machine # [ 3.633358] virtiofs virtio7: discovered new tag: shared527machine # [ 3.634212] virtiofs virtio7: virtio_fs_setup_dax: No cache capability528machine # [ 3.620606] systemd[1]: Mounted /sysroot/run.529machine # [ 3.644311] virtiofs virtio8: discovered new tag: xchg530machine # [ 3.645163] virtiofs virtio8: virtio_fs_setup_dax: No cache capability531machine # [ 3.653442] systemd[1]: Starting rw-sysroot-nix-store.service...532machine # [ 3.656878] systemd[1]: Mounted /sysroot/tmp/shared.533machine # [ 3.658669] systemd[1]: Mounted /sysroot/tmp/xchg.534machine # [ 3.662970] systemd[1]: Mounted /sysroot/nix/.ro-store.535machine # [ 3.695816] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.536machine # [ 3.699072] systemd[1]: Finished rw-sysroot-nix-store.service.537machine # [ 3.701912] systemd[1]: Mounting /sysroot/nix/store...538machine # [ 3.753344] systemd[1]: Mounted /sysroot/nix/store.539machine # [ 3.755656] systemd[1]: Reached target Initrd File Systems.540machine # [ 3.758002] systemd[1]: Starting Find NixOS closure...541machine # [ 3.766583] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...542machine # [ 3.814682] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.543machine # [ 3.825950] systemd[1]: Finished Find NixOS closure.544machine # [ 3.829099] systemd[1]: Reached target Initrd Default Target.545machine # [ 3.834475] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...546machine # [ 3.875876] systemd[1]: Stopped target Initrd Default Target.547machine # [ 3.878976] systemd[1]: Stopped target Basic System.548machine # [ 3.885073] systemd[1]: Stopped target Initrd Root Device.549machine # [ 3.887041] systemd[1]: Stopped target Path Units.550machine # [ 3.887839] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.551machine # [ 3.891985] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.552machine # [ 3.895126] systemd[1]: Stopped target Slice Units.553machine # [ 3.901965] systemd[1]: Stopped target Socket Units.554machine # [ 3.902954] systemd[1]: Stopped target System Initialization.555machine # [ 3.904866] systemd[1]: Stopped target Swaps.556machine # [ 3.908756] systemd[1]: Stopped target Timer Units.557machine # [ 3.912276] systemd[1]: dbus.socket: Deactivated successfully.558machine # [ 3.915563] systemd[1]: Closed D-Bus System Message Bus Socket.559machine # [ 3.918637] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.560machine # [ 3.919837] systemd[1]: Stopped Find NixOS closure.561machine # [ 3.925892] systemd[1]: Starting rw-sysroot-nix-store.service...562machine # [ 3.926921] systemd[1]: systemd-sysctl.service: Deactivated successfully.563machine # [ 3.927931] systemd[1]: Stopped Apply Kernel Variables.564machine # [ 3.934172] systemd[1]: systemd-modules-load.service: Deactivated successfully.565machine # [ 3.940918] systemd[1]: Stopped Load Kernel Modules.566machine # [ 3.942292] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.567machine # [ 3.943538] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.568machine # [ 3.952380] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.569machine # [ 3.953593] systemd[1]: Stopped Create System Files and Directories.570machine # [ 3.954943] systemd[1]: Stopped target Local File Systems.571machine # [ 3.960009] systemd[1]: Stopped target Preparation for Local File Systems.572machine # [ 3.964561] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.573machine # [ 3.968356] systemd[1]: Stopped Coldplug All udev Devices.574machine # [ 3.969624] systemd[1]: Stopping Rule-based Manager for Device Events and Files...575machine # [ 3.973755] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.576machine # [ 3.975003] systemd[1]: Stopped Virtual Console Setup.577machine # [ 3.975782] systemd[1]: initrd-cleanup.service: Deactivated successfully.578machine # [ 3.976949] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.579machine # [ 3.977939] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.580machine # [ 3.979022] systemd[1]: Finished rw-sysroot-nix-store.service.581machine # [ 3.983611] systemd[1]: systemd-udevd.service: Deactivated successfully.582machine # [ 3.987090] systemd[1]: Stopped Rule-based Manager for Device Events and Files.583machine # [ 3.988310] systemd[1]: systemd-udevd.service: Consumed 1.044s CPU time over 2.324s wall clock time, 18.4M memory peak.584machine # [ 3.992535] systemd[1]: Starting Cleanup udev Database...585machine # [ 3.993512] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.586machine # [ 3.996374] systemd[1]: Stopped Create Static Device Nodes in /dev.587machine # [ 3.999588] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.588machine # [ 4.001247] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.589machine # [ 4.002432] systemd[1]: kmod-static-nodes.service: Deactivated successfully.590machine # [ 4.003457] systemd[1]: Stopped Create List of Static Device Nodes.591machine # [ 4.035703] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.592machine # [ 4.038304] systemd[1]: Finished Cleanup udev Database.593machine # [ 4.042784] systemd[1]: Reached target Switch Root.594machine # [ 4.044421] systemd[1]: Starting NixOS Activation...595machine # [ 4.133223] initrd-nixos-activation-start[168]: booting system configuration /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test596machine # [ 4.169690] initrd-nixos-activation-start[168]: running activation script...597machine # [ 4.423671] initrd-nixos-activation-start[191]: setting up /etc...598machine # [ 4.557658] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.599machine # [ 4.560238] systemd[1]: Finished NixOS Activation.600machine # [ 4.562565] systemd[1]: Starting Switch Root...601machine # [ 4.590470] systemd[1]: Switching root.602machine # [ 4.777510] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).603machine # [ 4.925485] systemd[1]: systemd 263-889bc48 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)604machine # [ 4.926644] systemd[1]: Detected virtualization qemu.605machine # [ 4.926691] systemd[1]: Detected architecture arm64.606machine # [ 4.926766] systemd[1]: Detected first boot.607machine # [ 4.935133] systemd[1]: Initializing machine ID from random generator.608machine # [ 5.075516] systemd[1]: bpf-restrict-fs: LSM BPF program attached609machine # [ 5.225964] systemd[1]: Applying preset policy.610machine # [ 5.440052] systemd[1]: Populated /etc with preset unit settings.611machine # [ 5.646334] systemd[1]: initrd-switch-root.service: Deactivated successfully.612machine # [ 5.647245] systemd[1]: Stopped initrd-switch-root.service.613machine # [ 5.652610] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.614machine # [ 5.654506] systemd[1]: Created slice Slice /system/getty.615machine # [ 5.658191] systemd[1]: Created slice User and Session Slice.616machine # [ 5.658842] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.617machine # [ 5.662136] systemd[1]: Started Forward Password Requests to Wall Directory Watch.618machine # [ 5.662613] systemd[1]: Expecting device /dev/hvc0...619machine # [ 5.663311] systemd[1]: Expecting device /dev/ttyAMA0...620machine # [ 5.667024] systemd[1]: Reached target Local Encrypted Volumes.621machine # [ 5.667490] systemd[1]: Stopped target initrd-fs.target.622machine # [ 5.670436] systemd[1]: Stopped target initrd-root-fs.target.623machine # [ 5.670884] systemd[1]: Stopped target initrd-switch-root.target.624machine # [ 5.671602] systemd[1]: Reached target Virtual Machines and Containers.625machine # [ 5.675278] systemd[1]: Reached target Path Units.626machine # [ 5.677259] systemd[1]: Reached target Remote File Systems.627machine # [ 5.677691] systemd[1]: Reached target Slice Units.628machine # [ 5.678503] systemd[1]: Reached target Swaps.629machine # [ 5.682723] systemd[1]: Listening on Query the User Interactively for a Password.630machine # [ 5.686315] systemd[1]: Listening on Process Core Dump Socket.631machine # [ 5.688699] systemd[1]: Listening on Credential Encryption/Decryption.632machine # [ 5.690093] systemd[1]: Listening on Factory Reset Management.633machine # [ 5.690645] systemd[1]: Listening on Hostname Service Socket.634machine # [ 5.697008] systemd[1]: Starting Journal Log Access Socket...635machine # [ 5.698899] systemd[1]: Listening on Journal Audit Socket.636machine # [ 5.703401] systemd[1]: Listening on Console Output Muting Service Socket.637machine # [ 5.705617] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.638machine # [ 5.707004] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os639machine # [ 5.711407] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki640machine # [ 5.717093] systemd[1]: Listening on Disk Repartitioning Service Socket.641machine # [ 5.717745] systemd[1]: Listening on udev Varlink Socket.642machine # [ 5.723667] systemd[1]: Mounting Huge Pages File System...643machine # [ 5.729178] systemd[1]: Mounting POSIX Message Queue File System...644machine # [ 5.747921] systemd[1]: Mounting Kernel Debug File System...645machine # [ 5.754202] systemd[1]: Mounting Kernel Trace File System...646machine # [ 5.774037] systemd[1]: Starting Create List of Static Device Nodes...647machine # [ 5.782321] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs648machine # [ 5.808748] systemd[1]: Mounting Kernel Configuration File System...649machine # [ 5.809429] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm650machine # [ 5.820588] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore651machine # [ 5.821188] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse652machine # [ 5.841047] systemd[1]: Mounting FUSE Control File System...653machine # [ 5.843516] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67654machine # [ 5.877121] systemd[1]: Starting Journal Service...655machine # [ 5.896745] systemd[1]: Starting Load Kernel Modules...656machine # [ 5.911229] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...657machine # [ 5.938326] systemd[1]: Starting Remount Root and Kernel File Systems...658machine # [ 5.938758] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os659machine # [ 5.977600] systemd[1]: Starting Coldplug All udev Devices...660machine # [ 5.987579] systemd[1]: Listening on Journal Log Access Socket.661machine # [ 5.999123] systemd[1]: Mounted Huge Pages File System.662machine # [ 6.004818] systemd[1]: Mounted POSIX Message Queue File System.663machine # [ 6.005496] systemd[1]: Mounted Kernel Debug File System.664machine # [ 6.006103] systemd[1]: Mounted Kernel Trace File System.665machine # [ 6.016439] systemd[1]: Finished Create List of Static Device Nodes.666machine # [ 6.020020] systemd-journald[263]: Collecting audit messages is enabled.667machine # [ 6.017501] systemd[1]: Queued start job for default target Multi-User System.668machine # [ 6.019236] systemd[1]: systemd-journald.service: Deactivated successfully.669machine # [ 6.048709] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...670machine # [ 6.049462] systemd[1]: Started Journal Service.671machine # [ 6.035869] systemd-modules-load[264]: Module 'atkbd' is built in672machine # [ 6.047119] systemd-modules-load[264]: Module 'loop' is built in673machine # [ 6.065913] systemd[1]: Finished Load Kernel Modules.674machine # [ 6.095868] EXT4-fs (vda): re-mounted e5fb7b1c-1358-44cd-adf4-7e178c357316.675machine # [ 6.105585] systemd[1]: Finished Remount Root and Kernel File Systems.676machine # [ 6.112647] systemd-oomd[265]: No swap; memory pressure usage will be degraded677machine # [ 6.124932] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.678machine # [ 6.132398] systemd[1]: Mounted Kernel Configuration File System.679machine # [ 6.133502] systemd[1]: Mounted FUSE Control File System.680machine # [ 6.142600] systemd[1]: Listening on Disk Image Download Service Socket.681machine # [ 6.150851] systemd[1]: Starting Firewall...682machine # [ 6.158649] systemd[1]: Starting Flush Journal to Persistent Storage...683machine # [ 6.159789] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore684machine # [ 6.169788] systemd[1]: Starting Load/Save OS Random Seed...685machine # [ 6.182426] systemd[1]: Starting Apply Kernel Variables...686machine # [ 6.183450] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os687machine # [ 6.314148] systemd-journald[263]: Received client request to flush runtime journal.688machine # [ 6.453445] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.689machine # [ 6.455106] systemd[1]: Starting Create Static Device Nodes in /dev...690machine # [ 6.462325] systemd[1]: Finished Apply Kernel Variables.691machine # [ 6.463244] systemd[1]: Finished Load/Save OS Random Seed.692machine # [ 6.476378] systemd[1]: Reached target First Boot Complete.693machine # [ 6.477346] systemd[1]: Finished Flush Journal to Persistent Storage.694machine # [ 6.594676] systemd[1]: Finished Create Static Device Nodes in /dev.695machine # [ 6.595865] systemd[1]: Reached target Preparation for Local File Systems.696machine # [ 6.600716] systemd[1]: Starting Rule-based Manager for Device Events and Files...697machine # [ 6.639304] systemd[1]: Mounting /run/wrappers...698machine # [ 6.724596] systemd[1]: Mounted /run/wrappers.699machine # [ 6.725782] systemd[1]: Reached target Local File Systems.700machine # [ 6.734462] systemd[1]: Listening on Boot Loader Control Service Socket.701machine # [ 6.746906] systemd[1]: Starting Create SUID/SGID Wrappers...702machine # [ 6.747963] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.703machine # [ 6.756512] systemd[1]: Starting Save Transient machine-id to Disk...704machine # [ 6.768206] systemd[1]: Starting Create System Files and Directories...705machine # [ 7.056557] systemd[1]: Finished Create System Files and Directories.706machine # [ 7.072333] systemd[1]: Starting Rebuild Journal Catalog...707machine # [ 7.079879] systemd[1]: Starting Record System Boot/Shutdown in UTMP...708machine # [ 7.227957] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.709machine # [ 7.249030] systemd-udevd[302]: Using default interface naming scheme 'v261'.710machine # [ 7.250512] systemd[1]: Finished Save Transient machine-id to Disk.711machine # [ 7.290464] systemd[1]: Finished Record System Boot/Shutdown in UTMP.712machine # [ 7.307926] systemd[1]: Finished Rebuild Journal Catalog.713machine # [ 7.328295] systemd[1]: Starting Update is Completed...714machine # [ 7.427259] systemd[1]: Finished Update is Completed.715machine # [ 7.448164] systemd[1]: Started Rule-based Manager for Device Events and Files.716machine # [ 8.061207] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.717machine # [ 8.072227] systemd[1]: Finished Create SUID/SGID Wrappers.718machine # [ 8.156974] systemd[1]: Finished Coldplug All udev Devices.719machine # [ 8.159379] systemd[1]: Reached target System Initialization.720machine # [ 8.166521] systemd[1]: Started Discard unused filesystem blocks once a week.721machine # [ 8.167691] systemd[1]: Started Daily Cleanup of Temporary Directories.722machine # [ 8.172937] systemd[1]: Reached target Timer Units.723machine # [ 8.173775] systemd[1]: Listening on D-Bus System Message Bus Socket.724machine # [ 8.174802] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.725machine # [ 8.183336] systemd[1]: Reached target Socket Units.726machine # [ 8.186979] systemd[1]: Reached target Basic System.727machine # [ 8.187830] systemd[1]: Starting Import lastlog data into lastlog2 database...728machine # [ 8.195811] systemd[1]: Starting Name Service Cache Daemon (nsncd)...729machine # [ 8.198097] systemd[1]: Starting Post-Boot Actions...730machine # [ 8.215014] systemd[1]: Started Reset console on configuration changes.731machine # [ 8.242566] systemd[1]: Starting resolvconf update...732machine # [ 8.332192] systemd[1]: Starting D-Bus System Message Bus...733machine # [ 8.408641] nsncd[420]: Oct 01 03:46:19.817 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"734machine # [ 8.429279] systemd[1]: Started Name Service Cache Daemon (nsncd).735machine # [ 8.430434] systemd[1]: Reached target Host and Network Name Lookups.736machine # [ 8.431397] systemd[1]: Reached target User and Group Name Lookups.737machine # [ 8.467059] systemd[1]: Starting User Login Management...738machine # [ 8.508530] systemd[1]: Finished Post-Boot Actions.739machine # [ 8.547548] systemd[1]: Finished Import lastlog data into lastlog2 database.740machine # [ 8.640579] dbus-broker-launch[429]: Looking up NSS user entry for 'systemd-timesync'...741machine # [ 8.648367] dbus-broker-launch[429]: NSS returned no entry for 'systemd-timesync'742machine # [ 8.649601] dbus-broker-launch[429]: Invalid user-name in /nix/store/r21qlc763yx2sp1lnrvn2wkyx9l5bgx1-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"743machine # [ 8.708179] systemd[1]: Started D-Bus System Message Bus.744machine # [ 8.754427] systemd-logind[445]: New seat seat0.745machine # [ 8.764480] systemd[1]: Started User Login Management.746machine # [ 8.772783] dbus-broker-launch[429]: Ready747machine # [ 8.779236] systemd[1]: Starting linger-users.service...748machine # [ 8.855933] systemd[1]: Stopped target Host and Network Name Lookups.749machine # [ 8.866137] systemd[1]: Stopping Host and Network Name Lookups...750machine # [ 8.867443] systemd[1]: Stopped target User and Group Name Lookups.751machine # [ 8.871660] systemd[1]: Stopping User and Group Name Lookups...752machine # [ 8.875673] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...753machine # [ 8.880631] systemd[1]: nscd.service: Deactivated successfully.754machine # [ 8.881611] systemd[1]: Stopped Name Service Cache Daemon (nsncd).755machine # [ 8.932331] systemd[1]: Starting Name Service Cache Daemon (nsncd)...756machine # [ 8.982250] systemd[1]: Created slice Slice /user/1001.757machine # [ 9.008429] systemd[1]: Starting User Runtime Directory /run/user/1001...758machine # [ 9.059962] systemd[1]: Started Name Service Cache Daemon (nsncd).759machine # [ 9.070998] nsncd[510]: Oct 01 03:46:20.471 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"760machine # [ 9.087763] systemd[1]: linger-users.service: Deactivated successfully.761machine # [ 9.093542] systemd[1]: Finished linger-users.service.762machine # [ 9.094474] systemd[1]: Reached target Host and Network Name Lookups.763machine # [ 9.095461] systemd[1]: Reached target User and Group Name Lookups.764machine # [ 9.157569] systemd[1]: Finished resolvconf update.765machine # [ 9.162527] systemd[1]: Finished User Runtime Directory /run/user/1001.766machine # [ 9.183943] systemd[1]: Starting DHCP Client...767machine # [ 9.225807] systemd[1]: Starting User Manager for UID 1001...768machine # [ 9.389684] (systemd)[550]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0)769machine # [ 9.429021] systemd-logind[445]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'.770machine # [ 9.492605] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy771machine # [ 9.817111] systemd[550]: Queued start job for default target Main User Target.772machine # [ 9.851898] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy773machine # [ 9.894873] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3774machine # [ 9.905386] systemd[550]: Created slice User Application Slice.775machine # [ 9.906702] systemd[550]: Started Daily Cleanup of User's Temporary Directories.776machine # [ 9.907851] systemd[550]: Reached target Paths.777machine # [ 9.961001] systemd[550]: Reached target Timers.778machine # [ 9.976428] systemd[550]: Starting D-Bus User Message Bus Socket...779machine # [ 9.990414] systemd[550]: Starting Create User Files and Directories...780machine # [ 10.012247] systemd[550]: Finished Create User Files and Directories.781machine # [ 10.029062] systemd[550]: Listening on D-Bus User Message Bus Socket.782machine # [ 10.040794] systemd[550]: Reached target Sockets.783machine # [ 10.055120] systemd[550]: Reached target Basic System.784machine # [ 10.070123] systemd[1]: Started User Manager for UID 1001.785machine # [ 10.088912] systemd[550]: Starting Run user-specific NixOS activation...786machine # [ 10.100932] systemd[550]: Finished Run user-specific NixOS activation.787machine # [ 10.118813] systemd[550]: Reached target Main User Target.788machine # [ 10.140344] systemd[550]: Startup finished in 453ms.789machine # [ 10.297872] systemd[1]: Finished Firewall.790machine # [ 10.301187] systemd[1]: Reached target Preparation for Network.791machine # [ 10.305656] systemd[1]: Starting Extra networking commands....792machine # [ 10.323241] dhcpcd[568]: dhcpcd-10.3.2 starting793machine # [ 10.336995] dhcpcd[589]: dev: loaded udev794machine # [ 10.344095] dhcpcd[589]: no valid interfaces found795machine # [ 10.349684] dhcpcd[589]: no valid interfaces found796machine # [ 10.505051] systemd[1]: Starting Virtual Console Setup...797machine # [ 10.532510] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs798machine # [ 10.720174] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.799machine # [ 10.753537] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.800machine # [ 10.777293] systemd[1]: Started backdoor.service.801machine # [ 10.877443] 8021q: 802.1Q VLAN Support v1.8802machine # [ 10.915441] (udev-worker)[590]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.[ 11.001151] cfg80211: Loading compiled-in X.509 certificates for regulatory database803machine # 804machine # [ 10.989859] (udev-worker)[590]: Network interface NamePolicy= disabled on kernel command line.805machine # [ 11.083509] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'806machine # [ 11.085126] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'807machine # [ 11.089224] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2808machine # [ 11.089601] cfg80211: failed to load regulatory.db809machine # [ 11.269343] systemd[1]: Condition check resulted in Virtio network device being skipped.810machine # [ 11.298604] systemd-logind[445]: Watching system buttons on /dev/input/event0 (gpio-keys)811machine # [ 11.337833] systemd[1]: Starting Address configuration of eth1...812machine # connecting to host...813machine # [ 11.462852] mousedev: PS/2 mouse device common for all mice814machine: Guest shell says: b'Spawning backdoor root shell...\n'815machine: connected to guest root shell816machine: (connecting took 13.41 seconds)817machine: (finished: waiting for the VM to finish booting, in 13.84 seconds)818machine # [ 11.528317] dhcpcd[659]: /nix/store/92w4pf1lqszlcwfq9ma2y2vaad5dssks-openresolv-3.17.4/sbin/.resolvconf-wrapped: line 1250: kill: (603) - Operation not permitted819machine # [ 11.530497] dhcpcd[659]: .resolvconf-wrapped: clearing stale lock pid 603820machine # [ 11.664146] 8021q: adding VLAN 0 to HW filter on device eth1821machine # [ 11.667446] systemd[1]: Finished Extra networking commands..822machine # [ 11.685802] systemd[1]: Reached target Network.823machine # [ 11.686654] systemd[1]: Starting Permit User Sessions...824machine # [ 11.779806] 8021q: adding VLAN 0 to HW filter on device eth0825machine # [ 11.767567] systemd-logind[445]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)826machine # [ 11.796765] network-addresses-eth1-start[645]: adding address 192.168.1.1/24... done827machine # [ 11.798305] dhcpcd[589]: eth0: waiting for carrier828machine # [ 11.799176] dhcpcd[589]: eth0: carrier acquired829machine # [ 11.904426] network-addresses-eth1-start[645]: adding address 2001:db8:1::1/64... done830machine # [ 11.928894] dhcpcd[589]: DUID 00:01:00:01:32:50:94:0f:52:54:00:12:34:56831machine # [ 11.930055] dhcpcd[589]: eth0: IAID 00:12:34:56832machine # [ 11.930908] dhcpcd[589]: eth0: adding address fe80::5054:ff:fe12:3456833machine # [ 12.040712] systemd[1]: Finished Permit User Sessions.834machine # [ 12.041663] systemd[1]: Started Getty on tty1.835machine # [ 12.042560] systemd[1]: Reached target Login Prompts.836machine # [ 12.088648] systemd[1]: Finished Address configuration of eth1.837machine # [ 12.103723] systemd-vconsole-setup[604]: Configuration of first virtual console was skipped, ignoring remaining ones.838machine # [ 12.131821] systemd[1]: Finished Virtual Console Setup.839machine # [ 12.648260] dhcpcd[589]: eth0: soliciting a DHCP lease840machine # [ 12.668911] dhcpcd[589]: eth0: offered 10.0.2.15 from 10.0.2.2841machine # [ 12.669959] dhcpcd[589]: eth0: probing address 10.0.2.15/24842machine # [ 13.056478] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.843machine # [ 13.057787] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.844machine # [ 13.058982] systemd[1]: Stopped Virtual Console Setup.845machine # [ 13.095370] systemd[1]: Stopping Virtual Console Setup...846machine # [ 13.100889] systemd[1]: Starting Virtual Console Setup...847machine # [ 13.115104] systemd-logind[445]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)848machine # [ 13.122667] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.849machine # [ 13.123829] systemd[1]: Stopped Virtual Console Setup.850machine # [ 13.128378] systemd[1]: Starting Virtual Console Setup...851machine # [ 13.284424] systemd-vconsole-setup[707]: Configuration of first virtual console was skipped, ignoring remaining ones.852machine # [ 13.292231] systemd[1]: Finished Virtual Console Setup.853machine # [ 14.489489] dhcpcd[589]: eth0: soliciting an IPv6 router854machine # [ 14.491766] dhcpcd[589]: eth0: Router Advertisement from fe80::2855machine # [ 14.493490] dhcpcd[589]: eth0: adding address fec0::5054:ff:fe12:3456/64856machine # [ 14.495068] dhcpcd[589]: eth0: adding route to fec0::/64857machine # [ 14.496531] dhcpcd[589]: eth0: adding default route via fe80::2858machine # [ 17.694788] dhcpcd[589]: eth0: leased 10.0.2.15 for 86400 seconds859machine # [ 17.697829] dhcpcd[589]: eth0: adding route to 10.0.2.0/24860machine # [ 17.699201] dhcpcd[589]: eth0: adding default route via 10.0.2.2861machine # [ 17.807761] systemd[1]: Started DHCP Client.862machine # [ 17.810581] systemd[1]: Reached target Multi-User System.863machine # [ 17.811459] systemd[1]: Startup finished in 1.166s (kernel) + 3.666s (initrd) + 12.977s (userspace) = 17.809s.864machine: (finished: waiting for unit multi-user.target, in 20.99 seconds)865machine: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/bin/switch-to-configuration test866machine # Checking switch inhibitors... done867machine # [ 18.863809] nixos[824]: switching to system configuration /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test868machine # [ 18.866936] systemd[1]: Stopped target Local File Systems.869machine # [ 18.869050] systemd[1]: Stopped target Remote File Systems.870machine # activating the configuration...871machine # setting up /etc...872machine # [ 19.192800] systemd[1]: Reload requested from client PID 824 ('.switch-to-conf') (unit backdoor.service)...873machine # [ 19.194598] systemd[1]: Reloading...874machine # [ 19.529744] systemd[1]: Reloading finished in 333 ms.875machine # reloading user units for usertest...876machine # [ 19.586529] systemd[550]: Created slice User Core Session Slice.877machine # [ 19.588985] systemd[550]: Starting D-Bus User Message Bus...878machine # [ 19.620768] dbus-broker-launch[894]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/r21qlc763yx2sp1lnrvn2wkyx9l5bgx1-system-path/share/dbus-1/services/org.freedesktop.import1.service'879machine # [ 19.623973] dbus-broker-launch[894]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/r21qlc763yx2sp1lnrvn2wkyx9l5bgx1-system-path/share/dbus-1/services/org.freedesktop.machine1.service'880machine # [ 19.627117] dbus-broker-launch[894]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/r21qlc763yx2sp1lnrvn2wkyx9l5bgx1-system-path/share/dbus-1/services/org.freedesktop.portable1.service'881machine # [ 19.630287] dbus-broker-launch[894]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/r21qlc763yx2sp1lnrvn2wkyx9l5bgx1-system-path/share/dbus-1/services/org.freedesktop.systemd1.service'882machine # [ 19.635071] dbus-broker-launch[894]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored883machine # [ 19.638024] dbus-broker-launch[894]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored884machine # [ 19.639792] systemd[550]: Started D-Bus User Message Bus.885machine # [ 19.644110] dbus-broker-launch[894]: Ready886machine # [ 19.688138] systemd[550]: Reexecution requested from client PID 893 ('switch-to-confi')...887machine # [ 19.692247] systemd[550]: Reexecuting.888machine # [ 19.747771] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy889machine # [ 19.860856] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy890machine # [ 19.868082] systemd[550]: Reload requested from client PID 893 ('switch-to-confi')...891machine # [ 19.869458] systemd[550]: Reloading...892machine # [ 19.979716] systemd[550]: Reloading finished in 108 ms.893machine # [ 19.996223] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy894machine # restarting the following user units: nixos-activation.service895machine # [ 20.008114] systemd[550]: Stopped Run user-specific NixOS activation.896machine # [ 20.011887] systemd[550]: Stopping Run user-specific NixOS activation...897machine # [ 20.014667] systemd[550]: Starting Run user-specific NixOS activation...898machine # [ 20.049122] systemd[550]: Finished Run user-specific NixOS activation.899machine # restarting sysinit-reactivation.target900machine # [ 20.061933] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....901machine # [ 20.152282] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..902machine # [ 20.153605] systemd[1]: Reached target Reactivate sysinit units.903machine # [ 20.159639] systemd[1]: Reached target Remote File Systems.904machine # [ 20.164842] systemd[1]: Starting linger-users.service...905machine # [ 20.172575] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os906machine # [ 20.174066] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki907machine # [ 20.179944] systemd[1]: Reached target Local File Systems.908machine # [ 20.181542] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore909machine # [ 20.189644] systemd[1]: Starting Create SUID/SGID Wrappers...910machine # [ 20.190709] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.911machine # [ 20.201972] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67912machine # [ 20.210960] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore913machine # [ 20.214838] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os914machine # [ 20.217788] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os915machine # [ 20.256481] systemd[1]: linger-users.service: Deactivated successfully.916machine # [ 20.258481] systemd[1]: Finished linger-users.service.917machine # [ 20.418413] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.918machine # [ 20.420469] systemd[1]: Finished Create SUID/SGID Wrappers.919machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service920machine # [ 20.679799] nixos[824]: finished switching to system configuration /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test921machine: (finished: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/bin/switch-to-configuration test, in 2.04 seconds)922machine: must succeed: rm /etc/NIXOS923machine: (finished: must succeed: rm /etc/NIXOS, in 0.03 seconds)924machine: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/lhyz1cqawdrp86fih2gasi7wyafp6sqs-nixos-system-other-test/bin/switch-to-configuration test925machine # this should succeed (config: /nix/store/lhyz1cqawdrp86fih2gasi7wyafp6sqs-nixos-system-other-test, action: test)926machine # Checking switch inhibitors... done927machine # [ 20.944573] nixos[971]: switching to system configuration /nix/store/lhyz1cqawdrp86fih2gasi7wyafp6sqs-nixos-system-other-test928machine # [ 20.947223] systemd[1]: Stopped target Remote File Systems.929machine # activating the configuration...930machine # [ 20.950120] systemd[1]: Stopped target Local File Systems.931machine # removing user ‘usertest’932machine # setting up /etc...933machine # [ 21.283405] systemd[1]: Reload requested from client PID 971 ('.switch-to-conf') (unit backdoor.service)...934machine # [ 21.285601] systemd[1]: Reloading...935machine # [ 21.616907] systemd[1]: Reloading finished in 329 ms.936machine # reloading user units for usertest...937machine # [ 21.707592] systemd[550]: Reexecution requested from client PID 1043 ('switch-to-confi')...938machine # [ 21.710499] systemd[550]: Reexecuting.939machine # [ 21.768578] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy940machine # [ 21.885748] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy941machine # [ 21.892671] systemd[550]: Reload requested from client PID 1043 ('switch-to-confi')...942machine # [ 21.895219] systemd[550]: Reloading...943machine # [ 22.003223] systemd[550]: Reloading finished in 106 ms.944machine # [ 22.020239] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy945machine # restarting the following user units: nixos-activation.service946machine # [ 22.031671] systemd[550]: Stopped Run user-specific NixOS activation.947machine # [ 22.034382] systemd[550]: Stopping Run user-specific NixOS activation...948machine # [ 22.036871] systemd[550]: Starting Run user-specific NixOS activation...949machine # [ 22.069625] systemd[550]: Finished Run user-specific NixOS activation.950machine # restarting sysinit-reactivation.target951machine # [ 22.074600] systemd[1]: Stopped target Reactivate sysinit units.952machine # reloading the following units: dbus-broker.service953machine # [ 22.078554] systemd[1]: Stopping Reactivate sysinit units...954machine # [ 22.079485] systemd[1]: Reached target Reactivate sysinit units.955machine # [ 22.082640] systemd[1]: Reloading D-Bus System Message Bus...956machine # [ 22.084800] dbus-broker-launch[429]: Caught SIGHUP, trigger reload.957machine # [ 22.089195] dbus-broker-launch[429]: Looking up NSS user entry for 'systemd-timesync'...958machine # [ 22.091440] dbus-broker-launch[429]: NSS returned no entry for 'systemd-timesync'959machine # [ 22.092831] dbus-broker-launch[429]: Invalid user-name in /nix/store/bazmz3pkgsxs31n9mf1a0bzwvrdy5sq6-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"960machine # [ 22.109821] systemd[1]: Reloaded D-Bus System Message Bus.961machine # restarting the following units: network-addresses-eth1.service962machine # [ 22.116921] systemd[1]: Stopping Address configuration of eth1...963machine # [ 22.148329] network-addresses-eth1-pre-stop[1055]: deleting address 192.168.1.1/24... done964machine # [ 22.155049] network-addresses-eth1-pre-stop[1055]: deleting address 2001:db8:1::1/64... done965machine # [ 22.162313] systemd[1]: network-addresses-eth1.service: Deactivated successfully.966machine # [ 22.165386] systemd[1]: Stopped Address configuration of eth1.967machine # [ 22.170274] systemd[1]: Starting Address configuration of eth1...968machine # [ 22.216513] network-addresses-eth1-start[1060]: adding address 192.168.1.2/24... done969machine # [ 22.223928] network-addresses-eth1-start[1060]: adding address 2001:db8:1::2/64... done970machine # [ 22.233763] systemd[1]: Finished Address configuration of eth1.971machine # [ 22.239696] systemd[1]: Reached target Local File Systems.972machine # [ 22.244777] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore973machine # [ 22.252749] systemd[1]: Starting Create SUID/SGID Wrappers...974machine # [ 22.253819] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.975machine # [ 22.255137] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67976machine # [ 22.265337] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore977machine # [ 22.267201] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os978machine # [ 22.273400] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os979machine # [ 22.274895] systemd[1]: Reached target Remote File Systems.980machine # [ 22.278119] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os981machine # [ 22.281068] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki982machine # [ 22.455939] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.983machine # [ 22.460318] systemd[1]: Finished Create SUID/SGID Wrappers.984machine # [ 22.463660] systemd[1]: Starting linger-users.service...985machine # [ 22.494464] linger-users-start[1132]: id: ‘usertest’: no such user986machine # [ 22.496573] linger-users-start[1130]: Removing linger for missing user usertest987machine # [ 22.503279] systemd[1]: linger-users.service: Deactivated successfully.988machine # [ 22.506243] systemd[1]: Finished linger-users.service.989machine # [ 22.761922] nixos[971]: finished switching to system configuration /nix/store/lhyz1cqawdrp86fih2gasi7wyafp6sqs-nixos-system-other-test990machine: (finished: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/lhyz1cqawdrp86fih2gasi7wyafp6sqs-nixos-system-other-test/bin/switch-to-configuration test, in 2.05 seconds)991subtest: services992machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1993machine # [ 22.982818] nixos[1138]: switching to system configuration /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test994machine # [ 22.985425] systemd[1]: Stopped target Local File Systems.995machine # [ 22.988517] systemd[1]: Stopped target Remote File Systems.996machine # [ 23.286524] systemd[1]: Reload requested from client PID 1138 ('.switch-to-conf') (unit backdoor.service)...997machine # [ 23.288723] systemd[1]: Reloading...998machine # [ 23.618684] systemd[1]: Reloading finished in 328 ms.999machine # [ 23.704609] systemd[550]: Reexecution requested from client PID 1207 ('switch-to-confi')...1000machine # [ 23.708977] systemd[550]: Reexecuting.1001machine # [ 23.767950] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1002machine # [ 23.888337] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1003machine # [ 23.895841] systemd[550]: Reload requested from client PID 1207 ('switch-to-confi')...1004machine # [ 23.899898] systemd[550]: Reloading...1005machine # [ 24.010300] systemd[550]: Reloading finished in 111 ms.1006machine # [ 24.024197] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1007machine # [ 24.034907] systemd[550]: Stopped Run user-specific NixOS activation.1008machine # [ 24.037393] systemd[550]: Stopping Run user-specific NixOS activation...1009machine # [ 24.039638] systemd[550]: Starting Run user-specific NixOS activation...1010machine # [ 24.072329] systemd[550]: Finished Run user-specific NixOS activation.1011machine # [ 24.076669] systemd[1]: Stopped target Reactivate sysinit units.1012machine # [ 24.077699] systemd[1]: Stopping Reactivate sysinit units...1013machine # [ 24.081867] systemd[1]: Reached target Reactivate sysinit units.1014machine # [ 24.083950] systemd[1]: Reloading D-Bus System Message Bus...1015machine # [ 24.085444] dbus-broker-launch[429]: Caught SIGHUP, trigger reload.1016machine # [ 24.088837] dbus-broker-launch[429]: Looking up NSS user entry for 'systemd-timesync'...1017machine # [ 24.091064] dbus-broker-launch[429]: NSS returned no entry for 'systemd-timesync'1018machine # [ 24.092371] dbus-broker-launch[429]: Invalid user-name in /nix/store/r21qlc763yx2sp1lnrvn2wkyx9l5bgx1-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1019machine # [ 24.109907] systemd[1]: Reloaded D-Bus System Message Bus.1020machine # [ 24.115575] systemd[1]: Stopping Address configuration of eth1...1021machine # [ 24.147917] network-addresses-eth1-pre-stop[1219]: deleting address 192.168.1.2/24... done1022machine # [ 24.154350] network-addresses-eth1-pre-stop[1219]: deleting address 2001:db8:1::2/64... done1023machine # [ 24.161102] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1024machine # [ 24.163466] systemd[1]: Stopped Address configuration of eth1.1025machine # [ 24.167935] systemd[1]: Starting Address configuration of eth1...1026machine # [ 24.210205] network-addresses-eth1-start[1224]: adding address 192.168.1.1/24... done1027machine # [ 24.217659] network-addresses-eth1-start[1224]: adding address 2001:db8:1::1/64... done1028machine # [ 24.227252] systemd[1]: Finished Address configuration of eth1.1029machine # [ 24.230422] systemd[1]: Reached target Local File Systems.1030machine # [ 24.233560] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1031machine # [ 24.238350] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1032machine # [ 24.239772] systemd[1]: Reached target Remote File Systems.1033machine # [ 24.246912] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1034machine # [ 24.254309] systemd[1]: Starting Create SUID/SGID Wrappers...1035machine # [ 24.255252] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1036machine # [ 24.260657] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671037machine # [ 24.263000] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1038machine # [ 24.266637] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1039machine # [ 24.267988] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1040machine # [ 24.464311] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1041machine # [ 24.466269] systemd[1]: Finished Create SUID/SGID Wrappers.1042machine # [ 24.472255] systemd[1]: Starting linger-users.service...1043machine # [ 24.507588] systemd[1]: linger-users.service: Deactivated successfully.1044machine # [ 24.509534] systemd[1]: Finished linger-users.service.1045machine # [ 24.766000] nixos[1138]: finished switching to system configuration /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test1046machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.00 seconds)1047machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/bin/switch-to-configuration test 2>&11048machine # [ 24.992134] nixos[1294]: switching to system configuration /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test1049machine # [ 24.995354] systemd[1]: Stopped target Local File Systems.1050machine # [ 24.998762] systemd[1]: Stopped target Remote File Systems.1051machine # [ 25.296297] systemd[1]: Reload requested from client PID 1294 ('.switch-to-conf') (unit backdoor.service)...1052machine # [ 25.298490] systemd[1]: Reloading...1053machine # [ 25.622376] systemd[1]: Reloading finished in 322 ms.1054machine # [ 25.712433] systemd[550]: Reexecution requested from client PID 1363 ('switch-to-confi')...1055machine # [ 25.715743] systemd[550]: Reexecuting.1056machine # [ 25.775904] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1057machine # [ 25.889000] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1058machine # [ 25.896279] systemd[550]: Reload requested from client PID 1363 ('switch-to-confi')...1059machine # [ 25.900728] systemd[550]: Reloading...1060machine # [ 26.005565] systemd[550]: Reloading finished in 106 ms.1061machine # [ 26.020190] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1062machine # [ 26.031498] systemd[550]: Stopped Run user-specific NixOS activation.1063machine # [ 26.033958] systemd[550]: Stopping Run user-specific NixOS activation...1064machine # [ 26.036431] systemd[550]: Starting Run user-specific NixOS activation...1065machine # [ 26.067981] systemd[550]: Finished Run user-specific NixOS activation.1066machine # [ 26.072794] systemd[1]: Stopped target Reactivate sysinit units.1067machine # [ 26.073785] systemd[1]: Stopping Reactivate sysinit units...1068machine # [ 26.074732] systemd[1]: Reached target Reactivate sysinit units.1069machine # [ 26.078090] systemd[1]: Reached target Remote File Systems.1070machine # [ 26.082019] systemd[1]: Starting linger-users.service...1071machine # [ 26.086319] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1072machine # [ 26.087755] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1073machine # [ 26.094577] systemd[1]: Reached target Local File Systems.1074machine # [ 26.095401] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1075machine # [ 26.104543] systemd[1]: Starting Create SUID/SGID Wrappers...1076machine # [ 26.105457] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1077machine # [ 26.106853] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671078machine # [ 26.119629] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1079machine # [ 26.122536] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1080machine # [ 26.123938] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1081machine # [ 26.179969] systemd[1]: linger-users.service: Deactivated successfully.1082machine # [ 26.182890] systemd[1]: Finished linger-users.service.1083machine # [ 26.311713] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1084machine # [ 26.314835] systemd[1]: Finished Create SUID/SGID Wrappers.1085machine # [ 26.570816] nixos[1294]: finished switching to system configuration /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test1086machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.80 seconds)1087machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11088machine # [ 26.789651] nixos[1434]: switching to system configuration /nix/store/yqy05d2nkby18liz87hjgdfqmzikdmxw-nixos-system-machine-test1089machine # [ 26.792623] systemd[1]: Stopped target Remote File Systems.1090machine # [ 26.794328] systemd[1]: Stopped target Local File Systems.1091machine # [ 27.077051] systemd[1]: Reload requested from client PID 1434 ('.switch-to-conf') (unit backdoor.service)...1092machine # [ 27.079068] systemd[1]: Reloading...1093machine # [ 27.398543] systemd[1]: Reloading finished in 318 ms.1094machine # [ 27.484277] systemd[550]: Reexecution requested from client PID 1503 ('switch-to-confi')...1095machine # [ 27.488551] systemd[550]: Reexecuting.1096machine # [ 27.543365] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1097machine # [ 27.690235] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1098machine # [ 27.696858] systemd[550]: Reload requested from client PID 1503 ('switch-to-confi')...1099machine # [ 27.699320] systemd[550]: Reloading...1100machine # [ 27.805731] systemd[550]: Reloading finished in 105 ms.1101machine # [ 27.820183] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1102machine # [ 27.831647] systemd[550]: Stopped Run user-specific NixOS activation.1103machine # [ 27.834174] systemd[550]: Stopping Run user-specific NixOS activation...1104machine # [ 27.836325] systemd[550]: Starting Run user-specific NixOS activation...1105machine # [ 27.868086] systemd[550]: Finished Run user-specific NixOS activation.1106machine # [ 27.871958] systemd[1]: Stopped target Reactivate sysinit units.1107machine # [ 27.875278] systemd[1]: Stopping Reactivate sysinit units...1108machine # [ 27.877063] systemd[1]: Reached target Reactivate sysinit units.1109machine # [ 27.877965] systemd[1]: Reached target Local File Systems.1110machine # [ 27.885300] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1111machine # [ 27.894521] systemd[1]: Starting Create SUID/SGID Wrappers...1112machine # [ 27.895563] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1113machine # [ 27.902540] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671114machine # [ 27.907146] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1115machine # [ 27.908962] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1116machine # [ 27.910268] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1117machine # [ 27.911487] systemd[1]: Reached target Remote File Systems.1118machine # [ 27.913002] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1119machine # [ 27.914428] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1120machine # [ 28.065228] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1121machine # [ 28.070354] systemd[1]: Finished Create SUID/SGID Wrappers.1122machine # [ 28.073798] systemd[1]: Starting linger-users.service...1123machine # [ 28.077465] systemd[1]: Starting test.service...1124machine # [ 28.116308] systemd[1]: Finished test.service.1125machine # [ 28.134818] systemd[1]: linger-users.service: Deactivated successfully.1126machine # [ 28.136868] systemd[1]: Finished linger-users.service.1127machine # [ 28.394167] nixos[1434]: finished switching to system configuration /nix/store/yqy05d2nkby18liz87hjgdfqmzikdmxw-nixos-system-machine-test1128machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.82 seconds)1129machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11130machine # [ 28.598387] nixos[1577]: switching to system configuration /nix/store/yqy05d2nkby18liz87hjgdfqmzikdmxw-nixos-system-machine-test1131machine # [ 28.600968] systemd[1]: Stopped target Local File Systems.1132machine # [ 28.603759] systemd[1]: Stopped target Remote File Systems.1133machine # [ 28.868003] systemd[1]: Reload requested from client PID 1577 ('.switch-to-conf') (unit backdoor.service)...1134machine # [ 28.870076] systemd[1]: Reloading...1135machine # [ 29.184410] systemd[1]: Reloading finished in 312 ms.1136machine # [ 29.268068] systemd[550]: Reexecution requested from client PID 1646 ('switch-to-confi')...1137machine # [ 29.269512] systemd[550]: Reexecuting.1138machine # [ 29.327659] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1139machine # [ 29.439411] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1140machine # [ 29.446061] systemd[550]: Reload requested from client PID 1646 ('switch-to-confi')...1141machine # [ 29.449703] systemd[550]: Reloading...1142machine # [ 29.555165] systemd[550]: Reloading finished in 106 ms.1143machine # [ 29.572183] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1144machine # [ 29.581739] systemd[550]: Stopped Run user-specific NixOS activation.1145machine # [ 29.584124] systemd[550]: Stopping Run user-specific NixOS activation...1146machine # [ 29.586355] systemd[550]: Starting Run user-specific NixOS activation...1147machine # [ 29.614763] systemd[550]: Finished Run user-specific NixOS activation.1148machine # [ 29.618726] systemd[1]: Stopped target Reactivate sysinit units.1149machine # [ 29.621691] systemd[1]: Stopping Reactivate sysinit units...1150machine # [ 29.622650] systemd[1]: Reached target Reactivate sysinit units.1151machine # [ 29.623509] systemd[1]: Reached target Remote File Systems.1152machine # [ 29.629371] systemd[1]: Starting linger-users.service...1153machine # [ 29.632890] systemd[1]: Reached target Local File Systems.1154machine # [ 29.640074] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1155machine # [ 29.646776] systemd[1]: Starting Create SUID/SGID Wrappers...1156machine # [ 29.647680] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1157machine # [ 29.655244] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671158machine # [ 29.663447] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1159machine # [ 29.668217] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1160machine # [ 29.672920] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1161machine # [ 29.679934] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1162machine # [ 29.684228] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1163machine # [ 29.718794] systemd[1]: linger-users.service: Deactivated successfully.1164machine # [ 29.723552] systemd[1]: Finished linger-users.service.1165machine # [ 29.849909] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1166machine # [ 29.853966] systemd[1]: Finished Create SUID/SGID Wrappers.1167machine # [ 30.107787] nixos[1577]: finished switching to system configuration /nix/store/yqy05d2nkby18liz87hjgdfqmzikdmxw-nixos-system-machine-test1168machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.71 seconds)1169machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&11170machine # [ 30.325575] nixos[1717]: switching to system configuration /nix/store/8j38pkacfxg7wcdcxrklsbw74ayshkv7-nixos-system-machine-test1171machine # [ 30.328393] systemd[1]: Stopped target Remote File Systems.1172machine # [ 30.330832] systemd[1]: Stopped target Local File Systems.1173machine # [ 30.604941] systemd[1]: Reload requested from client PID 1717 ('.switch-to-conf') (unit backdoor.service)...1174machine # [ 30.606909] systemd[1]: Reloading...1175machine # [ 31.017109] systemd[1]: Reloading finished in 408 ms.1176machine # [ 31.134419] systemd[550]: Reexecution requested from client PID 1786 ('switch-to-confi')...1177machine # [ 31.135864] systemd[550]: Reexecuting.1178machine # [ 31.182973] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1179machine # [ 31.290360] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1180machine # [ 31.297767] systemd[550]: Reload requested from client PID 1786 ('switch-to-confi')...1181machine # [ 31.301281] systemd[550]: Reloading...1182machine # [ 31.403986] systemd[550]: Reloading finished in 103 ms.1183machine # [ 31.420174] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1184machine # [ 31.429574] systemd[550]: Stopped Run user-specific NixOS activation.1185machine # [ 31.431912] systemd[550]: Stopping Run user-specific NixOS activation...1186machine # [ 31.434194] systemd[550]: Starting Run user-specific NixOS activation...1187machine # [ 31.467468] systemd[550]: Finished Run user-specific NixOS activation.1188machine # [ 31.471779] systemd[1]: Stopped target Reactivate sysinit units.1189machine # [ 31.477353] systemd[1]: Stopping Reactivate sysinit units...1190machine # [ 31.478271] systemd[1]: Reached target Reactivate sysinit units.1191machine # [ 31.479155] systemd[1]: Reached target Local File Systems.1192machine # [ 31.479946] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1193machine # [ 31.484790] systemd[1]: Starting Create SUID/SGID Wrappers...1194machine # [ 31.485727] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1195machine # [ 31.487050] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671196machine # [ 31.495893] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1197machine # [ 31.501964] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1198machine # [ 31.503320] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1199machine # [ 31.510993] systemd[1]: Reached target Remote File Systems.1200machine # [ 31.512946] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1201machine # [ 31.514971] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1202machine # [ 31.660399] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1203machine # [ 31.664466] systemd[1]: Finished Create SUID/SGID Wrappers.1204machine # [ 31.667526] systemd[1]: Starting linger-users.service...1205machine # [ 31.707696] systemd[1]: linger-users.service: Deactivated successfully.1206machine # [ 31.709519] systemd[1]: Finished linger-users.service.1207machine # [ 31.965755] nixos[1717]: finished switching to system configuration /nix/store/8j38pkacfxg7wcdcxrklsbw74ayshkv7-nixos-system-machine-test1208machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 1.86 seconds)1209machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11210machine # [ 32.196594] nixos[1858]: switching to system configuration /nix/store/v9dgrzy7y8kapjwvi1fciij8nhxi3bky-nixos-system-machine-test1211machine # [ 32.199172] systemd[1]: Stopped target Remote File Systems.1212machine # [ 32.202927] systemd[1]: Stopped target Local File Systems.1213machine # [ 32.203787] systemd[1]: test.service: Deactivated successfully.1214machine # [ 32.205293] systemd[1]: Stopped Test unit.1215machine # [ 32.489671] systemd[1]: Reload requested from client PID 1858 ('.switch-to-conf') (unit backdoor.service)...1216machine # [ 32.491707] systemd[1]: Reloading...1217machine # [ 32.809645] systemd[1]: Reloading finished in 316 ms.1218machine # [ 32.892100] systemd[550]: Reexecution requested from client PID 1927 ('switch-to-confi')...1219machine # [ 32.896355] systemd[550]: Reexecuting.1220machine # [ 32.951673] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1221machine # [ 33.062238] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1222machine # [ 33.068520] systemd[550]: Reload requested from client PID 1927 ('switch-to-confi')...1223machine # [ 33.070910] systemd[550]: Reloading...1224machine # [ 33.174455] systemd[550]: Reloading finished in 102 ms.1225machine # [ 33.188171] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1226machine # [ 33.197705] systemd[550]: Stopped Run user-specific NixOS activation.1227machine # [ 33.200050] systemd[550]: Stopping Run user-specific NixOS activation...1228machine # [ 33.202266] systemd[550]: Starting Run user-specific NixOS activation...1229machine # [ 33.234428] systemd[550]: Finished Run user-specific NixOS activation.1230machine # [ 33.238277] systemd[1]: Stopped target Reactivate sysinit units.1231machine # [ 33.241043] systemd[1]: Stopping Reactivate sysinit units...1232machine # [ 33.246425] systemd[1]: Reached target Reactivate sysinit units.1233machine # [ 33.247348] systemd[1]: Reached target Remote File Systems.1234machine # [ 33.250748] systemd[1]: Starting linger-users.service...1235machine # [ 33.252920] systemd[1]: Starting test.service...1236machine # [ 33.257862] systemd[1]: Reached target Local File Systems.1237machine # [ 33.269243] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1238machine # [ 33.270885] systemd[1]: Starting Create SUID/SGID Wrappers...1239machine # [ 33.271723] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1240machine # [ 33.285258] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671241machine # [ 33.287480] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1242machine # [ 33.297862] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1243machine # [ 33.299358] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1244machine # [ 33.311033] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1245machine # [ 33.317867] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1246machine # [ 33.331132] systemd[1]: Finished test.service.1247machine # [ 33.359950] systemd[1]: linger-users.service: Deactivated successfully.1248machine # [ 33.363538] systemd[1]: Finished linger-users.service.1249machine # [ 33.485511] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1250machine # [ 33.489241] systemd[1]: Finished Create SUID/SGID Wrappers.1251machine # [ 33.743239] nixos[1858]: finished switching to system configuration /nix/store/v9dgrzy7y8kapjwvi1fciij8nhxi3bky-nixos-system-machine-test1252machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.77 seconds)1253machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&11254machine # [ 33.963091] nixos[2000]: switching to system configuration /nix/store/cbsymq7lb09snni660gz9vpbjxjplvzp-nixos-system-machine-test1255machine # [ 33.966024] systemd[1]: Stopped target Local File Systems.1256machine # [ 33.968339] systemd[1]: Stopped target Remote File Systems.1257machine # [ 34.243714] systemd[1]: Reload requested from client PID 2000 ('.switch-to-conf') (unit backdoor.service)...1258machine # [ 34.245850] systemd[1]: Reloading...1259machine # [ 34.570651] systemd[1]: Reloading finished in 323 ms.1260machine # [ 34.690874] systemd[550]: Reexecution requested from client PID 2069 ('switch-to-confi')...1261machine # [ 34.694954] systemd[550]: Reexecuting.1262machine # [ 34.751216] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1263machine # [ 34.863361] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1264machine # [ 34.870505] systemd[550]: Reload requested from client PID 2069 ('switch-to-confi')...1265machine # [ 34.871826] systemd[550]: Reloading...1266machine # [ 34.975156] systemd[550]: Reloading finished in 102 ms.1267machine # [ 34.989551] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1268machine # [ 34.997519] systemd[550]: Stopped Run user-specific NixOS activation.1269machine # [ 34.999792] systemd[550]: Stopping Run user-specific NixOS activation...1270machine # [ 35.001938] systemd[550]: Starting Run user-specific NixOS activation...1271machine # [ 35.030592] systemd[550]: Finished Run user-specific NixOS activation.1272machine # [ 35.034309] systemd[1]: Stopped target Reactivate sysinit units.1273machine # [ 35.038778] systemd[1]: Stopping Reactivate sysinit units...1274machine # [ 35.039671] systemd[1]: Reached target Reactivate sysinit units.1275machine # [ 35.040829] systemd[1]: test.service: Deactivated successfully.1276machine # [ 35.041656] systemd[1]: Stopped test.service.1277machine # [ 35.042375] systemd[1]: Stopping test.service...1278machine # [ 35.044000] systemd[1]: Starting test.service...1279machine # [ 35.067976] systemd[1]: Finished test.service.1280machine # [ 35.073697] systemd[1]: Reached target Local File Systems.1281machine # [ 35.078182] systemd[1]: Reached target Remote File Systems.1282machine # [ 35.081189] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1283machine # [ 35.084336] systemd[1]: Starting Create SUID/SGID Wrappers...1284machine # [ 35.085199] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1285machine # [ 35.086518] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671286machine # [ 35.097289] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1287machine # [ 35.098979] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1288machine # [ 35.103045] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1289machine # [ 35.104423] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1290machine # [ 35.105701] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1291machine # [ 35.252747] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1292machine # [ 35.256822] systemd[1]: Finished Create SUID/SGID Wrappers.1293machine # [ 35.258871] systemd[1]: Starting linger-users.service...1294machine # [ 35.299207] systemd[1]: linger-users.service: Deactivated successfully.1295machine # [ 35.301940] systemd[1]: Finished linger-users.service.1296machine # [ 35.557286] nixos[2000]: finished switching to system configuration /nix/store/cbsymq7lb09snni660gz9vpbjxjplvzp-nixos-system-machine-test1297machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.81 seconds)1298machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&11299machine # [ 35.771862] nixos[2143]: switching to system configuration /nix/store/x41089kz91w512ybfcpnp4nny3bkf1xl-nixos-system-machine-test1300machine # [ 35.774480] systemd[1]: Stopped target Remote File Systems.1301machine # [ 35.776864] systemd[1]: Stopped target Local File Systems.1302machine # [ 36.050664] systemd[1]: Reload requested from client PID 2143 ('.switch-to-conf') (unit backdoor.service)...1303machine # [ 36.052751] systemd[1]: Reloading...1304machine # [ 36.365571] systemd[1]: Reloading finished in 311 ms.1305machine # [ 36.448414] systemd[550]: Reexecution requested from client PID 2212 ('switch-to-confi')...1306machine # [ 36.450248] systemd[550]: Reexecuting.1307machine # [ 36.511347] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1308machine # [ 36.624876] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1309machine # [ 36.631782] systemd[550]: Reload requested from client PID 2212 ('switch-to-confi')...1310machine # [ 36.634205] systemd[550]: Reloading...1311machine # [ 36.737000] systemd[550]: Reloading finished in 101 ms.1312machine # [ 36.752181] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1313machine # [ 36.761862] systemd[550]: Stopped Run user-specific NixOS activation.1314machine # [ 36.764522] systemd[550]: Stopping Run user-specific NixOS activation...1315machine # [ 36.766480] systemd[550]: Starting Run user-specific NixOS activation...1316machine # [ 36.800536] systemd[550]: Finished Run user-specific NixOS activation.1317machine # [ 36.804111] systemd[1]: Stopped target Reactivate sysinit units.1318machine # [ 36.808408] systemd[1]: Stopping Reactivate sysinit units...1319machine # [ 36.809335] systemd[1]: Reached target Reactivate sysinit units.1320machine # [ 36.811119] systemd[1]: Reloading test.service...1321machine # [ 36.836860] systemd[1]: Reloaded test.service.1322machine # [ 36.841119] systemd[1]: Reached target Remote File Systems.1323machine # [ 36.845303] systemd[1]: Starting linger-users.service...1324machine # [ 36.857783] systemd[1]: Reached target Local File Systems.1325machine # [ 36.859582] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1326machine # [ 36.866324] systemd[1]: Starting Create SUID/SGID Wrappers...1327machine # [ 36.867239] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1328machine # [ 36.876903] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671329machine # [ 36.879250] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1330machine # [ 36.888249] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1331machine # [ 36.889608] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1332machine # [ 36.890898] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1333machine # [ 36.900598] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1334machine # [ 36.937124] systemd[1]: linger-users.service: Deactivated successfully.1335machine # [ 36.940102] systemd[1]: Finished linger-users.service.1336machine # [ 37.068638] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1337machine # [ 37.072411] systemd[1]: Finished Create SUID/SGID Wrappers.1338machine # [ 37.327606] nixos[2143]: finished switching to system configuration /nix/store/x41089kz91w512ybfcpnp4nny3bkf1xl-nixos-system-machine-test1339machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 1.77 seconds)1340machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&11341machine # [ 37.547212] nixos[2285]: switching to system configuration /nix/store/3gx66a8k8b55mc1w5735vb0aiykd2nqw-nixos-system-machine-test1342machine # [ 37.549753] systemd[1]: Stopped target Remote File Systems.1343machine # [ 37.552923] systemd[1]: Stopped target Local File Systems.1344machine # [ 37.884332] systemd[1]: Reload requested from client PID 2285 ('.switch-to-conf') (unit backdoor.service)...1345machine # [ 37.886396] systemd[1]: Reloading...1346machine # [ 38.200467] systemd[1]: Reloading finished in 312 ms.1347machine # [ 38.282322] systemd[550]: Reexecution requested from client PID 2355 ('switch-to-confi')...1348machine # [ 38.286075] systemd[550]: Reexecuting.1349machine # [ 38.343288] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1350machine # [ 38.451891] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1351machine # [ 38.459467] systemd[550]: Reload requested from client PID 2355 ('switch-to-confi')...1352machine # [ 38.462524] systemd[550]: Reloading...1353machine # [ 38.565078] systemd[550]: Reloading finished in 103 ms.1354machine # [ 38.580176] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1355machine # [ 38.590205] systemd[550]: Stopped Run user-specific NixOS activation.1356machine # [ 38.592475] systemd[550]: Stopping Run user-specific NixOS activation...1357machine # [ 38.594600] systemd[550]: Starting Run user-specific NixOS activation...1358machine # [ 38.627360] systemd[550]: Finished Run user-specific NixOS activation.1359machine # [ 38.630996] systemd[1]: Stopped target Reactivate sysinit units.1360machine # [ 38.632992] systemd[1]: Stopping Reactivate sysinit units...1361machine # [ 38.633885] systemd[1]: Reached target Reactivate sysinit units.1362machine # [ 38.639720] systemd[1]: Reached target Remote File Systems.1363machine # [ 38.642758] systemd[1]: Starting linger-users.service...1364machine # [ 38.654772] systemd[1]: Reached target Local File Systems.1365machine # [ 38.655735] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1366machine # [ 38.662117] systemd[1]: Starting Create SUID/SGID Wrappers...1367machine # [ 38.663008] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1368machine # [ 38.675465] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671369machine # [ 38.679715] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1370machine # [ 38.687424] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1371machine # [ 38.691111] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1372machine # [ 38.694256] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1373machine # [ 38.700372] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1374machine # [ 38.731863] systemd[1]: linger-users.service: Deactivated successfully.1375machine # [ 38.736604] systemd[1]: Finished linger-users.service.1376machine # [ 38.863411] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1377machine # [ 38.866532] systemd[1]: Finished Create SUID/SGID Wrappers.1378machine # [ 39.121754] nixos[2285]: finished switching to system configuration /nix/store/3gx66a8k8b55mc1w5735vb0aiykd2nqw-nixos-system-machine-test1379machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.79 seconds)1380machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&11381machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.29 seconds)1382machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/bin/switch-to-configuration test 2>&11383machine # [ 39.588472] nixos[2436]: switching to system configuration /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test1384machine # [ 39.591312] systemd[1]: test.service: Deactivated successfully.1385machine # [ 39.595376] systemd[1]: Stopped test.service.1386machine # [ 39.596323] systemd[1]: Stopped target Remote File Systems.1387machine # [ 39.597148] systemd[1]: Stopped target Local File Systems.1388machine # [ 39.853601] systemd[1]: Reload requested from client PID 2436 ('.switch-to-conf') (unit backdoor.service)...1389machine # [ 39.855599] systemd[1]: Reloading...1390machine # [ 40.164296] systemd[1]: Reloading finished in 307 ms.1391machine # [ 40.250518] systemd[550]: Reexecution requested from client PID 2504 ('switch-to-confi')...1392machine # [ 40.251911] systemd[550]: Reexecuting.1393machine # [ 40.315432] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1394machine # [ 40.427963] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1395machine # [ 40.434721] systemd[550]: Reload requested from client PID 2504 ('switch-to-confi')...1396machine # [ 40.438248] systemd[550]: Reloading...1397machine # [ 40.540499] systemd[550]: Reloading finished in 103 ms.1398machine # [ 40.556161] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1399machine # [ 40.565716] systemd[550]: Stopped Run user-specific NixOS activation.1400machine # [ 40.567940] systemd[550]: Stopping Run user-specific NixOS activation...1401machine # [ 40.570127] systemd[550]: Starting Run user-specific NixOS activation...1402machine # [ 40.603502] systemd[550]: Finished Run user-specific NixOS activation.1403machine # [ 40.607807] systemd[1]: Stopped target Reactivate sysinit units.1404machine # [ 40.609293] systemd[1]: Stopping Reactivate sysinit units...1405machine # [ 40.610230] systemd[1]: Reached target Reactivate sysinit units.1406machine # [ 40.613613] systemd[1]: Reached target Local File Systems.1407machine # [ 40.617791] systemd[1]: Reached target Remote File Systems.1408machine # [ 40.622075] systemd[1]: Starting linger-users.service...1409machine # [ 40.631682] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1410machine # [ 40.641300] systemd[1]: Starting Create SUID/SGID Wrappers...1411machine # [ 40.642294] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1412machine # [ 40.643533] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671413machine # [ 40.650380] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1414machine # [ 40.657675] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1415machine # [ 40.659227] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1416machine # [ 40.667042] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1417machine # [ 40.672307] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1418machine # [ 40.707869] systemd[1]: linger-users.service: Deactivated successfully.1419machine # [ 40.709877] systemd[1]: Finished linger-users.service.1420machine # [ 40.835761] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1421machine # [ 40.837800] systemd[1]: Finished Create SUID/SGID Wrappers.1422machine # [ 41.093854] nixos[2436]: finished switching to system configuration /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test1423machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.68 seconds)1424machine: must succeed: /nix/store/dy887fbf4wsw1bvb2j3csj73qrs59ryd-separate-activation-script/bin/switch-to-configuration test 2>&11425machine # [ 41.295178] nixos[2577]: switching to system configuration /nix/store/wlib51fxw0c635lglsya69rp1fcwdzh5-nixos-system-machine-test1426machine # [ 41.300279] systemd[1]: Stopped target Local File Systems.1427machine # [ 41.301160] systemd[1]: Stopped target Remote File Systems.1428machine # [ 41.570531] systemd[1]: Reload requested from client PID 2577 ('.switch-to-conf') (unit backdoor.service)...1429machine # [ 41.572705] systemd[1]: Reloading...1430machine # [ 41.870213] systemd[1]: Reloading finished in 296 ms.1431machine # [ 41.961730] systemd[550]: Stopped Run user-specific NixOS activation.1432machine # [ 41.965656] systemd[550]: Reexecution requested from client PID 2645 ('switch-to-confi')...1433machine # [ 41.967144] systemd[550]: Reexecuting.1434machine # [ 42.027259] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1435machine # [ 42.139622] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1436machine # [ 42.146290] systemd[550]: Reload requested from client PID 2645 ('switch-to-confi')...1437machine # [ 42.148551] systemd[550]: Reloading...1438machine # [ 42.249400] systemd[550]: Reloading finished in 99 ms.1439machine # [ 42.264159] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1440machine # [ 42.275749] systemd[1]: Stopped target Reactivate sysinit units.1441machine # [ 42.281107] systemd[1]: Stopping Reactivate sysinit units...1442machine # [ 42.282071] systemd[1]: Reached target Reactivate sysinit units.1443machine # [ 42.282925] systemd[1]: Reached target Local File Systems.1444machine # [ 42.283746] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1445machine # [ 42.287116] systemd[1]: Starting Create SUID/SGID Wrappers...1446machine # [ 42.292476] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1447machine # [ 42.293836] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671448machine # [ 42.301613] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1449machine # [ 42.303307] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1450machine # [ 42.313224] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1451machine # [ 42.314637] systemd[1]: Reached target Remote File Systems.1452machine # [ 42.315978] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1453machine # [ 42.317467] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1454machine # [ 42.460467] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1455machine # [ 42.464674] systemd[1]: Finished Create SUID/SGID Wrappers.1456machine # [ 42.468371] systemd[1]: Starting linger-users.service...1457machine # [ 42.470889] systemd[1]: Starting test.service...1458machine # [ 42.511095] systemd[1]: Finished test.service.1459machine # [ 42.527858] systemd[1]: linger-users.service: Deactivated successfully.1460machine # [ 42.530606] systemd[1]: Finished linger-users.service.1461machine # [ 42.787434] nixos[2577]: finished switching to system configuration /nix/store/wlib51fxw0c635lglsya69rp1fcwdzh5-nixos-system-machine-test1462machine: (finished: must succeed: /nix/store/dy887fbf4wsw1bvb2j3csj73qrs59ryd-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.69 seconds)1463machine: must succeed: ! test -e /run/current-system/activate1464machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.02 seconds)1465machine: must succeed: ! test -e /run/current-system/dry-activate1466machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.02 seconds)1467machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration1468machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.02 seconds)1469machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&11470machine # [ 43.037302] nixos[2725]: switching to system configuration /nix/store/k326krzhs9sf0skh117fzgbxfgyvp6dm-nixos-system-machine-test1471machine # [ 43.040349] systemd[1]: Stopped target Remote File Systems.1472machine # [ 43.042106] systemd[1]: Stopped target Local File Systems.1473machine # [ 43.044822] systemd[1]: test.service: Deactivated successfully.1474machine # [ 43.045757] systemd[1]: Stopped test.service.1475machine # [ 43.314164] systemd[1]: Reload requested from client PID 2725 ('.switch-to-conf') (unit backdoor.service)...1476machine # [ 43.316185] systemd[1]: Reloading...1477machine # [ 43.624678] systemd[1]: Reloading finished in 307 ms.1478machine # [ 43.706659] systemd[550]: Reexecution requested from client PID 2794 ('switch-to-confi')...1479machine # [ 43.708977] systemd[550]: Reexecuting.1480machine # [ 43.763679] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1481machine # [ 43.873094] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1482machine # [ 43.879665] systemd[550]: Reload requested from client PID 2794 ('switch-to-confi')...1483machine # [ 43.883817] systemd[550]: Reloading...1484machine # [ 43.985594] systemd[550]: Reloading finished in 103 ms.1485machine # [ 44.001636] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1486machine # [ 44.010772] systemd[550]: Starting Run user-specific NixOS activation...1487machine # [ 44.043238] systemd[550]: Finished Run user-specific NixOS activation.1488machine # [ 44.046260] systemd[550]: Stopped Run user-specific NixOS activation.1489machine # [ 44.050235] systemd[550]: Stopping Run user-specific NixOS activation...1490machine # [ 44.051301] systemd[550]: Starting Run user-specific NixOS activation...1491machine # [ 44.059173] systemd[1]: Stopped target Reactivate sysinit units.1492machine # [ 44.061233] systemd[1]: Stopping Reactivate sysinit units...1493machine # [ 44.062111] systemd[1]: Reached target Reactivate sysinit units.1494machine # [ 44.076830] systemd[1]: Started test.service.1495machine # [ 44.083160] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1496machine # [ 44.092626] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1497machine # [ 44.093984] systemd[1]: Reached target Local File Systems.1498machine # [ 44.094784] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1499machine # [ 44.113241] systemd[1]: Starting Create SUID/SGID Wrappers...1500machine # [ 44.114257] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1501machine # [ 44.115517] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671502machine # [ 44.139706] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1503machine # [ 44.146161] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1504machine # [ 44.149217] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1505machine # [ 44.150616] systemd[550]: Finished Run user-specific NixOS activation.1506machine # [ 44.151584] systemd[1]: Reached target Remote File Systems.1507machine # [ 44.157550] systemd[1]: test.service: Deactivated successfully.1508machine # [ 44.342352] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1509machine # [ 44.348946] systemd[1]: Finished Create SUID/SGID Wrappers.1510machine # [ 44.351631] systemd[1]: Starting linger-users.service...1511machine # [ 44.391448] systemd[1]: linger-users.service: Deactivated successfully.1512machine # [ 44.393327] systemd[1]: Finished linger-users.service.1513machine # [ 44.649897] nixos[2725]: finished switching to system configuration /nix/store/k326krzhs9sf0skh117fzgbxfgyvp6dm-nixos-system-machine-test1514machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.81 seconds)1515machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&11516machine # [ 44.863592] nixos[2871]: switching to system configuration /nix/store/m3cr7xjy4dsr61mfp6kvrnjxfsiv736a-nixos-system-machine-test1517machine # [ 44.866372] systemd[1]: Stopped target Remote File Systems.1518machine # [ 44.868992] systemd[1]: Stopped target Local File Systems.1519machine # [ 45.138874] systemd[1]: Reload requested from client PID 2871 ('.switch-to-conf') (unit backdoor.service)...1520machine # [ 45.141069] systemd[1]: Reloading...1521machine # [ 45.450533] systemd[1]: Reloading finished in 308 ms.1522machine # [ 45.536662] systemd[550]: Reexecution requested from client PID 2940 ('switch-to-confi')...1523machine # [ 45.541102] systemd[550]: Reexecuting.1524machine # [ 45.587029] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1525machine # [ 45.694187] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1526machine # [ 45.700715] systemd[550]: Reload requested from client PID 2940 ('switch-to-confi')...1527machine # [ 45.703031] systemd[550]: Reloading...1528machine # [ 45.807391] systemd[550]: Reloading finished in 103 ms.1529machine # [ 45.825548] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1530machine # [ 45.835654] systemd[550]: Stopped Run user-specific NixOS activation.1531machine # [ 45.837956] systemd[550]: Stopping Run user-specific NixOS activation...1532machine # [ 45.840083] systemd[550]: Starting Run user-specific NixOS activation...1533machine # [ 45.870476] systemd[550]: Finished Run user-specific NixOS activation.1534machine # [ 45.873958] systemd[1]: Stopped target Reactivate sysinit units.1535machine # [ 45.876677] systemd[1]: Stopping Reactivate sysinit units...1536machine # [ 45.877546] systemd[1]: Reached target Reactivate sysinit units.1537machine # [ 45.882313] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1538machine # [ 45.883669] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1539machine # [ 45.886662] systemd[1]: Reached target Remote File Systems.1540machine # [ 45.889291] systemd[1]: Reached target Local File Systems.1541machine # [ 45.893185] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1542machine # [ 45.899570] systemd[1]: Starting Create SUID/SGID Wrappers...1543machine # [ 45.902876] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1544machine # [ 45.908140] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671545machine # [ 45.910413] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1546machine # [ 45.912652] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1547machine # [ 45.914032] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1548machine # [ 46.060468] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1549machine # [ 46.063352] systemd[1]: Finished Create SUID/SGID Wrappers.1550machine # [ 46.068177] systemd[1]: Starting escaped\x2ddash.service...1551machine # [ 46.072333] systemd[1]: Starting linger-users.service...1552machine # [ 46.111806] systemd[1]: Finished escaped\x2ddash.service.1553machine # [ 46.129458] systemd[1]: linger-users.service: Deactivated successfully.1554machine # [ 46.132811] systemd[1]: Finished linger-users.service.1555machine # [ 46.388610] nixos[2871]: finished switching to system configuration /nix/store/m3cr7xjy4dsr61mfp6kvrnjxfsiv736a-nixos-system-machine-test1556machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 1.74 seconds)1557machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&11558machine # [ 46.603313] nixos[3013]: switching to system configuration /nix/store/645n01gjgmd0dd8v4xd5m4r8vlpb1zrp-nixos-system-machine-test1559machine # [ 46.606408] systemd[1]: Stopped target Remote File Systems.1560machine # [ 46.609728] systemd[1]: Stopped target Local File Systems.1561machine # [ 46.611246] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1562machine # [ 46.613254] systemd[1]: Stopped escaped\x2ddash.service.1563machine # [ 46.884741] systemd[1]: Reload requested from client PID 3013 ('.switch-to-conf') (unit backdoor.service)...1564machine # [ 46.886714] systemd[1]: Reloading...1565machine # [ 47.194611] systemd[1]: Reloading finished in 306 ms.1566machine # [ 47.279603] systemd[550]: Reexecution requested from client PID 3081 ('switch-to-confi')...1567machine # [ 47.281831] systemd[550]: Reexecuting.1568machine # [ 47.339319] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1569machine # [ 47.452840] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1570machine # [ 47.459461] systemd[550]: Reload requested from client PID 3081 ('switch-to-confi')...1571machine # [ 47.462797] systemd[550]: Reloading...1572machine # [ 47.566644] systemd[550]: Reloading finished in 104 ms.1573machine # [ 47.580162] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1574machine # [ 47.589495] systemd[550]: Stopped Run user-specific NixOS activation.1575machine # [ 47.591818] systemd[550]: Stopping Run user-specific NixOS activation...1576machine # [ 47.594115] systemd[550]: Starting Run user-specific NixOS activation...1577machine # [ 47.622776] systemd[550]: Finished Run user-specific NixOS activation.1578machine # [ 47.626745] systemd[1]: Stopped target Reactivate sysinit units.1579machine # [ 47.629786] systemd[1]: Stopping Reactivate sysinit units...1580machine # [ 47.630691] systemd[1]: Reached target Reactivate sysinit units.1581machine # [ 47.635264] systemd[1]: Starting escaped\x2ddash.service...1582machine # [ 47.640326] systemd[1]: Reached target Remote File Systems.1583machine # [ 47.644539] systemd[1]: Starting linger-users.service...1584machine # [ 47.658149] systemd[1]: Reached target Local File Systems.1585machine # [ 47.659055] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1586machine # [ 47.671059] systemd[1]: Starting Create SUID/SGID Wrappers...1587machine # [ 47.677204] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1588machine # [ 47.682728] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671589machine # [ 47.693718] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1590machine # [ 47.702476] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1591machine # [ 47.703907] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1592machine # [ 47.714714] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1593machine # [ 47.718255] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1594machine # [ 47.719597] systemd[1]: Finished escaped\x2ddash.service.1595machine # [ 47.755868] systemd[1]: linger-users.service: Deactivated successfully.1596machine # [ 47.758761] systemd[1]: Finished linger-users.service.1597machine # [ 47.886008] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1598machine # [ 47.888334] systemd[1]: Finished Create SUID/SGID Wrappers.1599machine # [ 48.144261] nixos[3013]: finished switching to system configuration /nix/store/645n01gjgmd0dd8v4xd5m4r8vlpb1zrp-nixos-system-machine-test1600machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 1.76 seconds)1601machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&11602machine # [ 48.411622] nixos[3155]: switching to system configuration /nix/store/rymlvfv1gkyjr7kl61h2yi7vmxvcc6d4-nixos-system-machine-test1603machine # [ 48.414239] systemd[1]: Stopped target Remote File Systems.1604machine # [ 48.416721] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1605machine # [ 48.417746] systemd[1]: Stopped escaped\x2ddash.service.1606machine # [ 48.419242] systemd[1]: Stopped target Local File Systems.1607machine # [ 48.701150] systemd[1]: Reload requested from client PID 3155 ('.switch-to-conf') (unit backdoor.service)...1608machine # [ 48.703091] systemd[1]: Reloading...1609machine # [ 49.015226] systemd[1]: Reloading finished in 310 ms.1610machine # [ 49.100310] systemd[550]: Reexecution requested from client PID 3224 ('switch-to-confi')...1611machine # [ 49.101714] systemd[550]: Reexecuting.1612machine # [ 49.159660] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1613machine # [ 49.269973] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1614machine # [ 49.276214] systemd[550]: Reload requested from client PID 3224 ('switch-to-confi')...1615machine # [ 49.278428] systemd[550]: Reloading...1616machine # [ 49.381639] systemd[550]: Reloading finished in 102 ms.1617machine # [ 49.396168] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1618machine # [ 49.405115] systemd[550]: Stopped Run user-specific NixOS activation.1619machine # [ 49.407309] systemd[550]: Stopping Run user-specific NixOS activation...1620machine # [ 49.409335] systemd[550]: Starting Run user-specific NixOS activation...1621machine # [ 49.438262] systemd[550]: Finished Run user-specific NixOS activation.1622machine # [ 49.442003] systemd[1]: Stopped target Reactivate sysinit units.1623machine # [ 49.443947] systemd[1]: Stopping Reactivate sysinit units...1624machine # [ 49.446063] systemd[1]: Reached target Reactivate sysinit units.1625machine # [ 49.449733] systemd[1]: Reached target Remote File Systems.1626machine # [ 49.452144] systemd[1]: Starting -.service...1627machine # [ 49.455358] systemd[1]: Starting linger-users.service...1628machine # [ 49.460998] systemd[1]: Reached target Local File Systems.1629machine # [ 49.470608] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1630machine # [ 49.481700] systemd[1]: Starting Create SUID/SGID Wrappers...1631machine # [ 49.482672] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1632machine # [ 49.483907] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671633machine # [ 49.489623] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1634machine # [ 49.491323] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1635machine # [ 49.501075] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1636machine # [ 49.502401] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1637machine # [ 49.515788] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1638machine # [ 49.528781] systemd[1]: Finished -.service.1639machine # [ 49.561670] systemd[1]: linger-users.service: Deactivated successfully.1640machine # [ 49.563890] systemd[1]: Finished linger-users.service.1641machine # [ 49.685736] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1642machine # [ 49.688572] systemd[1]: Finished Create SUID/SGID Wrappers.1643machine # [ 49.945308] nixos[3155]: finished switching to system configuration /nix/store/rymlvfv1gkyjr7kl61h2yi7vmxvcc6d4-nixos-system-machine-test1644machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.80 seconds)1645machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&11646machine # [ 50.167727] nixos[3297]: switching to system configuration /nix/store/jschm6qwrdp44ls1zny99c6mwacnbn8z-nixos-system-machine-test1647machine # [ 50.171082] systemd[1]: Stopped target Local File Systems.1648machine # [ 50.173256] systemd[1]: Stopped target Remote File Systems.1649machine # [ 50.443918] systemd[1]: Reload requested from client PID 3297 ('.switch-to-conf') (unit backdoor.service)...1650machine # [ 50.446295] systemd[1]: Reloading...1651machine # [ 50.761730] systemd[1]: Reloading finished in 313 ms.1652machine # [ 50.843812] systemd[550]: Reexecution requested from client PID 3366 ('switch-to-confi')...1653machine # [ 50.848250] systemd[550]: Reexecuting.1654machine # [ 50.903161] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1655machine # [ 51.014769] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1656machine # [ 51.021576] systemd[550]: Reload requested from client PID 3366 ('switch-to-confi')...1657machine # [ 51.023947] systemd[550]: Reloading...1658machine # [ 51.127435] systemd[550]: Reloading finished in 102 ms.1659machine # [ 51.144167] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1660machine # [ 51.154196] systemd[550]: Stopped Run user-specific NixOS activation.1661machine # [ 51.156588] systemd[550]: Stopping Run user-specific NixOS activation...1662machine # [ 51.158658] systemd[550]: Starting Run user-specific NixOS activation...1663machine # [ 51.190529] systemd[550]: Finished Run user-specific NixOS activation.1664machine # [ 51.194971] systemd[1]: Stopped target Reactivate sysinit units.1665machine # [ 51.199004] systemd[1]: Stopping Reactivate sysinit units...1666machine # [ 51.199895] systemd[1]: Reached target Reactivate sysinit units.1667machine # [ 51.202083] systemd[1]: Reloading -.service...1668machine # [ 51.224258] systemd[1]: Reloaded -.service.1669machine # [ 51.229038] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1670machine # [ 51.235030] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1671machine # [ 51.237586] systemd[1]: Reached target Remote File Systems.1672machine # [ 51.238439] systemd[1]: Starting linger-users.service...1673machine # [ 51.245729] systemd[1]: Reached target Local File Systems.1674machine # [ 51.251849] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1675machine # [ 51.261181] systemd[1]: Starting Create SUID/SGID Wrappers...1676machine # [ 51.262165] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1677machine # [ 51.263436] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671678machine # [ 51.273752] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1679machine # [ 51.278422] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1680machine # [ 51.279846] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1681machine # [ 51.325957] systemd[1]: linger-users.service: Deactivated successfully.1682machine # [ 51.330405] systemd[1]: Finished linger-users.service.1683machine # [ 51.457434] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1684machine # [ 51.460924] systemd[1]: Finished Create SUID/SGID Wrappers.1685machine # [ 51.714809] nixos[3297]: finished switching to system configuration /nix/store/jschm6qwrdp44ls1zny99c6mwacnbn8z-nixos-system-machine-test1686machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.77 seconds)1687machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&11688machine # [ 51.937159] nixos[3439]: switching to system configuration /nix/store/p3w69z15w5pmg4j7ll8v8z2yg8y7q3r7-nixos-system-machine-test1689machine # [ 51.939741] systemd[1]: Stopped target Remote File Systems.1690machine # [ 51.942492] systemd[1]: -.service: Deactivated successfully.1691machine # [ 51.943359] systemd[1]: Stopped -.service.1692machine # [ 51.944480] systemd[1]: Stopped target Local File Systems.1693machine # [ 52.216744] systemd[1]: Reload requested from client PID 3439 ('.switch-to-conf') (unit backdoor.service)...1694machine # [ 52.218740] systemd[1]: Reloading...1695machine # [ 52.535268] systemd[1]: Reloading finished in 315 ms.1696machine # [ 52.620902] systemd[550]: Reexecution requested from client PID 3508 ('switch-to-confi')...1697machine # [ 52.625357] systemd[550]: Reexecuting.1698machine # [ 52.683255] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1699machine # [ 52.794334] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1700machine # [ 52.800950] systemd[550]: Reload requested from client PID 3508 ('switch-to-confi')...1701machine # [ 52.804251] systemd[550]: Reloading...1702machine # [ 52.905389] systemd[550]: Reloading finished in 102 ms.1703machine # [ 52.920153] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1704machine # [ 52.930307] systemd[550]: Stopped Run user-specific NixOS activation.1705machine # [ 52.932639] systemd[550]: Stopping Run user-specific NixOS activation...1706machine # [ 52.934673] systemd[550]: Starting Run user-specific NixOS activation...1707machine # [ 52.966449] systemd[550]: Finished Run user-specific NixOS activation.1708machine # [ 52.970226] systemd[1]: Stopped target Reactivate sysinit units.1709machine # [ 52.973386] systemd[1]: Stopping Reactivate sysinit units...1710machine # [ 52.974301] systemd[1]: Reached target Reactivate sysinit units.1711machine # [ 52.975138] systemd[1]: Reached target Remote File Systems.1712machine # [ 52.979762] systemd[1]: Reached target Local File Systems.1713machine # [ 52.983233] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1714machine # [ 52.986779] systemd[1]: Starting Create SUID/SGID Wrappers...1715machine # [ 52.987632] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1716machine # [ 52.996571] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671717machine # [ 52.998866] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1718machine # [ 53.005098] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1719machine # [ 53.006373] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1720machine # [ 53.007565] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1721machine # [ 53.008949] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1722machine # [ 53.155339] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1723machine # [ 53.160292] systemd[1]: Finished Create SUID/SGID Wrappers.1724machine # [ 53.163229] systemd[1]: Starting linger-users.service...1725machine # [ 53.167277] systemd[1]: Starting required-service.service...1726machine # [ 53.170749] systemd[1]: Starting test-service.service...1727machine # [ 53.219788] systemd[1]: Finished required-service.service.1728machine # [ 53.223407] systemd[1]: Finished test-service.service.1729machine # [ 53.239350] systemd[1]: linger-users.service: Deactivated successfully.1730machine # [ 53.241570] systemd[1]: Finished linger-users.service.1731machine # [ 53.497963] nixos[3439]: finished switching to system configuration /nix/store/p3w69z15w5pmg4j7ll8v8z2yg8y7q3r7-nixos-system-machine-test1732machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.78 seconds)1733machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&11734machine # [ 53.717807] nixos[3583]: switching to system configuration /nix/store/c2n9w68lz10q5db4xkr794abm9rv6ss9-nixos-system-machine-test1735machine # [ 53.720401] systemd[1]: Stopped target Local File Systems.1736machine # [ 53.725194] systemd[1]: Stopped target Remote File Systems.1737machine # [ 53.726079] systemd[1]: required-service.service: Deactivated successfully.1738machine # [ 53.727055] systemd[1]: Stopped required-service.service.1739machine # [ 53.727827] systemd[1]: test-service.service: Deactivated successfully.1740machine # [ 53.731581] systemd[1]: Stopped test-service.service.1741machine # [ 54.003919] systemd[1]: Reload requested from client PID 3583 ('.switch-to-conf') (unit backdoor.service)...1742machine # [ 54.006058] systemd[1]: Reloading...1743machine # [ 54.321768] systemd[1]: Reloading finished in 314 ms.1744machine # [ 54.402950] systemd[550]: Reexecution requested from client PID 3651 ('switch-to-confi')...1745machine # [ 54.405070] systemd[550]: Reexecuting.1746machine # [ 54.463343] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1747machine # [ 54.573707] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1748machine # [ 54.580341] systemd[550]: Reload requested from client PID 3651 ('switch-to-confi')...1749machine # [ 54.582645] systemd[550]: Reloading...1750machine # [ 54.686588] systemd[550]: Reloading finished in 102 ms.1751machine # [ 54.704165] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1752machine # [ 54.714804] systemd[550]: Stopped Run user-specific NixOS activation.1753machine # [ 54.715841] systemd[550]: Stopping Run user-specific NixOS activation...1754machine # [ 54.718735] systemd[550]: Starting Run user-specific NixOS activation...1755machine # [ 54.746441] systemd[550]: Finished Run user-specific NixOS activation.1756machine # [ 54.750156] systemd[1]: Stopped target Reactivate sysinit units.1757machine # [ 54.752187] systemd[1]: Stopping Reactivate sysinit units...1758machine # [ 54.753355] systemd[1]: Reached target Reactivate sysinit units.1759machine # [ 54.756952] systemd[1]: Reached target Remote File Systems.1760machine # [ 54.763521] systemd[1]: Starting linger-users.service...1761machine # [ 54.768176] systemd[1]: Starting required-service.service...1762machine # [ 54.776752] systemd[1]: Starting test-service.service...1763machine # [ 54.791994] systemd[1]: Reached target Local File Systems.1764machine # [ 54.792935] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1765machine # [ 54.804275] systemd[1]: Starting Create SUID/SGID Wrappers...1766machine # [ 54.805198] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1767machine # [ 54.806506] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671768machine # [ 54.822812] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1769machine # [ 54.832367] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1770machine # [ 54.833901] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1771machine # [ 54.835215] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1772machine # [ 54.858591] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1773machine # [ 54.864411] systemd[1]: Finished required-service.service.1774machine # [ 54.868702] systemd[1]: Finished test-service.service.1775machine # [ 54.894511] systemd[1]: linger-users.service: Deactivated successfully.1776machine # [ 54.898716] systemd[1]: Finished linger-users.service.1777machine # [ 55.019398] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1778machine # [ 55.022715] systemd[1]: Finished Create SUID/SGID Wrappers.1779machine # [ 55.276519] nixos[3583]: finished switching to system configuration /nix/store/c2n9w68lz10q5db4xkr794abm9rv6ss9-nixos-system-machine-test1780machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.78 seconds)1781machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&11782machine # [ 55.495975] nixos[3727]: switching to system configuration /nix/store/bfcw6hm7d8v22lcy1yaa2igvh45kp3fh-nixos-system-machine-test1783machine # [ 55.499572] systemd[1]: required-service.service: Deactivated successfully.1784machine # [ 55.503313] systemd[1]: Stopped required-service.service.1785machine # [ 55.505210] systemd[1]: test-service.service: Deactivated successfully.1786machine # [ 55.506189] systemd[1]: Stopped test-service.service.1787machine # [ 55.506915] systemd[1]: Stopped target Local File Systems.1788machine # [ 55.507709] systemd[1]: Stopped target Remote File Systems.1789machine # [ 55.774628] systemd[1]: Reload requested from client PID 3727 ('.switch-to-conf') (unit backdoor.service)...1790machine # [ 55.776618] systemd[1]: Reloading...1791machine # [ 56.082634] systemd[1]: Reloading finished in 304 ms.1792machine # [ 56.168163] systemd[550]: Reexecution requested from client PID 3796 ('switch-to-confi')...1793machine # [ 56.169573] systemd[550]: Reexecuting.1794machine # [ 56.227255] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1795machine # [ 56.337516] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1796machine # [ 56.343795] systemd[550]: Reload requested from client PID 3796 ('switch-to-confi')...1797machine # [ 56.347117] systemd[550]: Reloading...1798machine # [ 56.447911] systemd[550]: Reloading finished in 101 ms.1799machine # [ 56.464157] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1800machine # [ 56.473037] systemd[550]: Stopped Run user-specific NixOS activation.1801machine # [ 56.475409] systemd[550]: Stopping Run user-specific NixOS activation...1802machine # [ 56.477429] systemd[550]: Starting Run user-specific NixOS activation...1803machine # [ 56.506137] systemd[550]: Finished Run user-specific NixOS activation.1804machine # [ 56.510042] systemd[1]: Stopped target Reactivate sysinit units.1805machine # [ 56.513514] systemd[1]: Stopping Reactivate sysinit units...1806machine # [ 56.514451] systemd[1]: Reached target Reactivate sysinit units.1807machine # [ 56.518879] systemd[1]: Starting required-service.service...1808machine # [ 56.525889] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1809machine # [ 56.527265] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1810machine # [ 56.532884] systemd[1]: Reached target Remote File Systems.1811machine # [ 56.534812] systemd[1]: Reached target Local File Systems.1812machine # [ 56.540468] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1813machine # [ 56.550357] systemd[1]: Starting Create SUID/SGID Wrappers...1814machine # [ 56.551253] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1815machine # [ 56.557097] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671816machine # [ 56.559356] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1817machine # [ 56.568066] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1818machine # [ 56.570794] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1819machine # [ 56.573393] systemd[1]: Finished required-service.service.1820machine # [ 56.714575] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1821machine # [ 56.719288] systemd[1]: Finished Create SUID/SGID Wrappers.1822machine # [ 56.722739] systemd[1]: Starting linger-users.service...1823machine # [ 56.725919] systemd[1]: Starting test-service.service...1824machine # [ 56.762469] systemd[1]: Finished test-service.service.1825machine # [ 56.779960] systemd[1]: linger-users.service: Deactivated successfully.1826machine # [ 56.782598] systemd[1]: Finished linger-users.service.1827machine # [ 57.037686] nixos[3727]: finished switching to system configuration /nix/store/bfcw6hm7d8v22lcy1yaa2igvh45kp3fh-nixos-system-machine-test1828machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.76 seconds)1829machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&11830machine # [ 57.255776] nixos[3871]: switching to system configuration /nix/store/544d65y2xjf1l9bbd7844z5cbv5is45d-nixos-system-machine-test1831machine # [ 57.258667] systemd[1]: required-service.service: Deactivated successfully.1832machine # [ 57.261338] systemd[1]: Stopped required-service.service.1833machine # [ 57.262203] systemd[1]: test-service.service: Deactivated successfully.1834machine # [ 57.263115] systemd[1]: Stopped test-service.service.1835machine # [ 57.264349] systemd[1]: Stopped target Remote File Systems.1836machine # [ 57.267152] systemd[1]: Stopped target Local File Systems.1837machine # [ 57.539326] systemd[1]: Reload requested from client PID 3871 ('.switch-to-conf') (unit backdoor.service)...1838machine # [ 57.541385] systemd[1]: Reloading...1839machine # [ 57.848171] systemd[1]: Reloading finished in 305 ms.1840machine # [ 57.931867] systemd[550]: Reexecution requested from client PID 3940 ('switch-to-confi')...1841machine # [ 57.934128] systemd[550]: Reexecuting.1842machine # [ 57.991636] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1843machine # [ 58.102273] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1844machine # [ 58.108731] systemd[550]: Reload requested from client PID 3940 ('switch-to-confi')...1845machine # [ 58.112081] systemd[550]: Reloading...1846machine # [ 58.214527] systemd[550]: Reloading finished in 103 ms.1847machine # [ 58.232169] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1848machine # [ 58.243480] systemd[550]: Stopped Run user-specific NixOS activation.1849machine # [ 58.245800] systemd[550]: Stopping Run user-specific NixOS activation...1850machine # [ 58.247847] systemd[550]: Starting Run user-specific NixOS activation...1851machine # [ 58.278779] systemd[550]: Finished Run user-specific NixOS activation.1852machine # [ 58.282698] systemd[1]: Stopped target Reactivate sysinit units.1853machine # [ 58.285701] systemd[1]: Stopping Reactivate sysinit units...1854machine # [ 58.286564] systemd[1]: Reached target Reactivate sysinit units.1855machine # [ 58.287845] systemd[1]: Reached target Local File Systems.1856machine # [ 58.292791] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1857machine # [ 58.301884] systemd[1]: Starting Create SUID/SGID Wrappers...1858machine # [ 58.302778] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1859machine # [ 58.313236] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671860machine # [ 58.315572] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1861machine # [ 58.318141] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1862machine # [ 58.319436] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1863machine # [ 58.321933] systemd[1]: Created slice Slice /system/instantiated.1864machine # [ 58.324088] systemd[1]: Reached target Remote File Systems.1865machine # [ 58.325477] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1866machine # [ 58.327653] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1867machine # [ 58.472358] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1868machine # [ 58.474243] systemd[1]: Finished Create SUID/SGID Wrappers.1869machine # [ 58.479061] systemd[1]: Starting instantiated@one.service...1870machine # [ 58.483916] systemd[1]: Starting instantiated@two.service...1871machine # [ 58.495023] systemd[1]: Starting linger-users.service...1872machine # [ 58.537161] systemd[1]: Finished instantiated@two.service.1873machine # [ 58.540379] systemd[1]: Finished instantiated@one.service.1874machine # [ 58.557259] systemd[1]: linger-users.service: Deactivated successfully.1875machine # [ 58.560343] systemd[1]: Finished linger-users.service.1876machine # [ 58.814966] nixos[3871]: finished switching to system configuration /nix/store/544d65y2xjf1l9bbd7844z5cbv5is45d-nixos-system-machine-test1877machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.78 seconds)1878machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&11879machine # [ 59.040868] nixos[4015]: switching to system configuration /nix/store/va5w8bprhigx1kylyy5dcv934h2zwm8b-nixos-system-machine-test1880machine # [ 59.043410] systemd[1]: Stopped target Local File Systems.1881machine # [ 59.046016] systemd[1]: instantiated@two.service: Deactivated successfully.1882machine # [ 59.047020] systemd[1]: Stopped instantiated@two.service.1883machine # [ 59.048387] systemd[1]: Stopped target Remote File Systems.1884machine # [ 59.050823] systemd[1]: instantiated@one.service: Deactivated successfully.1885machine # [ 59.052432] systemd[1]: Stopped instantiated@one.service.1886machine # [ 59.317372] systemd[1]: Reload requested from client PID 4015 ('.switch-to-conf') (unit backdoor.service)...1887machine # [ 59.319272] systemd[1]: Reloading...1888machine # [ 59.630080] systemd[1]: Reloading finished in 308 ms.1889machine # [ 59.711144] systemd[550]: Reexecution requested from client PID 4084 ('switch-to-confi')...1890machine # [ 59.714876] systemd[550]: Reexecuting.1891machine # [ 59.775235] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1892machine # [ 59.887780] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1893machine # [ 59.894185] systemd[550]: Reload requested from client PID 4084 ('switch-to-confi')...1894machine # [ 59.896462] systemd[550]: Reloading...1895machine # [ 59.998991] systemd[550]: Reloading finished in 101 ms.1896machine # [ 60.016205] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1897machine # [ 60.027765] systemd[550]: Stopped Run user-specific NixOS activation.1898machine # [ 60.030127] systemd[550]: Stopping Run user-specific NixOS activation...1899machine # [ 60.032278] systemd[550]: Starting Run user-specific NixOS activation...1900machine # [ 60.063062] systemd[550]: Finished Run user-specific NixOS activation.1901machine # [ 60.066698] systemd[1]: Stopped target Reactivate sysinit units.1902machine # [ 60.072246] systemd[1]: Stopping Reactivate sysinit units...1903machine # [ 60.073139] systemd[1]: Reached target Reactivate sysinit units.1904machine # [ 60.074070] systemd[1]: Reached target Local File Systems.1905machine # [ 60.074843] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1906machine # [ 60.078748] systemd[1]: Starting Create SUID/SGID Wrappers...1907machine # [ 60.079643] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1908machine # [ 60.091436] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671909machine # [ 60.096794] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1910machine # [ 60.098468] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1911machine # [ 60.099725] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1912machine # [ 60.103790] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1913machine # [ 60.106052] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1914machine # [ 60.107352] systemd[1]: Reached target Remote File Systems.1915machine # [ 60.254147] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1916machine # [ 60.258504] systemd[1]: Finished Create SUID/SGID Wrappers.1917machine # [ 60.261777] systemd[1]: Starting instantiated@one.service...1918machine # [ 60.265972] systemd[1]: Starting instantiated@two.service...1919machine # [ 60.279145] systemd[1]: Starting linger-users.service...1920machine # [ 60.321423] systemd[1]: Finished instantiated@one.service.1921machine # [ 60.325583] systemd[1]: Finished instantiated@two.service.1922machine # [ 60.341256] systemd[1]: linger-users.service: Deactivated successfully.1923machine # [ 60.344409] systemd[1]: Finished linger-users.service.1924machine # [ 60.598485] nixos[4015]: finished switching to system configuration /nix/store/va5w8bprhigx1kylyy5dcv934h2zwm8b-nixos-system-machine-test1925machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.78 seconds)1926(finished: subtest: services, in 37.84 seconds)1927subtest: failing units1928machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11929machine # [ 60.808370] nixos[4159]: switching to system configuration /nix/store/v9dgrzy7y8kapjwvi1fciij8nhxi3bky-nixos-system-machine-test1930machine # [ 60.811744] systemd[1]: instantiated@one.service: Deactivated successfully.1931machine # [ 60.814241] systemd[1]: Stopped instantiated@one.service.1932machine # [ 60.815047] systemd[1]: instantiated@two.service: Deactivated successfully.1933machine # [ 60.815994] systemd[1]: Stopped instantiated@two.service.1934machine # [ 60.819104] systemd[1]: Stopped target Local File Systems.1935machine # [ 60.819894] systemd[1]: Stopped target Remote File Systems.1936machine # [ 61.071805] systemd[1]: Reload requested from client PID 4159 ('.switch-to-conf') (unit backdoor.service)...1937machine # [ 61.074019] systemd[1]: Reloading...1938machine # [ 61.372177] systemd[1]: Reloading finished in 296 ms.1939machine # [ 61.455769] systemd[550]: Reexecution requested from client PID 4228 ('switch-to-confi')...1940machine # [ 61.458673] systemd[550]: Reexecuting.1941machine # [ 61.519287] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1942machine # [ 61.631026] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1943machine # [ 61.638362] systemd[550]: Reload requested from client PID 4228 ('switch-to-confi')...1944machine # [ 61.639732] systemd[550]: Reloading...1945machine # [ 61.742541] systemd[550]: Reloading finished in 101 ms.1946machine # [ 61.764182] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1947machine # [ 61.774111] systemd[550]: Stopped Run user-specific NixOS activation.1948machine # [ 61.776445] systemd[550]: Stopping Run user-specific NixOS activation...1949machine # [ 61.778669] systemd[550]: Starting Run user-specific NixOS activation...1950machine # [ 61.811464] systemd[550]: Finished Run user-specific NixOS activation.1951machine # [ 61.815218] systemd[1]: Stopped target Reactivate sysinit units.1952machine # [ 61.817205] systemd[1]: Stopping Reactivate sysinit units...1953machine # [ 61.818137] systemd[1]: Reached target Reactivate sysinit units.1954machine # [ 61.820460] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1955machine # [ 61.821830] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1956machine # [ 61.825242] systemd[1]: Reached target Remote File Systems.1957machine # [ 61.830306] systemd[1]: Starting linger-users.service...1958machine # [ 61.834146] systemd[1]: Starting test.service...1959machine # [ 61.848825] systemd[1]: Reached target Local File Systems.1960machine # [ 61.849857] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1961machine # [ 61.865039] systemd[1]: Starting Create SUID/SGID Wrappers...1962machine # [ 61.866079] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1963machine # [ 61.873404] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671964machine # [ 61.883450] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1965machine # [ 61.892707] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1966machine # [ 61.894036] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1967machine # [ 61.904169] systemd[1]: Finished test.service.1968machine # [ 61.931171] systemd[1]: linger-users.service: Deactivated successfully.1969machine # [ 61.935985] systemd[1]: Finished linger-users.service.1970machine # [ 62.066607] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1971machine # [ 62.069867] systemd[1]: Finished Create SUID/SGID Wrappers.1972machine # [ 62.325139] nixos[4159]: finished switching to system configuration /nix/store/v9dgrzy7y8kapjwvi1fciij8nhxi3bky-nixos-system-machine-test1973machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.73 seconds)1974machine: must fail: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&11975machine # [ 62.541580] nixos[4301]: switching to system configuration /nix/store/z0cx6jxfkkga6mjmr0ybc55yc24l662g-nixos-system-machine-test1976machine # [ 62.544150] systemd[1]: test.service: Deactivated successfully.1977machine # [ 62.548081] systemd[1]: Stopped test.service.1978machine # [ 62.548809] systemd[1]: Stopped target Remote File Systems.1979machine # [ 62.549629] systemd[1]: Stopped target Local File Systems.1980machine # [ 62.825920] systemd[1]: Reload requested from client PID 4301 ('.switch-to-conf') (unit backdoor.service)...1981machine # [ 62.827835] systemd[1]: Reloading...1982machine # [ 63.137078] systemd[1]: Reloading finished in 307 ms.1983machine # [ 63.220426] systemd[550]: Reexecution requested from client PID 4370 ('switch-to-confi')...1984machine # [ 63.224081] systemd[550]: Reexecuting.1985machine # [ 63.283259] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1986machine # [ 63.393046] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1987machine # [ 63.400197] systemd[550]: Reload requested from client PID 4370 ('switch-to-confi')...1988machine # [ 63.401592] systemd[550]: Reloading...1989machine # [ 63.506497] systemd[550]: Reloading finished in 103 ms.1990machine # [ 63.520183] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1991machine # [ 63.529277] systemd[550]: Stopped Run user-specific NixOS activation.1992machine # [ 63.531573] systemd[550]: Stopping Run user-specific NixOS activation...1993machine # [ 63.533687] systemd[550]: Starting Run user-specific NixOS activation...1994machine # [ 63.563044] systemd[550]: Finished Run user-specific NixOS activation.1995machine # [ 63.566659] systemd[1]: Stopped target Reactivate sysinit units.1996machine # [ 63.569794] systemd[1]: Stopping Reactivate sysinit units...1997machine # [ 63.570677] systemd[1]: Reached target Reactivate sysinit units.1998machine # [ 63.571513] systemd[1]: Reached target Local File Systems.1999machine # [ 63.577406] systemd[1]: Starting test.service...2000machine # [ 63.581823] systemd[1]: Reached target Remote File Systems.2001machine # [ 63.584822] systemd[1]: Starting linger-users.service...2002machine # [ 63.591800] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2003machine # [ 63.603555] systemd[1]: Starting Create SUID/SGID Wrappers...2004machine # [ 63.605163] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2005machine # [ 63.606482] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672006machine # [ 63.617357] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2007machine # [ 63.619115] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2008machine # [ 63.625567] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2009machine # [ 63.626953] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2010machine # [ 63.637680] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2011machine # [ 63.658057] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE2012machine # [ 63.659463] systemd[1]: test.service: Failed with result 'exit-code'.2013machine # [ 63.664907] systemd[1]: Failed to start test.service.2014machine # [ 63.690322] systemd[1]: linger-users.service: Deactivated successfully.2015machine # [ 63.694623] systemd[1]: Finished linger-users.service.2016machine # [ 63.818758] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2017machine # [ 63.822250] systemd[1]: Finished Create SUID/SGID Wrappers.2018machine # [ 64.097472] nixos[4301]: switching to system configuration /nix/store/z0cx6jxfkkga6mjmr0ybc55yc24l662g-nixos-system-machine-test failed (status 4)2019machine: (finished: must fail: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.77 seconds)2020machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12021machine # [ 64.306794] nixos[4444]: switching to system configuration /nix/store/m78zd7xzjbhlpi0pfz0f3wm0cda9hm7p-nixos-system-machine-test2022machine # [ 64.309488] systemd[1]: Stopped target Remote File Systems.2023machine # [ 64.311699] systemd[1]: Stopped target Local File Systems.2024machine # [ 64.589425] systemd[1]: Reload requested from client PID 4444 ('.switch-to-conf') (unit backdoor.service)...2025machine # [ 64.591402] systemd[1]: Reloading...2026machine # [ 64.901721] systemd[1]: Reloading finished in 308 ms.2027machine # [ 64.981684] systemd[550]: Reexecution requested from client PID 4513 ('switch-to-confi')...2028machine # [ 64.985381] systemd[550]: Reexecuting.2029machine # [ 65.043699] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2030machine # [ 65.153870] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2031machine # [ 65.160223] systemd[550]: Reload requested from client PID 4513 ('switch-to-confi')...2032machine # [ 65.162550] systemd[550]: Reloading...2033machine # [ 65.264976] systemd[550]: Reloading finished in 101 ms.2034machine # [ 65.277522] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2035machine # [ 65.285123] systemd[550]: Stopped Run user-specific NixOS activation.2036machine # [ 65.287344] systemd[550]: Stopping Run user-specific NixOS activation...2037machine # [ 65.289391] systemd[550]: Starting Run user-specific NixOS activation...2038machine # [ 65.317995] systemd[550]: Finished Run user-specific NixOS activation.2039machine # [ 65.321966] systemd[1]: Stopped target Reactivate sysinit units.2040machine # [ 65.325170] systemd[1]: Stopping Reactivate sysinit units...2041machine # [ 65.326049] systemd[1]: Reached target Reactivate sysinit units.2042machine # [ 65.328400] systemd[1]: Reached target Local File Systems.2043machine # [ 65.329233] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2044machine # [ 65.336147] systemd[1]: Starting Create SUID/SGID Wrappers...2045machine # [ 65.337038] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2046machine # [ 65.338338] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672047machine # [ 65.351179] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2048machine # [ 65.354980] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2049machine # [ 65.356358] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2050machine # [ 65.357567] systemd[1]: Reached target Remote File Systems.2051machine # [ 65.358365] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2052machine # [ 65.359622] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2053machine # [ 65.505557] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2054machine # [ 65.507985] systemd[1]: Finished Create SUID/SGID Wrappers.2055machine # [ 65.512160] systemd[1]: Started autorestart.service.2056machine # [ 65.517120] systemd[1]: Starting linger-users.service...2057machine # [ 65.554260] systemd[1]: autorestart.service: Deactivated successfully.2058machine # [ 65.572325] systemd[1]: linger-users.service: Deactivated successfully.2059machine # [ 65.575257] systemd[1]: Finished linger-users.service.2060machine # [ 65.830533] nixos[4444]: finished switching to system configuration /nix/store/m78zd7xzjbhlpi0pfz0f3wm0cda9hm7p-nixos-system-machine-test2061machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.73 seconds)2062machine # [ 65.869465] systemd[1]: Stopped autorestart.service.2063machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12064machine # [ 66.062215] nixos[4591]: switching to system configuration /nix/store/m78zd7xzjbhlpi0pfz0f3wm0cda9hm7p-nixos-system-machine-test2065machine # [ 66.064673] systemd[1]: Stopped target Remote File Systems.2066machine # [ 66.067503] systemd[1]: Stopped target Local File Systems.2067machine # [ 66.317031] systemd[1]: Reload requested from client PID 4591 ('.switch-to-conf') (unit backdoor.service)...2068machine # [ 66.319191] systemd[1]: Reloading...2069machine # [ 66.616422] systemd[1]: Reloading finished in 295 ms.2070machine # [ 66.699027] systemd[550]: Reexecution requested from client PID 4660 ('switch-to-confi')...2071machine # [ 66.702598] systemd[550]: Reexecuting.2072machine # [ 66.759183] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2073machine # [ 66.868225] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2074machine # [ 66.874427] systemd[550]: Reload requested from client PID 4660 ('switch-to-confi')...2075machine # [ 66.877788] systemd[550]: Reloading...2076machine # [ 66.978098] systemd[550]: Reloading finished in 101 ms.2077machine # [ 66.992147] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2078machine # [ 67.001325] systemd[550]: Stopped Run user-specific NixOS activation.2079machine # [ 67.003602] systemd[550]: Stopping Run user-specific NixOS activation...2080machine # [ 67.005637] systemd[550]: Starting Run user-specific NixOS activation...2081machine # [ 67.034095] systemd[550]: Finished Run user-specific NixOS activation.2082machine # [ 67.037791] systemd[1]: Stopped target Reactivate sysinit units.2083machine # [ 67.040661] systemd[1]: Stopping Reactivate sysinit units...2084machine # [ 67.041536] systemd[1]: Reached target Reactivate sysinit units.2085machine # [ 67.043094] systemd[1]: Reached target Remote File Systems.2086machine # [ 67.051273] systemd[1]: Started autorestart.service.2087machine # [ 67.056220] systemd[1]: Starting linger-users.service...2088machine # [ 67.057048] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2089machine # [ 67.058345] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2090machine # [ 67.070858] systemd[1]: Reached target Local File Systems.2091machine # [ 67.073346] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2092machine # [ 67.081604] systemd[1]: Starting Create SUID/SGID Wrappers...2093machine # [ 67.082566] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2094machine # [ 67.083795] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672095machine # [ 67.099945] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2096machine # [ 67.104995] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2097machine # [ 67.110412] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2098machine # [ 67.119814] systemd[1]: autorestart.service: Deactivated successfully.2099machine # [ 67.150900] systemd[1]: linger-users.service: Deactivated successfully.2100machine # [ 67.154574] systemd[1]: Finished linger-users.service.2101machine # [ 67.283830] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2102machine # [ 67.286873] systemd[1]: Finished Create SUID/SGID Wrappers.2103machine # [ 67.543681] nixos[4591]: finished switching to system configuration /nix/store/m78zd7xzjbhlpi0pfz0f3wm0cda9hm7p-nixos-system-machine-test2104machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.67 seconds)2105machine # [ 67.582823] systemd[1]: Stopped autorestart.service.2106machine: must fail: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&12107machine # [ 67.791325] nixos[4738]: switching to system configuration /nix/store/5riwgdg245wnwh4knrs7p7xjb9hjmayl-nixos-system-machine-test2108machine # [ 67.794399] systemd[1]: Stopped target Remote File Systems.2109machine # [ 67.796132] systemd[1]: Stopped target Local File Systems.2110machine # [ 68.065105] systemd[1]: Reload requested from client PID 4738 ('.switch-to-conf') (unit backdoor.service)...2111machine # [ 68.067101] systemd[1]: Reloading...2112machine # [ 68.375280] systemd[1]: Reloading finished in 306 ms.2113machine # [ 68.459974] systemd[550]: Reexecution requested from client PID 4807 ('switch-to-confi')...2114machine # [ 68.461404] systemd[550]: Reexecuting.2115machine # [ 68.519088] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2116machine # [ 68.630434] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2117machine # [ 68.636959] systemd[550]: Reload requested from client PID 4807 ('switch-to-confi')...2118machine # [ 68.640081] systemd[550]: Reloading...2119machine # [ 68.743987] systemd[550]: Reloading finished in 104 ms.2120machine # [ 68.764177] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2121machine # [ 68.773372] systemd[550]: Stopped Run user-specific NixOS activation.2122machine # [ 68.775598] systemd[550]: Stopping Run user-specific NixOS activation...2123machine # [ 68.777642] systemd[550]: Starting Run user-specific NixOS activation...2124machine # [ 68.806516] systemd[550]: Finished Run user-specific NixOS activation.2125machine # [ 68.810403] systemd[1]: Stopped target Reactivate sysinit units.2126machine # [ 68.814280] systemd[1]: Stopping Reactivate sysinit units...2127machine # [ 68.815176] systemd[1]: Reached target Reactivate sysinit units.2128machine # [ 68.820426] systemd[1]: Reached target Local File Systems.2129machine # [ 68.821323] systemd[1]: Reached target Remote File Systems.2130machine # [ 68.824374] systemd[1]: Started autorestart.service.2131machine # [ 68.829272] systemd[1]: Starting linger-users.service...2132machine # [ 68.843356] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2133machine # [ 68.847695] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2134machine # [ 68.855005] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2135machine # [ 68.861704] systemd[1]: Starting Create SUID/SGID Wrappers...2136machine # [ 68.865937] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2137machine # [ 68.872414] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672138machine # [ 68.882781] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2139machine # [ 68.890328] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2140machine # [ 68.891740] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2141machine # [ 68.900584] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE2142machine # [ 68.901965] systemd[1]: autorestart.service: Failed with result 'exit-code'.2143machine # [ 68.930660] systemd[1]: linger-users.service: Deactivated successfully.2144machine # [ 68.934249] systemd[1]: Finished linger-users.service.2145machine # [ 69.056902] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2146machine # [ 69.060309] systemd[1]: Finished Create SUID/SGID Wrappers.2147machine # [ 69.335695] nixos[4738]: switching to system configuration /nix/store/5riwgdg245wnwh4knrs7p7xjb9hjmayl-nixos-system-machine-test failed (status 4)2148machine: (finished: must fail: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.75 seconds)2149(finished: subtest: failing units, in 8.74 seconds)2150subtest: unit file parser2151machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12152machine # [ 69.530620] nixos[4881]: switching to system configuration /nix/store/cbsymq7lb09snni660gz9vpbjxjplvzp-nixos-system-machine-test2153machine # [ 69.533369] systemd[1]: Stopped target Remote File Systems.2154machine # [ 69.535614] systemd[1]: Stopped autorestart.service.2155machine # [ 69.537764] systemd[1]: Stopped target Local File Systems.2156machine # [ 69.789287] systemd[1]: Reload requested from client PID 4881 ('.switch-to-conf') (unit backdoor.service)...2157machine # [ 69.791231] systemd[1]: Reloading...2158machine # [ 70.093595] systemd[1]: Reloading finished in 300 ms.2159machine # [ 70.176410] systemd[550]: Reexecution requested from client PID 4950 ('switch-to-confi')...2160machine # [ 70.180152] systemd[550]: Reexecuting.2161machine # [ 70.235238] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2162machine # [ 70.347426] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2163machine # [ 70.354216] systemd[550]: Reload requested from client PID 4950 ('switch-to-confi')...2164machine # [ 70.356530] systemd[550]: Reloading...2165machine # [ 70.462391] systemd[550]: Reloading finished in 104 ms.2166machine # [ 70.476148] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2167machine # [ 70.485898] systemd[550]: Stopped Run user-specific NixOS activation.2168machine # [ 70.488066] systemd[550]: Stopping Run user-specific NixOS activation...2169machine # [ 70.489980] systemd[550]: Starting Run user-specific NixOS activation...2170machine # [ 70.518190] systemd[550]: Finished Run user-specific NixOS activation.2171machine # [ 70.522112] systemd[1]: Stopped target Reactivate sysinit units.2172machine # [ 70.524895] systemd[1]: Stopping Reactivate sysinit units...2173machine # [ 70.525802] systemd[1]: Reached target Reactivate sysinit units.2174machine # [ 70.526694] systemd[1]: Reached target Remote File Systems.2175machine # [ 70.532175] systemd[1]: Reached target Local File Systems.2176machine # [ 70.533079] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2177machine # [ 70.538328] systemd[1]: Starting Create SUID/SGID Wrappers...2178machine # [ 70.539233] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2179machine # [ 70.548535] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672180machine # [ 70.550806] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2181machine # [ 70.553015] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2182machine # [ 70.554398] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2183machine # [ 70.557703] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2184machine # [ 70.559069] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2185machine # [ 70.708289] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2186machine # [ 70.712616] systemd[1]: Finished Create SUID/SGID Wrappers.2187machine # [ 70.716173] systemd[1]: Starting linger-users.service...2188machine # [ 70.718971] systemd[1]: Starting test.service...2189machine # [ 70.758698] systemd[1]: Finished test.service.2190machine # [ 70.775824] systemd[1]: linger-users.service: Deactivated successfully.2191machine # [ 70.778187] systemd[1]: Finished linger-users.service.2192machine # [ 71.034641] nixos[4881]: finished switching to system configuration /nix/store/cbsymq7lb09snni660gz9vpbjxjplvzp-nixos-system-machine-test2193machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.70 seconds)2194machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&12195machine # [ 71.256219] nixos[5023]: switching to system configuration /nix/store/80y53wma71wfc3cjjhr9cl76q17bwr9h-nixos-system-machine-test2196machine # [ 71.259044] systemd[1]: Stopped target Local File Systems.2197machine # [ 71.261010] systemd[1]: Stopped target Remote File Systems.2198machine # [ 71.530637] systemd[1]: Reload requested from client PID 5023 ('.switch-to-conf') (unit backdoor.service)...2199machine # [ 71.532651] systemd[1]: Reloading...2200machine # [ 71.842503] systemd[1]: Reloading finished in 308 ms.2201machine # [ 71.931478] systemd[550]: Reexecution requested from client PID 5092 ('switch-to-confi')...2202machine # [ 71.933727] systemd[550]: Reexecuting.2203machine # [ 71.995180] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2204machine # [ 72.114434] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2205machine # [ 72.120808] systemd[550]: Reload requested from client PID 5092 ('switch-to-confi')...2206machine # [ 72.123234] systemd[550]: Reloading...2207machine # [ 72.227871] systemd[550]: Reloading finished in 103 ms.2208machine # [ 72.248152] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2209machine # [ 72.257163] systemd[550]: Stopped Run user-specific NixOS activation.2210machine # [ 72.259404] systemd[550]: Stopping Run user-specific NixOS activation...2211machine # [ 72.261479] systemd[550]: Starting Run user-specific NixOS activation...2212machine # [ 72.290181] systemd[550]: Finished Run user-specific NixOS activation.2213machine # [ 72.294072] systemd[1]: Stopped target Reactivate sysinit units.2214machine # [ 72.298888] systemd[1]: Stopping Reactivate sysinit units...2215machine # [ 72.299812] systemd[1]: Reached target Reactivate sysinit units.2216machine # [ 72.301184] systemd[1]: test.service: Deactivated successfully.2217machine # [ 72.302070] systemd[1]: Stopped test.service.2218machine # [ 72.302738] systemd[1]: Stopping test.service...2219machine # [ 72.308397] systemd[1]: Starting test.service...2220machine # [ 72.327837] systemd[1]: Finished test.service.2221machine # [ 72.331646] systemd[1]: Reached target Remote File Systems.2222machine # [ 72.335709] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2223machine # [ 72.339568] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2224machine # [ 72.343304] systemd[1]: Reached target Local File Systems.2225machine # [ 72.345896] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2226machine # [ 72.352476] systemd[1]: Starting Create SUID/SGID Wrappers...2227machine # [ 72.353438] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2228machine # [ 72.354769] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672229machine # [ 72.363890] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2230machine # [ 72.365712] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2231machine # [ 72.366990] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2232machine # [ 72.511560] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2233machine # [ 72.513537] systemd[1]: Finished Create SUID/SGID Wrappers.2234machine # [ 72.518367] systemd[1]: Starting linger-users.service...2235machine # [ 72.554482] systemd[1]: linger-users.service: Deactivated successfully.2236machine # [ 72.556758] systemd[1]: Finished linger-users.service.2237machine # [ 72.812254] nixos[5023]: finished switching to system configuration /nix/store/80y53wma71wfc3cjjhr9cl76q17bwr9h-nixos-system-machine-test2238machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.78 seconds)2239machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&12240machine # [ 73.034495] nixos[5165]: switching to system configuration /nix/store/q0wiypaj23lvyys0skhmq644abqddfnc-nixos-system-machine-test2241machine # [ 73.036880] systemd[1]: Stopped target Remote File Systems.2242machine # [ 73.039350] systemd[1]: Stopped target Local File Systems.2243machine # [ 73.308786] systemd[1]: Reload requested from client PID 5165 ('.switch-to-conf') (unit backdoor.service)...2244machine # [ 73.310672] systemd[1]: Reloading...2245machine # [ 73.617843] systemd[1]: Reloading finished in 305 ms.2246machine # [ 73.704751] systemd[550]: Reexecution requested from client PID 5234 ('switch-to-confi')...2247machine # [ 73.708824] systemd[550]: Reexecuting.2248machine # [ 73.767204] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2249machine # [ 73.881149] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2250machine # [ 73.887555] systemd[550]: Reload requested from client PID 5234 ('switch-to-confi')...2251machine # [ 73.891110] systemd[550]: Reloading...2252machine # [ 73.992912] systemd[550]: Reloading finished in 102 ms.2253machine # [ 74.008154] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2254machine # [ 74.017951] systemd[550]: Stopped Run user-specific NixOS activation.2255machine # [ 74.020123] systemd[550]: Stopping Run user-specific NixOS activation...2256machine # [ 74.022427] systemd[550]: Starting Run user-specific NixOS activation...2257machine # [ 74.055302] systemd[550]: Finished Run user-specific NixOS activation.2258machine # [ 74.059178] systemd[1]: Stopped target Reactivate sysinit units.2259machine # [ 74.063620] systemd[1]: Stopping Reactivate sysinit units...2260machine # [ 74.064781] systemd[1]: Reached target Reactivate sysinit units.2261machine # [ 74.065730] systemd[1]: test.service: Deactivated successfully.2262machine # [ 74.066572] systemd[1]: Stopped test.service.2263machine # [ 74.067227] systemd[1]: Stopping test.service...2264machine # [ 74.072224] systemd[1]: Starting test.service...2265machine # [ 74.091572] systemd[1]: Finished test.service.2266machine # [ 74.099052] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2267machine # [ 74.102172] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2268machine # [ 74.103482] systemd[1]: Reached target Remote File Systems.2269machine # [ 74.105482] systemd[1]: Reached target Local File Systems.2270machine # [ 74.110618] systemd[1]: Starting linger-users.service...2271machine # [ 74.115124] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2272machine # [ 74.118847] systemd[1]: Starting Create SUID/SGID Wrappers...2273machine # [ 74.119741] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2274machine # [ 74.130822] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672275machine # [ 74.133365] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2276machine # [ 74.134963] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2277machine # [ 74.136281] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2278machine # [ 74.187249] systemd[1]: linger-users.service: Deactivated successfully.2279machine # [ 74.190005] systemd[1]: Finished linger-users.service.2280machine # [ 74.312211] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2281machine # [ 74.314922] systemd[1]: Finished Create SUID/SGID Wrappers.2282machine # [ 74.570561] nixos[5165]: finished switching to system configuration /nix/store/q0wiypaj23lvyys0skhmq644abqddfnc-nixos-system-machine-test2283machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.76 seconds)2284machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12285machine # [ 74.772480] nixos[5307]: switching to system configuration /nix/store/cbsymq7lb09snni660gz9vpbjxjplvzp-nixos-system-machine-test2286machine # [ 74.774905] systemd[1]: Stopped target Remote File Systems.2287machine # [ 74.777493] systemd[1]: Stopped target Local File Systems.2288machine # [ 75.027324] systemd[1]: Reload requested from client PID 5307 ('.switch-to-conf') (unit backdoor.service)...2289machine # [ 75.029614] systemd[1]: Reloading...2290machine # [ 75.323252] systemd[1]: Reloading finished in 292 ms.2291machine # [ 75.406858] systemd[550]: Reexecution requested from client PID 5376 ('switch-to-confi')...2292machine # [ 75.408862] systemd[550]: Reexecuting.2293machine # [ 75.471219] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2294machine # [ 75.582822] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2295machine # [ 75.589094] systemd[550]: Reload requested from client PID 5376 ('switch-to-confi')...2296machine # [ 75.592200] systemd[550]: Reloading...2297machine # [ 75.693985] systemd[550]: Reloading finished in 102 ms.2298machine # [ 75.712161] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2299machine # [ 75.721091] systemd[550]: Stopped Run user-specific NixOS activation.2300machine # [ 75.723331] systemd[550]: Stopping Run user-specific NixOS activation...2301machine # [ 75.725331] systemd[550]: Starting Run user-specific NixOS activation...2302machine # [ 75.753589] systemd[550]: Finished Run user-specific NixOS activation.2303machine # [ 75.756900] systemd[1]: Stopped target Reactivate sysinit units.2304machine # [ 75.758778] systemd[1]: Stopping Reactivate sysinit units...2305machine # [ 75.759622] systemd[1]: Reached target Reactivate sysinit units.2306machine # [ 75.763234] systemd[1]: test.service: Deactivated successfully.2307machine # [ 75.764363] systemd[1]: Stopped test.service.2308machine # [ 75.765004] systemd[1]: Stopping test.service...2309machine # [ 75.766640] systemd[1]: Starting test.service...2310machine # [ 75.787321] systemd[1]: Finished test.service.2311machine # [ 75.791766] systemd[1]: Reached target Local File Systems.2312machine # [ 75.797197] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2313machine # [ 75.798851] systemd[1]: Starting Create SUID/SGID Wrappers...2314machine # [ 75.799677] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2315machine # [ 75.813114] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672316machine # [ 75.815340] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2317machine # [ 75.818217] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2318machine # [ 75.819514] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2319machine # [ 75.820788] systemd[1]: Reached target Remote File Systems.2320machine # [ 75.821583] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2321machine # [ 75.822861] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2322machine # [ 75.968198] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2323machine # [ 75.971022] systemd[1]: Finished Create SUID/SGID Wrappers.2324machine # [ 75.975042] systemd[1]: Starting linger-users.service...2325machine # [ 76.014158] systemd[1]: linger-users.service: Deactivated successfully.2326machine # [ 76.016361] systemd[1]: Finished linger-users.service.2327machine # [ 76.272110] nixos[5307]: finished switching to system configuration /nix/store/cbsymq7lb09snni660gz9vpbjxjplvzp-nixos-system-machine-test2328machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.70 seconds)2329machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&12330machine # [ 76.487603] nixos[5449]: switching to system configuration /nix/store/m8kqkf8v6s3vka995prjp55r4scg2wq7-nixos-system-machine-test2331machine # [ 76.490559] systemd[1]: Stopped target Local File Systems.2332machine # [ 76.493069] systemd[1]: Stopped target Remote File Systems.2333machine # [ 76.759029] systemd[1]: Reload requested from client PID 5449 ('.switch-to-conf') (unit backdoor.service)...2334machine # [ 76.761267] systemd[1]: Reloading...2335machine # [ 77.063993] systemd[1]: Reloading finished in 301 ms.2336machine # [ 77.150191] systemd[550]: Reexecution requested from client PID 5518 ('switch-to-confi')...2337machine # [ 77.154050] systemd[550]: Reexecuting.2338machine # [ 77.211037] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2339machine # [ 77.325008] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2340machine # [ 77.331413] systemd[550]: Reload requested from client PID 5518 ('switch-to-confi')...2341machine # [ 77.334742] systemd[550]: Reloading...2342machine # [ 77.435823] systemd[550]: Reloading finished in 102 ms.2343machine # [ 77.452140] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2344machine # [ 77.460741] systemd[550]: Stopped Run user-specific NixOS activation.2345machine # [ 77.462834] systemd[550]: Stopping Run user-specific NixOS activation...2346machine # [ 77.464765] systemd[550]: Starting Run user-specific NixOS activation...2347machine # [ 77.493186] systemd[550]: Finished Run user-specific NixOS activation.2348machine # [ 77.497571] systemd[1]: Stopped target Reactivate sysinit units.2349machine # [ 77.498580] systemd[1]: Stopping Reactivate sysinit units...2350machine # [ 77.499372] systemd[1]: Reached target Reactivate sysinit units.2351machine # [ 77.504666] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2352machine # [ 77.506098] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2353machine # [ 77.508492] systemd[1]: Reached target Remote File Systems.2354machine # [ 77.510973] systemd[1]: Reached target Local File Systems.2355machine # [ 77.515117] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2356machine # [ 77.522339] systemd[1]: Starting Create SUID/SGID Wrappers...2357machine # [ 77.523227] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2358machine # [ 77.529107] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672359machine # [ 77.531326] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2360machine # [ 77.534918] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2361machine # [ 77.536274] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2362machine # [ 77.681732] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2363machine # [ 77.686186] systemd[1]: Finished Create SUID/SGID Wrappers.2364machine # [ 77.688287] systemd[1]: Starting linger-users.service...2365machine # [ 77.726194] systemd[1]: linger-users.service: Deactivated successfully.2366machine # [ 77.729129] systemd[1]: Finished linger-users.service.2367machine # [ 77.983016] nixos[5449]: finished switching to system configuration /nix/store/m8kqkf8v6s3vka995prjp55r4scg2wq7-nixos-system-machine-test2368machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.71 seconds)2369machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&12370machine # [ 78.199150] nixos[5589]: switching to system configuration /nix/store/bk16lyhhcmr4z92mz9ss9fxxjwxrmhvs-nixos-system-machine-test2371machine # [ 78.201910] systemd[1]: Stopped target Remote File Systems.2372machine # [ 78.203548] systemd[1]: Stopped target Local File Systems.2373machine # [ 78.468235] systemd[1]: Reload requested from client PID 5589 ('.switch-to-conf') (unit backdoor.service)...2374machine # [ 78.470119] systemd[1]: Reloading...2375machine # [ 78.775480] systemd[1]: Reloading finished in 303 ms.2376machine # [ 78.858484] systemd[550]: Reexecution requested from client PID 5658 ('switch-to-confi')...2377machine # [ 78.862516] systemd[550]: Reexecuting.2378machine # [ 78.918990] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2379machine # [ 79.027002] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2380machine # [ 79.033852] systemd[550]: Reload requested from client PID 5658 ('switch-to-confi')...2381machine # [ 79.035179] systemd[550]: Reloading...2382machine # [ 79.136737] systemd[550]: Reloading finished in 100 ms.2383machine # [ 79.152148] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2384machine # [ 79.160855] systemd[550]: Stopped Run user-specific NixOS activation.2385machine # [ 79.163241] systemd[550]: Stopping Run user-specific NixOS activation...2386machine # [ 79.165218] systemd[550]: Starting Run user-specific NixOS activation...2387machine # [ 79.193414] systemd[550]: Finished Run user-specific NixOS activation.2388machine # [ 79.197039] systemd[1]: Stopped target Reactivate sysinit units.2389machine # [ 79.198891] systemd[1]: Stopping Reactivate sysinit units...2390machine # [ 79.199727] systemd[1]: Reached target Reactivate sysinit units.2391machine # [ 79.203250] systemd[1]: test.service: Deactivated successfully.2392machine # [ 79.204354] systemd[1]: Stopped test.service.2393machine # [ 79.205011] systemd[1]: Stopping test.service...2394machine # [ 79.206596] systemd[1]: Starting test.service...2395machine # [ 79.227095] systemd[1]: Finished test.service.2396machine # [ 79.231575] systemd[1]: Reached target Remote File Systems.2397machine # [ 79.235420] systemd[1]: Starting linger-users.service...2398machine # [ 79.240532] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2399machine # [ 79.241927] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2400machine # [ 79.248118] systemd[1]: Reached target Local File Systems.2401machine # [ 79.249993] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2402machine # [ 79.256116] systemd[1]: Starting Create SUID/SGID Wrappers...2403machine # [ 79.256977] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2404machine # [ 79.258288] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672405machine # [ 79.275086] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2406machine # [ 79.278389] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2407machine # [ 79.279679] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2408machine # [ 79.315446] systemd[1]: linger-users.service: Deactivated successfully.2409machine # [ 79.320373] systemd[1]: Finished linger-users.service.2410machine # [ 79.445962] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2411machine # [ 79.448981] systemd[1]: Finished Create SUID/SGID Wrappers.2412machine # [ 79.704425] nixos[5589]: finished switching to system configuration /nix/store/bk16lyhhcmr4z92mz9ss9fxxjwxrmhvs-nixos-system-machine-test2413machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.72 seconds)2414machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&12415machine # [ 79.922412] nixos[5731]: switching to system configuration /nix/store/b31bx232lb6np76bzhqjwdim29ic98ln-nixos-system-machine-test2416machine # [ 79.925299] systemd[1]: Stopped target Remote File Systems.2417machine # [ 79.927491] systemd[1]: Stopped target Local File Systems.2418machine # [ 80.187899] systemd[1]: Reload requested from client PID 5731 ('.switch-to-conf') (unit backdoor.service)...2419machine # [ 80.189969] systemd[1]: Reloading...2420machine # [ 80.491568] systemd[1]: Reloading finished in 300 ms.2421machine # [ 80.579775] systemd[550]: Reexecution requested from client PID 5800 ('switch-to-confi')...2422machine # [ 80.583411] systemd[550]: Reexecuting.2423machine # [ 80.630933] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2424machine # [ 80.737216] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2425machine # [ 80.743882] systemd[550]: Reload requested from client PID 5800 ('switch-to-confi')...2426machine # [ 80.747406] systemd[550]: Reloading...2427machine # [ 80.848898] systemd[550]: Reloading finished in 102 ms.2428machine # [ 80.865634] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2429machine # [ 80.873618] systemd[550]: Stopped Run user-specific NixOS activation.2430machine # [ 80.875736] systemd[550]: Stopping Run user-specific NixOS activation...2431machine # [ 80.877890] systemd[550]: Starting Run user-specific NixOS activation...2432machine # [ 80.905740] systemd[550]: Finished Run user-specific NixOS activation.2433machine # [ 80.909501] systemd[1]: Stopped target Reactivate sysinit units.2434machine # [ 80.912345] systemd[1]: Stopping Reactivate sysinit units...2435machine # [ 80.913240] systemd[1]: Reached target Reactivate sysinit units.2436machine # [ 80.914160] systemd[1]: test.service: Deactivated successfully.2437machine # [ 80.916925] systemd[1]: Stopped test.service.2438machine # [ 80.917677] systemd[1]: Stopping test.service...2439machine # [ 80.919250] systemd[1]: Starting test.service...2440machine # [ 80.943990] systemd[1]: Finished test.service.2441machine # [ 80.946660] systemd[1]: Reached target Local File Systems.2442machine # [ 80.949786] systemd[1]: Reached target Remote File Systems.2443machine # [ 80.956927] systemd[1]: Starting linger-users.service...2444machine # [ 80.962543] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2445machine # [ 80.972399] systemd[1]: Starting Create SUID/SGID Wrappers...2446machine # [ 80.973259] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2447machine # [ 80.974495] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672448machine # [ 80.982406] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2449machine # [ 80.983997] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2450machine # [ 80.985272] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2451machine # [ 80.986529] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2452machine # [ 80.987773] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2453machine # [ 81.040619] systemd[1]: linger-users.service: Deactivated successfully.2454machine # [ 81.043622] systemd[1]: Finished linger-users.service.2455machine # [ 81.163873] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2456machine # [ 81.166851] systemd[1]: Finished Create SUID/SGID Wrappers.2457machine # [ 81.422225] nixos[5731]: finished switching to system configuration /nix/store/b31bx232lb6np76bzhqjwdim29ic98ln-nixos-system-machine-test2458machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.72 seconds)2459machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&12460machine # [ 81.670429] nixos[5873]: switching to system configuration /nix/store/hf7rrvv9drs21hzdcqsw9xsf6mfkar4d-nixos-system-machine-test2461machine # [ 81.672946] systemd[1]: Stopped target Local File Systems.2462machine # [ 81.675355] systemd[1]: Stopped target Remote File Systems.2463machine # [ 81.935204] systemd[1]: Reload requested from client PID 5873 ('.switch-to-conf') (unit backdoor.service)...2464machine # [ 81.937262] systemd[1]: Reloading...2465machine # [ 82.240190] systemd[1]: Reloading finished in 301 ms.2466machine # [ 82.320609] systemd[550]: Reexecution requested from client PID 5942 ('switch-to-confi')...2467machine # [ 82.324931] systemd[550]: Reexecuting.2468machine # [ 82.379160] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2469machine # [ 82.488421] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2470machine # [ 82.494729] systemd[550]: Reload requested from client PID 5942 ('switch-to-confi')...2471machine # [ 82.498155] systemd[550]: Reloading...2472machine # [ 82.599873] systemd[550]: Reloading finished in 102 ms.2473machine # [ 82.616148] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2474machine # [ 82.626807] systemd[550]: Stopped Run user-specific NixOS activation.2475machine # [ 82.629018] systemd[550]: Stopping Run user-specific NixOS activation...2476machine # [ 82.630995] systemd[550]: Starting Run user-specific NixOS activation...2477machine # [ 82.661211] systemd[550]: Finished Run user-specific NixOS activation.2478machine # [ 82.664769] systemd[1]: Stopped target Reactivate sysinit units.2479machine # [ 82.666770] systemd[1]: Stopping Reactivate sysinit units...2480machine # [ 82.667626] systemd[1]: Reached target Reactivate sysinit units.2481machine # [ 82.670958] systemd[1]: test.service: Deactivated successfully.2482machine # [ 82.671817] systemd[1]: Stopped test.service.2483machine # [ 82.672811] systemd[1]: Stopping test.service...2484machine # [ 82.674867] systemd[1]: Starting test.service...2485machine # [ 82.694873] systemd[1]: Finished test.service.2486machine # [ 82.697297] systemd[1]: Reached target Remote File Systems.2487machine # [ 82.702236] systemd[1]: Reached target Local File Systems.2488machine # [ 82.703101] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2489machine # [ 82.706668] systemd[1]: Starting Create SUID/SGID Wrappers...2490machine # [ 82.707556] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2491machine # [ 82.715998] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672492machine # [ 82.718598] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2493machine # [ 82.725065] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2494machine # [ 82.726398] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2495machine # [ 82.727593] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2496machine # [ 82.731798] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2497machine # [ 82.875593] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2498machine # [ 82.880220] systemd[1]: Finished Create SUID/SGID Wrappers.2499machine # [ 82.882219] systemd[1]: Starting linger-users.service...2500machine # [ 82.917680] systemd[1]: linger-users.service: Deactivated successfully.2501machine # [ 82.920228] systemd[1]: Finished linger-users.service.2502machine # [ 83.175342] nixos[5873]: finished switching to system configuration /nix/store/hf7rrvv9drs21hzdcqsw9xsf6mfkar4d-nixos-system-machine-test2503machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 1.75 seconds)2504machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12505machine # [ 83.376930] nixos[6015]: switching to system configuration /nix/store/cbsymq7lb09snni660gz9vpbjxjplvzp-nixos-system-machine-test2506machine # [ 83.379661] systemd[1]: Stopped target Remote File Systems.2507machine # [ 83.382550] systemd[1]: Stopped target Local File Systems.2508machine # [ 83.631925] systemd[1]: Reload requested from client PID 6015 ('.switch-to-conf') (unit backdoor.service)...2509machine # [ 83.634316] systemd[1]: Reloading...2510machine # [ 83.931753] systemd[1]: Reloading finished in 295 ms.2511machine # [ 84.016088] systemd[550]: Reexecution requested from client PID 6083 ('switch-to-confi')...2512machine # [ 84.017511] systemd[550]: Reexecuting.2513machine # [ 84.075024] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2514machine # [ 84.185959] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2515machine # [ 84.191955] systemd[550]: Reload requested from client PID 6083 ('switch-to-confi')...2516machine # [ 84.195427] systemd[550]: Reloading...2517machine # [ 84.297417] systemd[550]: Reloading finished in 102 ms.2518machine # [ 84.312145] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2519machine # [ 84.320949] systemd[550]: Stopped Run user-specific NixOS activation.2520machine # [ 84.323157] systemd[550]: Stopping Run user-specific NixOS activation...2521machine # [ 84.325170] systemd[550]: Starting Run user-specific NixOS activation...2522machine # [ 84.353429] systemd[550]: Finished Run user-specific NixOS activation.2523machine # [ 84.357158] systemd[1]: Stopped target Reactivate sysinit units.2524machine # [ 84.358933] systemd[1]: Stopping Reactivate sysinit units...2525machine # [ 84.359771] systemd[1]: Reached target Reactivate sysinit units.2526machine # [ 84.363382] systemd[1]: test.service: Deactivated successfully.2527machine # [ 84.364538] systemd[1]: Stopped test.service.2528machine # [ 84.365178] systemd[1]: Stopping test.service...2529machine # [ 84.366782] systemd[1]: Starting test.service...2530machine # [ 84.387438] systemd[1]: Finished test.service.2531machine # [ 84.391214] systemd[1]: Reached target Remote File Systems.2532machine # [ 84.399130] systemd[1]: Starting linger-users.service...2533machine # [ 84.401782] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2534machine # [ 84.408626] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2535machine # [ 84.414427] systemd[1]: Reached target Local File Systems.2536machine # [ 84.415275] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2537machine # [ 84.423137] systemd[1]: Starting Create SUID/SGID Wrappers...2538machine # [ 84.424001] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2539machine # [ 84.425338] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672540machine # [ 84.427563] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2541machine # [ 84.436556] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2542machine # [ 84.437928] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2543machine # [ 84.480110] systemd[1]: linger-users.service: Deactivated successfully.2544machine # [ 84.483553] systemd[1]: Finished linger-users.service.2545machine # [ 84.602463] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2546machine # [ 84.605320] systemd[1]: Finished Create SUID/SGID Wrappers.2547machine # [ 84.860356] nixos[6015]: finished switching to system configuration /nix/store/cbsymq7lb09snni660gz9vpbjxjplvzp-nixos-system-machine-test2548machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.68 seconds)2549machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&12550machine # [ 85.075430] nixos[6157]: switching to system configuration /nix/store/0awp9qx60h9sjqjdimlx39q54f6qd3cn-nixos-system-machine-test2551machine # [ 85.077911] systemd[1]: Stopped target Local File Systems.2552machine # [ 85.080185] systemd[1]: Stopped target Remote File Systems.2553machine # [ 85.340152] systemd[1]: Reload requested from client PID 6157 ('.switch-to-conf') (unit backdoor.service)...2554machine # [ 85.342066] systemd[1]: Reloading...2555machine # [ 85.646874] systemd[1]: Reloading finished in 303 ms.2556machine # [ 85.734121] systemd[550]: Reexecution requested from client PID 6226 ('switch-to-confi')...2557machine # [ 85.735527] systemd[550]: Reexecuting.2558machine # [ 85.799888] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2559machine # [ 85.912108] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2560machine # [ 85.918190] systemd[550]: Reload requested from client PID 6226 ('switch-to-confi')...2561machine # [ 85.921478] systemd[550]: Reloading...2562machine # [ 86.020425] systemd[550]: Reloading finished in 99 ms.2563machine # [ 86.036138] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2564machine # [ 86.046305] systemd[550]: Stopped Run user-specific NixOS activation.2565machine # [ 86.047355] systemd[550]: Stopping Run user-specific NixOS activation...2566machine # [ 86.050239] systemd[550]: Starting Run user-specific NixOS activation...2567machine # [ 86.073572] systemd[550]: Finished Run user-specific NixOS activation.2568machine # [ 86.077169] systemd[1]: Stopped target Reactivate sysinit units.2569machine # [ 86.078530] systemd[1]: Stopping Reactivate sysinit units...2570machine # [ 86.079354] systemd[1]: Reached target Reactivate sysinit units.2571machine # [ 86.084607] systemd[1]: Reloading test.service...2572machine # [ 86.107297] systemd[1]: Reloaded test.service.2573machine # [ 86.111639] systemd[1]: Reached target Remote File Systems.2574machine # [ 86.115476] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2575machine # [ 86.124445] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2576machine # [ 86.125802] systemd[1]: Starting linger-users.service...2577machine # [ 86.126564] systemd[1]: Reached target Local File Systems.2578machine # [ 86.127341] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2579machine # [ 86.142074] systemd[1]: Starting Create SUID/SGID Wrappers...2580machine # [ 86.142937] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2581machine # [ 86.149574] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672582machine # [ 86.151813] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2583machine # [ 86.162439] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2584machine # [ 86.166050] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2585machine # [ 86.199048] systemd[1]: linger-users.service: Deactivated successfully.2586machine # [ 86.202161] systemd[1]: Finished linger-users.service.2587machine # [ 86.325203] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2588machine # [ 86.328794] systemd[1]: Finished Create SUID/SGID Wrappers.2589machine # [ 86.582624] nixos[6157]: finished switching to system configuration /nix/store/0awp9qx60h9sjqjdimlx39q54f6qd3cn-nixos-system-machine-test2590machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.72 seconds)2591machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&12592machine # [ 86.797755] nixos[6299]: switching to system configuration /nix/store/hpk2mzvh7brxrym1sq988qv67vfddiwq-nixos-system-machine-test2593machine # [ 86.800492] systemd[1]: Stopped target Local File Systems.2594machine # [ 86.802880] systemd[1]: Stopped target Remote File Systems.2595machine # [ 87.066642] systemd[1]: Reload requested from client PID 6299 ('.switch-to-conf') (unit backdoor.service)...2596machine # [ 87.068585] systemd[1]: Reloading...2597machine # [ 87.370516] systemd[1]: Reloading finished in 300 ms.2598machine # [ 87.455234] systemd[550]: Reexecution requested from client PID 6368 ('switch-to-confi')...2599machine # [ 87.457209] systemd[550]: Reexecuting.2600machine # [ 87.514982] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2601machine # [ 87.622669] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2602machine # [ 87.629345] systemd[550]: Reload requested from client PID 6368 ('switch-to-confi')...2603machine # [ 87.630651] systemd[550]: Reloading...2604machine # [ 87.733806] systemd[550]: Reloading finished in 100 ms.2605machine # [ 87.748135] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2606machine # [ 87.756730] systemd[550]: Stopped Run user-specific NixOS activation.2607machine # [ 87.758879] systemd[550]: Stopping Run user-specific NixOS activation...2608machine # [ 87.760907] systemd[550]: Starting Run user-specific NixOS activation...2609machine # [ 87.788841] systemd[550]: Finished Run user-specific NixOS activation.2610machine # [ 87.792388] systemd[1]: Stopped target Reactivate sysinit units.2611machine # [ 87.796353] systemd[1]: Stopping Reactivate sysinit units...2612machine # [ 87.797222] systemd[1]: Reached target Reactivate sysinit units.2613machine # [ 87.799149] systemd[1]: Reloading test.service...2614machine # [ 87.819491] systemd[1]: Reloaded test.service.2615machine # [ 87.823415] systemd[1]: Reached target Local File Systems.2616machine # [ 87.826747] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2617machine # [ 87.835172] systemd[1]: Starting Create SUID/SGID Wrappers...2618machine # [ 87.836503] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2619machine # [ 87.837787] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672620machine # [ 87.839946] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2621machine # [ 87.846259] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2622machine # [ 87.847564] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2623machine # [ 87.853512] systemd[1]: Reached target Remote File Systems.2624machine # [ 87.854378] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2625machine # [ 87.856277] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2626machine # [ 87.996129] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2627machine # [ 88.000513] systemd[1]: Finished Create SUID/SGID Wrappers.2628machine # [ 88.002740] systemd[1]: Starting linger-users.service...2629machine # [ 88.042200] systemd[1]: linger-users.service: Deactivated successfully.2630machine # [ 88.044597] systemd[1]: Finished linger-users.service.2631machine # [ 88.300088] nixos[6299]: finished switching to system configuration /nix/store/hpk2mzvh7brxrym1sq988qv67vfddiwq-nixos-system-machine-test2632machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.72 seconds)2633machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&12634machine # [ 88.518713] nixos[6441]: switching to system configuration /nix/store/m89va0dbm4lz17aqzj7p0mfpbpr46r8j-nixos-system-machine-test2635machine # [ 88.523691] systemd[1]: Stopped target Remote File Systems.2636machine # [ 88.526001] systemd[1]: Stopped target Local File Systems.2637machine # [ 88.788307] systemd[1]: Reload requested from client PID 6441 ('.switch-to-conf') (unit backdoor.service)...2638machine # [ 88.789879] systemd[1]: Reloading...2639machine # [ 89.092654] systemd[1]: Reloading finished in 301 ms.2640machine # [ 89.174378] systemd[550]: Reexecution requested from client PID 6510 ('switch-to-confi')...2641machine # [ 89.175776] systemd[550]: Reexecuting.2642machine # [ 89.235582] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2643machine # [ 89.346484] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2644machine # [ 89.353362] systemd[550]: Reload requested from client PID 6510 ('switch-to-confi')...2645machine # [ 89.354747] systemd[550]: Reloading...2646machine # [ 89.457467] systemd[550]: Reloading finished in 101 ms.2647machine # [ 89.472158] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2648machine # [ 89.481137] systemd[550]: Stopped Run user-specific NixOS activation.2649machine # [ 89.483439] systemd[550]: Stopping Run user-specific NixOS activation...2650machine # [ 89.485589] systemd[550]: Starting Run user-specific NixOS activation...2651machine # [ 89.514387] systemd[550]: Finished Run user-specific NixOS activation.2652machine # [ 89.518681] systemd[1]: Stopped target Reactivate sysinit units.2653machine # [ 89.519642] systemd[1]: Stopping Reactivate sysinit units...2654machine # [ 89.520784] systemd[1]: Reached target Reactivate sysinit units.2655machine # [ 89.524391] systemd[1]: test.service: Deactivated successfully.2656machine # [ 89.525313] systemd[1]: Stopped test.service.2657machine # [ 89.525976] systemd[1]: Stopping test.service...2658machine # [ 89.527988] systemd[1]: Starting test.service...2659machine # [ 89.552112] systemd[1]: Finished test.service.2660machine # [ 89.558829] systemd[1]: Reached target Remote File Systems.2661machine # [ 89.562857] systemd[1]: Starting linger-users.service...2662machine # [ 89.571121] systemd[1]: Reached target Local File Systems.2663machine # [ 89.575371] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2664machine # [ 89.584797] systemd[1]: Starting Create SUID/SGID Wrappers...2665machine # [ 89.585761] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2666machine # [ 89.591689] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672667machine # [ 89.595772] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2668machine # [ 89.600562] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2669machine # [ 89.601936] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2670machine # [ 89.608967] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2671machine # [ 89.610350] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2672machine # [ 89.643931] systemd[1]: linger-users.service: Deactivated successfully.2673machine # [ 89.647860] systemd[1]: Finished linger-users.service.2674machine # [ 89.772606] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2675machine # [ 89.775353] systemd[1]: Finished Create SUID/SGID Wrappers.2676machine # [ 90.030866] nixos[6441]: finished switching to system configuration /nix/store/m89va0dbm4lz17aqzj7p0mfpbpr46r8j-nixos-system-machine-test2677machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.73 seconds)2678machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&12679machine # [ 90.231720] nixos[6583]: switching to system configuration /nix/store/bk16lyhhcmr4z92mz9ss9fxxjwxrmhvs-nixos-system-machine-test2680machine # [ 90.234749] systemd[1]: Stopped target Local File Systems.2681machine # [ 90.237347] systemd[1]: Stopped target Remote File Systems.2682machine # [ 90.480781] systemd[1]: Reload requested from client PID 6583 ('.switch-to-conf') (unit backdoor.service)...2683machine # [ 90.482710] systemd[1]: Reloading...2684machine # [ 90.774348] systemd[1]: Reloading finished in 290 ms.2685machine # [ 90.861815] systemd[550]: Reexecution requested from client PID 6651 ('switch-to-confi')...2686machine # [ 90.865179] systemd[550]: Reexecuting.2687machine # [ 90.923115] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2688machine # [ 91.034993] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2689machine # [ 91.041218] systemd[550]: Reload requested from client PID 6651 ('switch-to-confi')...2690machine # [ 91.043463] systemd[550]: Reloading...2691machine # [ 91.145147] systemd[550]: Reloading finished in 100 ms.2692machine # [ 91.160145] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2693machine # [ 91.169887] systemd[550]: Stopped Run user-specific NixOS activation.2694machine # [ 91.170836] systemd[550]: Stopping Run user-specific NixOS activation...2695machine # [ 91.173528] systemd[550]: Starting Run user-specific NixOS activation...2696machine # [ 91.201022] systemd[550]: Finished Run user-specific NixOS activation.2697machine # [ 91.204552] systemd[1]: Stopped target Reactivate sysinit units.2698machine # [ 91.207288] systemd[1]: Stopping Reactivate sysinit units...2699machine # [ 91.209831] systemd[1]: Reached target Reactivate sysinit units.2700machine # [ 91.210706] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2701machine # [ 91.211974] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2702machine # [ 91.215383] systemd[1]: Reached target Remote File Systems.2703machine # [ 91.218646] systemd[1]: Reached target Local File Systems.2704machine # [ 91.222665] systemd[1]: Starting linger-users.service...2705machine # [ 91.232162] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2706machine # [ 91.240735] systemd[1]: Starting Create SUID/SGID Wrappers...2707machine # [ 91.241672] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2708machine # [ 91.242891] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672709machine # [ 91.252536] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2710machine # [ 91.254185] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2711machine # [ 91.262491] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2712machine # [ 91.295851] systemd[1]: linger-users.service: Deactivated successfully.2713machine # [ 91.297798] systemd[1]: Finished linger-users.service.2714machine # [ 91.421984] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2715machine # [ 91.424306] systemd[1]: Finished Create SUID/SGID Wrappers.2716machine # [ 91.679570] nixos[6583]: finished switching to system configuration /nix/store/bk16lyhhcmr4z92mz9ss9fxxjwxrmhvs-nixos-system-machine-test2717machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.65 seconds)2718(finished: subtest: unit file parser, in 22.34 seconds)2719subtest: restart and reload by activation script2720machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&12721machine # [ 91.881586] nixos[6723]: switching to system configuration /nix/store/3gx66a8k8b55mc1w5735vb0aiykd2nqw-nixos-system-machine-test2722machine # [ 91.884059] systemd[1]: Stopped target Remote File Systems.2723machine # [ 91.886773] systemd[1]: Stopped target Local File Systems.2724machine # [ 92.134521] systemd[1]: Reload requested from client PID 6723 ('.switch-to-conf') (unit backdoor.service)...2725machine # [ 92.136461] systemd[1]: Reloading...2726machine # [ 92.430247] systemd[1]: Reloading finished in 292 ms.2727machine # [ 92.513400] systemd[550]: Reexecution requested from client PID 6792 ('switch-to-confi')...2728machine # [ 92.517313] systemd[550]: Reexecuting.2729machine # [ 92.575034] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2730machine # [ 92.686646] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2731machine # [ 92.693095] systemd[550]: Reload requested from client PID 6792 ('switch-to-confi')...2732machine # [ 92.696083] systemd[550]: Reloading...2733machine # [ 92.798875] systemd[550]: Reloading finished in 103 ms.2734machine # [ 92.816163] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2735machine # [ 92.826284] systemd[550]: Stopped Run user-specific NixOS activation.2736machine # [ 92.827238] systemd[550]: Stopping Run user-specific NixOS activation...2737machine # [ 92.829872] systemd[550]: Starting Run user-specific NixOS activation...2738machine # [ 92.857213] systemd[550]: Finished Run user-specific NixOS activation.2739machine # [ 92.860844] systemd[1]: Stopped target Reactivate sysinit units.2740machine # [ 92.863134] systemd[1]: Stopping Reactivate sysinit units...2741machine # [ 92.865179] systemd[1]: Reached target Reactivate sysinit units.2742machine # [ 92.867800] systemd[1]: Reached target Remote File Systems.2743machine # [ 92.870885] systemd[1]: Reached target Local File Systems.2744machine # [ 92.874405] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2745machine # [ 92.875767] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2746machine # [ 92.880654] systemd[1]: Starting linger-users.service...2747machine # [ 92.883396] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2748machine # [ 92.891255] systemd[1]: Starting Create SUID/SGID Wrappers...2749machine # [ 92.899233] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2750machine # [ 92.900775] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672751machine # [ 92.903019] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2752machine # [ 92.904849] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2753machine # [ 92.906200] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2754machine # [ 92.960981] systemd[1]: linger-users.service: Deactivated successfully.2755machine # [ 92.963216] systemd[1]: Finished linger-users.service.2756machine # [ 93.081637] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2757machine # [ 93.084340] systemd[1]: Finished Create SUID/SGID Wrappers.2758machine # [ 93.340050] nixos[6723]: finished switching to system configuration /nix/store/3gx66a8k8b55mc1w5735vb0aiykd2nqw-nixos-system-machine-test2759machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.66 seconds)2760machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12761machine # [ 93.551722] nixos[6863]: switching to system configuration /nix/store/5b02nzd0pwz2459gd6prmii9rv94fipl-nixos-system-machine-test2762machine # [ 93.554607] systemd[1]: Stopped target Remote File Systems.2763machine # [ 93.558076] systemd[1]: test.service: Deactivated successfully.2764machine # [ 93.559620] systemd[1]: Stopped test.service.2765machine # [ 93.561214] systemd[1]: Stopped target Local File Systems.2766machine # [ 93.830122] systemd[1]: Reload requested from client PID 6863 ('.switch-to-conf') (unit backdoor.service)...2767machine # [ 93.832004] systemd[1]: Reloading...2768machine # [ 94.145760] systemd[1]: Reloading finished in 311 ms.2769machine # [ 94.228408] systemd[550]: Reexecution requested from client PID 6934 ('switch-to-confi')...2770machine # [ 94.229857] systemd[550]: Reexecuting.2771machine # [ 94.291076] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2772machine # [ 94.403039] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2773machine # [ 94.409232] systemd[550]: Reload requested from client PID 6934 ('switch-to-confi')...2774machine # [ 94.412151] systemd[550]: Reloading...2775machine # [ 94.513848] systemd[550]: Reloading finished in 102 ms.2776machine # [ 94.528155] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2777machine # [ 94.537071] systemd[550]: Stopped Run user-specific NixOS activation.2778machine # [ 94.539251] systemd[550]: Stopping Run user-specific NixOS activation...2779machine # [ 94.541282] systemd[550]: Starting Run user-specific NixOS activation...2780machine # [ 94.570096] systemd[550]: Finished Run user-specific NixOS activation.2781machine # [ 94.574163] systemd[1]: Stopped target Reactivate sysinit units.2782machine # [ 94.576758] systemd[1]: Stopping Reactivate sysinit units...2783machine # [ 94.577702] systemd[1]: Reached target Reactivate sysinit units.2784machine # [ 94.578586] systemd[1]: Reached target Remote File Systems.2785machine # [ 94.584458] systemd[1]: Created slice Slice /system/templated-no-restart-service.2786machine # [ 94.588100] systemd[1]: Starting templated-no-restart-service@instance.service...2787machine # [ 94.602170] systemd[1]: Created slice Slice /system/templated-simple-reload-service.2788machine # [ 94.606498] systemd[1]: Starting templated-simple-reload-service@instance.service...2789machine # [ 94.617283] systemd[1]: Created slice Slice /system/templated-reload-triggers.2790machine # [ 94.618485] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart.2791machine # [ 94.637669] systemd[1]: Starting linger-users.service...2792machine # [ 94.638512] systemd[1]: Starting reload-triggers-and-restart.service...2793machine # [ 94.639422] systemd[1]: Starting reload-triggers.service...2794machine # [ 94.664907] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2795machine # [ 94.666230] systemd[1]: Starting templated-reload-triggers@instance.service...2796machine # [ 94.700964] systemd[1]: Starting simple-reload-service.service...2797machine # [ 94.702072] systemd[1]: Created slice Slice /system/templated-simple-service.2798machine # [ 94.703169] systemd[1]: Starting templated-simple-service@instance.service...2799machine # [ 94.750737] systemd[1]: Starting no-restart-service.service...2800machine # [ 94.751673] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2801machine # [ 94.785520] systemd[1]: Finished templated-no-restart-service@instance.service.2802machine # [ 94.786711] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2803machine # [ 94.834252] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2804machine # [ 94.861719] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as.2805machine # [ 94.877028] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2806machine # [ 94.892251] systemd[1]: Reached target Local File Systems.2807machine # [ 94.901137] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2808machine # [ 94.911792] systemd[1]: Starting Create SUID/SGID Wrappers...2809machine # [ 94.920175] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2810machine # [ 94.921571] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672811machine # [ 94.923764] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2812machine # [ 94.933902] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2813machine # [ 94.935210] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2814machine # [ 94.941542] systemd[1]: Created slice Slice /system/templated-simple-restart-service.2815machine # [ 94.942640] systemd[1]: Finished templated-simple-reload-service@instance.service.2816machine # [ 94.943662] systemd[1]: Finished reload-triggers-and-restart.service.2817machine # [ 94.951725] systemd[1]: Finished reload-triggers.service.2818machine # [ 94.953670] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2819machine # [ 94.954794] systemd[1]: Finished templated-reload-triggers@instance.service.2820machine # [ 94.955754] systemd[1]: Finished simple-reload-service.service.2821machine # [ 94.957151] systemd[1]: Finished templated-simple-service@instance.service.2822machine # [ 94.959442] systemd[1]: Finished no-restart-service.service.2823machine # [ 94.961500] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2824machine # [ 94.962518] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2825machine # [ 94.963669] systemd[1]: linger-users.service: Deactivated successfully.2826machine # [ 94.966409] systemd[1]: Finished linger-users.service.2827machine # [ 95.084528] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2828machine # [ 95.088380] systemd[1]: Finished Create SUID/SGID Wrappers.2829machine # [ 95.091854] systemd[1]: Starting simple-restart-service.service...2830machine # [ 95.095905] systemd[1]: Starting simple-service.service...2831machine # [ 95.103743] systemd[1]: Starting templated-simple-restart-service@instance.service...2832machine # [ 95.146609] systemd[1]: Finished simple-restart-service.service.2833machine # [ 95.149356] systemd[1]: Finished simple-service.service.2834machine # [ 95.150179] systemd[1]: Finished templated-simple-restart-service@instance.service.2835machine # [ 95.403938] nixos[6863]: finished switching to system configuration /nix/store/5b02nzd0pwz2459gd6prmii9rv94fipl-nixos-system-machine-test2836machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.06 seconds)2837machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12838machine # [ 95.640191] nixos[7033]: switching to system configuration /nix/store/5b02nzd0pwz2459gd6prmii9rv94fipl-nixos-system-machine-test2839machine # [ 95.642961] systemd[1]: Stopped target Local File Systems.2840machine # [ 95.645690] systemd[1]: Stopped target Remote File Systems.2841machine # [ 95.913336] systemd[1]: Reload requested from client PID 7033 ('.switch-to-conf') (unit backdoor.service)...2842machine # [ 95.915227] systemd[1]: Reloading...2843machine # [ 96.227823] systemd[1]: Reloading finished in 311 ms.2844machine # [ 96.316578] systemd[550]: Reexecution requested from client PID 7104 ('switch-to-confi')...2845machine # [ 96.318942] systemd[550]: Reexecuting.2846machine # [ 96.374948] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2847machine # [ 96.481893] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2848machine # [ 96.488572] systemd[550]: Reload requested from client PID 7104 ('switch-to-confi')...2849machine # [ 96.491889] systemd[550]: Reloading...2850machine # [ 96.592466] systemd[550]: Reloading finished in 101 ms.2851machine # [ 96.609513] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2852machine # [ 96.617622] systemd[550]: Stopped Run user-specific NixOS activation.2853machine # [ 96.618648] systemd[550]: Stopping Run user-specific NixOS activation...2854machine # [ 96.621273] systemd[550]: Starting Run user-specific NixOS activation...2855machine # [ 96.649142] systemd[550]: Finished Run user-specific NixOS activation.2856machine # [ 96.652944] systemd[1]: Stopped target Reactivate sysinit units.2857machine # [ 96.655922] systemd[1]: Stopping Reactivate sysinit units...2858machine # [ 96.659232] systemd[1]: Reached target Reactivate sysinit units.2859machine # [ 96.661534] systemd[1]: Reloading reload-triggers-and-restart.service...2860machine # [ 96.666202] systemd[1]: Reloading reload-triggers.service...2861machine # [ 96.676076] systemd[1]: Reloading simple-reload-service.service...2862machine # [ 96.678340] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service...2863machine # [ 96.696412] systemd[1]: Reloading templated-reload-triggers@instance.service...2864machine # [ 96.703969] systemd[1]: Reloading templated-simple-reload-service@instance.service...2865machine # [ 96.761956] systemd[1]: Reloaded reload-triggers-and-restart.service.2866machine # [ 96.765016] systemd[1]: Reloaded reload-triggers.service.2867machine # [ 96.770449] systemd[1]: Reloaded simple-reload-service.service.2868machine # [ 96.771355] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service.2869machine # [ 96.775098] systemd[1]: Reloaded templated-reload-triggers@instance.service.2870machine # [ 96.780142] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2871machine # [ 96.784158] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2872machine # [ 96.785348] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2873machine # [ 96.786399] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2874machine # [ 96.791965] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2875machine # [ 96.793275] systemd[1]: simple-restart-service.service: Deactivated successfully.2876machine # [ 96.794410] systemd[1]: Stopped simple-restart-service.service.2877machine # [ 96.795255] systemd[1]: Stopping simple-restart-service.service...2878machine # [ 96.800609] systemd[1]: Starting simple-restart-service.service...2879machine # [ 96.801555] systemd[1]: simple-service.service: Deactivated successfully.2880machine # [ 96.802491] systemd[1]: Stopped simple-service.service.2881machine # [ 96.803237] systemd[1]: Stopping simple-service.service...2882machine # [ 96.807873] systemd[1]: Starting simple-service.service...2883machine # [ 96.816684] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2884machine # [ 96.818085] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2885machine # [ 96.819236] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2886machine # [ 96.840250] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2887machine # [ 96.841524] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2888machine # [ 96.842795] systemd[1]: Stopped templated-simple-restart-service@instance.service.2889machine # [ 96.843820] systemd[1]: Stopping templated-simple-restart-service@instance.service...2890machine # [ 96.866650] systemd[1]: Starting templated-simple-restart-service@instance.service...2891machine # [ 96.867790] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2892machine # [ 96.884503] systemd[1]: Stopped templated-simple-service@instance.service.2893machine # [ 96.893909] systemd[1]: Stopping templated-simple-service@instance.service...2894machine # [ 96.908303] systemd[1]: Starting templated-simple-service@instance.service...2895machine # [ 96.919932] systemd[1]: Finished simple-service.service.2896machine # [ 96.927809] systemd[1]: Finished simple-restart-service.service.2897machine # [ 96.936465] systemd[1]: Finished templated-simple-restart-service@instance.service.2898machine # [ 96.937668] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2899machine # [ 96.938624] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2900machine # [ 96.939768] systemd[1]: Finished templated-simple-service@instance.service.2901machine # [ 96.944406] systemd[1]: Reached target Remote File Systems.2902machine # [ 96.945230] systemd[1]: Reached target Local File Systems.2903machine # [ 96.946014] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2904machine # [ 96.947477] systemd[1]: Starting Create SUID/SGID Wrappers...2905machine # [ 96.957191] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2906machine # [ 96.958594] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672907machine # [ 96.964785] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2908machine # [ 96.966448] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2909machine # [ 96.967727] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2910machine # [ 96.970704] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2911machine # [ 96.974868] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2912machine # [ 97.108458] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2913machine # [ 97.109562] systemd[1]: Finished Create SUID/SGID Wrappers.2914machine # [ 97.111387] systemd[1]: Starting linger-users.service...2915machine # [ 97.149615] systemd[1]: linger-users.service: Deactivated successfully.2916machine # [ 97.152639] systemd[1]: Finished linger-users.service.2917machine # [ 97.406659] nixos[7033]: finished switching to system configuration /nix/store/5b02nzd0pwz2459gd6prmii9rv94fipl-nixos-system-machine-test2918machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.00 seconds)2919machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&12920machine # [ 97.664578] nixos[7199]: switching to system configuration /nix/store/cwiiny4vcb3j8j82392ss7yzv0qrrdmr-nixos-system-machine-test2921machine # [ 97.667286] systemd[1]: Stopped target Remote File Systems.2922machine # [ 97.669455] systemd[1]: Stopped target Local File Systems.2923machine # [ 97.956627] systemd[1]: Reload requested from client PID 7199 ('.switch-to-conf') (unit backdoor.service)...2924machine # [ 97.958561] systemd[1]: Reloading...2925machine # [ 98.283262] systemd[1]: Reloading finished in 323 ms.2926machine # [ 98.375274] systemd[550]: Reexecution requested from client PID 7270 ('switch-to-confi')...2927machine # [ 98.378983] systemd[550]: Reexecuting.2928machine # [ 98.439207] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2929machine # [ 98.549738] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2930machine # [ 98.556345] systemd[550]: Reload requested from client PID 7270 ('switch-to-confi')...2931machine # [ 98.558676] systemd[550]: Reloading...2932machine # [ 98.661008] systemd[550]: Reloading finished in 101 ms.2933machine # [ 98.676141] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2934machine # [ 98.685113] systemd[550]: Stopped Run user-specific NixOS activation.2935machine # [ 98.687341] systemd[550]: Stopping Run user-specific NixOS activation...2936machine # [ 98.689373] systemd[550]: Starting Run user-specific NixOS activation...2937machine # [ 98.718215] systemd[550]: Finished Run user-specific NixOS activation.2938machine # [ 98.722101] systemd[1]: Stopped target Reactivate sysinit units.2939machine # [ 98.723020] systemd[1]: Stopping Reactivate sysinit units...2940machine # [ 98.723816] systemd[1]: Reached target Reactivate sysinit units.2941machine # [ 98.729615] systemd[1]: Reloading reload-triggers.service...2942machine # [ 98.738457] systemd[1]: Reloading simple-reload-service.service...2943machine # [ 98.745711] systemd[1]: Reloading templated-reload-triggers@instance.service...2944machine # [ 98.755158] systemd[1]: Reloading templated-simple-reload-service@instance.service...2945machine # [ 98.781290] systemd[1]: Reloaded reload-triggers.service.2946machine # [ 98.805965] systemd[1]: Reloaded simple-reload-service.service.2947machine # [ 98.808232] systemd[1]: Reloaded templated-reload-triggers@instance.service.2948machine # [ 98.810690] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2949machine # [ 98.816348] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2950machine # [ 98.817605] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2951machine # [ 98.818600] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2952machine # [ 98.826755] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2953machine # [ 98.827798] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully.2954machine # [ 98.833725] systemd[1]: Stopped reload-triggers-and-restart.service.2955machine # [ 98.834692] systemd[1]: Stopping reload-triggers-and-restart.service...2956machine # [ 98.835597] systemd[1]: Starting reload-triggers-and-restart.service...2957machine # [ 98.863643] systemd[1]: simple-restart-service.service: Deactivated successfully.2958machine # [ 98.869845] systemd[1]: Stopped simple-restart-service.service.2959machine # [ 98.870739] systemd[1]: Stopping simple-restart-service.service...2960machine # [ 98.871625] systemd[1]: Starting simple-restart-service.service...2961machine # [ 98.898607] systemd[1]: simple-service.service: Deactivated successfully.2962machine # [ 98.899617] systemd[1]: Stopped simple-service.service.2963machine # [ 98.916144] systemd[1]: Stopping simple-service.service...2964machine # [ 98.929494] systemd[1]: Starting simple-service.service...2965machine # [ 98.940198] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2966machine # [ 98.961190] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2967machine # [ 98.971377] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2968machine # [ 98.977674] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2969machine # [ 98.979038] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully.2970machine # [ 98.988365] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service.2971machine # [ 98.991203] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service...2972machine # [ 98.998308] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2973machine # [ 98.999477] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2974machine # [ 99.000839] systemd[1]: Stopped templated-simple-restart-service@instance.service.2975machine # [ 99.001880] systemd[1]: Stopping templated-simple-restart-service@instance.service...2976machine # [ 99.002935] systemd[1]: Starting templated-simple-restart-service@instance.service...2977machine # [ 99.003986] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2978machine # [ 99.016925] systemd[1]: Stopped templated-simple-service@instance.service.2979machine # [ 99.017985] systemd[1]: Stopping templated-simple-service@instance.service...2980machine # [ 99.018956] systemd[1]: Starting templated-simple-service@instance.service...2981machine # [ 99.019932] systemd[1]: Finished reload-triggers-and-restart.service.2982machine # [ 99.027711] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2983machine # [ 99.036458] systemd[1]: Finished simple-restart-service.service.2984machine # [ 99.037364] systemd[1]: Finished simple-service.service.2985machine # [ 99.041776] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2986machine # [ 99.047165] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2987machine # [ 99.050950] systemd[1]: Finished templated-simple-restart-service@instance.service.2988machine # [ 99.053834] systemd[1]: Finished templated-simple-service@instance.service.2989machine # [ 99.054831] systemd[1]: Reached target Remote File Systems.2990machine # [ 99.055651] systemd[1]: Starting linger-users.service...2991machine # [ 99.061222] systemd[1]: Reached target Local File Systems.2992machine # [ 99.062072] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2993machine # [ 99.063520] systemd[1]: Starting Create SUID/SGID Wrappers...2994machine # [ 99.068261] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2995machine # [ 99.069542] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672996machine # [ 99.071700] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2997machine # [ 99.084197] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2998machine # [ 99.085504] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2999machine # [ 99.086695] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os3000machine # [ 99.087972] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki3001machine # [ 99.100636] systemd[1]: linger-users.service: Deactivated successfully.3002machine # [ 99.103240] systemd[1]: Finished linger-users.service.3003machine # [ 99.226587] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.3004machine # [ 99.229553] systemd[1]: Finished Create SUID/SGID Wrappers.3005machine # [ 99.485881] nixos[7199]: finished switching to system configuration /nix/store/cwiiny4vcb3j8j82392ss7yzv0qrrdmr-nixos-system-machine-test3006machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.08 seconds)3007machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&13008machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.32 seconds)3009(finished: subtest: restart and reload by activation script, in 8.13 seconds)3010(finished: run the VM test script, in 102.16 seconds)3011test script finished in 102.19s3012cleanup3013kill QemuMachine (pid 45)3014machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14)3015machine # [2026-10-01T03:47:51Z INFO virtiofsd] Client disconnected, shutting down3016machine # [2026-10-01T03:47:51Z INFO virtiofsd] Client disconnected, shutting down3017machine # [2026-10-01T03:47:51Z INFO virtiofsd] Client disconnected, shutting down3018(finished: cleanup, in 0.15 seconds)3019additionally exposed symbols:3020 machine, other,3021 vlan1,3022 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh