vm-test-run-switch-test-services
checks.aarch64-linux.switchTest
· build #64
· raw
1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7machine: waiting for unit multi-user.target8machine: waiting for the VM to finish booting9machine: starting vm10machine: QEMU running (pid 45)11machine # Disk image does not exist, creating the virtualisation disk image...12machine # Formatting '/build/vm-state-machine/tmp.D9OPpsN01Z', 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: 46ffe815-2156-426f-8d85-6001848781d317machine # 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-22T02:58:16Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)28machine # [2026-10-22T02:58:16Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether29machine # [2026-10-22T02:58:16Z INFO virtiofsd] Waiting for vhost-user socket connection...30machine # [2026-10-22T02:58:16Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)31machine # [2026-10-22T02:58:16Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether32machine # [2026-10-22T02:58:16Z INFO virtiofsd] Waiting for vhost-user socket connection...33machine # [2026-10-22T02:58:16Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)34machine # [2026-10-22T02:58:16Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether35machine # [2026-10-22T02:58:16Z INFO virtiofsd] Waiting for vhost-user socket connection...36machine # [2026-10-22T02:58:16Z INFO virtiofsd] Client connected, servicing requests37machine # [2026-10-22T02:58:16Z INFO virtiofsd] Client connected, servicing requests38machine # [2026-10-22T02:58:16Z INFO virtiofsd] Client connected, servicing requests39machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]40machine # [ 0.000000] Linux version 6.18.57 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT @179205830041machine # [ 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 s187672 r8192 d115432 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/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/init regInfo=/nix/.ro-store/wjpb50m56229pl1hkl556g44mfvv3aww-closure-info/registration console=ttyAMA0,115200n8 console=tty074machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/wjpb50m56229pl1hkl556g44mfvv3aww-closure-info/registration", will be passed to user space.75machine # [ 0.000000] printk: log buffer data + meta data: 1048576 + 3670016 = 4718592 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 75301 entries in 296 pages88machine # [ 0.000000] ftrace: allocated 296 pages with 3 groups89machine # [ 0.000000] rcu: Hierarchical RCU implementation.90machine # [ 0.000000] rcu: RCU event tracing is enabled.91machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1.92machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.93machine # [ 0.000000] Rude variant of Tasks RCU enabled.94machine # [ 0.000000] Tracing variant of Tasks RCU enabled.95machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.96machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=197machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.98machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.99machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.100machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0101machine # [ 0.000000] GICv3: 256 SPIs implemented102machine # [ 0.000000] GICv3: 0 Extended SPIs implemented103machine # [ 0.000000] Root IRQ handler: gic_handle_irq104machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI105machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0106machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000107machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]108machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @450e0000 (indirect, esz 8, psz 64K, shr 1)109machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @450f0000 (flat, esz 8, psz 64K, shr 1)110machine # [ 0.000000] GICv3: using LPI property table @0x0000000045100000111machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000045110000112machine # [ 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.000038] arm-pv: using stolen time PV118machine # [ 0.000434] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)119machine # [ 0.000615] Console: colour dummy device 80x25120machine # [ 0.000624] printk: legacy console [tty0] enabled121machine # [ 0.000835] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)122machine # [ 0.000842] pid_max: default: 32768 minimum: 301123machine # [ 0.000939] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima124machine # [ 0.001078] landlock: Up and running.125machine # [ 0.001082] Yama: becoming mindful.126machine # [ 0.001548] LSM support for eBPF active127machine # [ 0.001679] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)128machine # [ 0.001701] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)129machine # [ 0.003771] rcu: Hierarchical SRCU implementation.130machine # [ 0.003778] rcu: Max phase no-delay instances is 1000.131machine # [ 0.005229] fsl-mc MSI: its@8080000 domain created132machine # [ 0.005363] EFI services will not be available.133machine # [ 0.005518] smp: Bringing up secondary CPUs ...134machine # [ 0.005530] smp: Brought up 1 node, 1 CPU135machine # [ 0.005534] SMP: Total of 1 processors activated.136machine # [ 0.005536] CPU: All CPU(s) started at EL1137machine # [ 0.005549] CPU features: detected: Branch Target Identification138machine # [ 0.005554] CPU features: detected: ARMv8.4 Translation Table Level139machine # [ 0.005557] CPU features: detected: Instruction cache invalidation not required for I/D coherence140machine # [ 0.005560] CPU features: detected: Data cache clean to the PoU not required for I/D coherence141machine # [ 0.005569] CPU features: detected: Common not Private translations142machine # [ 0.005573] CPU features: detected: CRC32 instructions143machine # [ 0.005576] CPU features: detected: Data cache clean to Point of Deep Persistence144machine # [ 0.005579] CPU features: detected: Data cache clean to Point of Persistence145machine # [ 0.005582] CPU features: detected: Data independent timing control (DIT)146machine # [ 0.005585] CPU features: detected: E0PD147machine # [ 0.005588] CPU features: detected: Enhanced Counter Virtualization148machine # [ 0.005591] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)149machine # [ 0.005594] CPU features: detected: Enhanced Virtualization Traps150machine # [ 0.005598] CPU features: detected: Fine Grained Traps151machine # [ 0.005602] CPU features: detected: Generic authentication (architected QARMA5 algorithm)152machine # [ 0.005607] CPU features: detected: RCpc load-acquire (LDAPR)153machine # [ 0.005610] CPU features: detected: LSE atomic instructions154machine # [ 0.005613] CPU features: detected: Privileged Access Never155machine # [ 0.005616] CPU features: detected: PMUv3156machine # [ 0.005618] CPU features: detected: RAS Extension Support157machine # [ 0.005621] CPU features: detected: RASv1p1 Extension Support158machine # [ 0.005624] CPU features: detected: Random Number Generator159machine # [ 0.005630] CPU features: detected: Speculation barrier (SB)160machine # [ 0.005633] CPU features: detected: Stage-2 Force Write-Back161machine # [ 0.005636] CPU features: detected: TLB range maintenance instructions162machine # [ 0.005641] CPU features: detected: Speculative Store Bypassing Safe (SSBS)163machine # [ 0.005680] alternatives: applying system-wide alternatives164machine # [ 0.009057] CPU features: detected: BBM Level 2 without TLB conflict abort165machine # [ 0.009257] Memory: 886656K/1048576K available (24640K kernel code, 10246K rwdata, 26664K rodata, 7808K init, 2086K bss, 120628K reserved, 32768K cma-reserved)166machine # [ 0.009709] devtmpfs: initialized167machine # [ 0.011645] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)168machine # [ 0.011672] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).169machine # [ 0.011865] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL170machine # [ 0.011870] 0 pages in range for non-PLT usage171machine # [ 0.011871] 506368 pages in range for PLT usage172machine # [ 0.012010] pinctrl core: initialized pinctrl subsystem173machine # [ 0.012894] DMI not present or invalid.174machine # [ 0.016509] NET: Registered PF_NETLINK/PF_ROUTE protocol family175machine # [ 0.019159] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations176machine # [ 0.019345] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations177machine # [ 0.019529] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations178machine # [ 0.019557] audit: initializing netlink subsys (disabled)179machine # [ 0.020225] thermal_sys: Registered thermal governor 'fair_share'180machine # [ 0.020228] thermal_sys: Registered thermal governor 'bang_bang'181machine # [ 0.020232] thermal_sys: Registered thermal governor 'step_wise'182machine # [ 0.020235] thermal_sys: Registered thermal governor 'user_space'183machine # [ 0.020238] thermal_sys: Registered thermal governor 'power_allocator'184machine # [ 0.020267] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1185machine # [ 0.020276] cpuidle: using governor ladder186machine # [ 0.020282] cpuidle: using governor menu187machine # [ 0.020481] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.188machine # [ 0.020499] ASID allocator initialised with 65536 entries189machine # [ 0.021913] Serial: AMBA PL011 UART driver190machine # [ 0.027963] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1191machine # [ 0.028171] printk: console [ttyAMA0] enabled192machine # [ 0.157172] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages193machine # [ 0.157185] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page194machine # [ 0.157189] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages195machine # [ 0.157192] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page196machine # [ 0.157194] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages197machine # [ 0.157197] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page198machine # [ 0.157200] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages199machine # [ 0.157203] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page200machine # [ 0.158541] fbcon: Taking over console201machine # [ 0.158553] ACPI: Interpreter disabled.202machine # [ 0.168360] iommu: Default domain type: Translated203machine # [ 0.168366] iommu: DMA domain TLB invalidation policy: strict mode204machine # [ 0.168867] SCSI subsystem initialized205machine # [ 0.170978] usbcore: registered new interface driver usbfs206machine # [ 0.171020] usbcore: registered new interface driver hub207machine # [ 0.171042] usbcore: registered new device driver usb208machine # [ 0.171375] pps_core: LinuxPPS API ver. 1 registered209machine # [ 0.171379] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>210machine # [ 0.171388] PTP clock support registered211machine # [ 0.171444] EDAC MC: Ver: 3.0.0212machine # [ 0.177786] scmi_core: SCMI protocol bus registered213machine # [ 0.178208] FPGA manager framework214machine # [ 0.181322] vgaarb: loaded215machine # [ 0.183058] clocksource: Switched to clocksource arch_sys_counter216machine # [ 0.189482] VFS: Disk quotas dquot_6.6.0217machine # [ 0.189517] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)218machine # [ 0.192844] netfs: FS-Cache loaded219machine # [ 0.192984] pnp: PnP ACPI: disabled220machine # [ 0.197998] NET: Registered PF_INET protocol family221machine # [ 0.198158] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)222machine # [ 0.230746] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)223machine # [ 0.230792] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)224machine # [ 0.230819] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)225machine # [ 0.230865] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)226machine # [ 0.230939] TCP: Hash tables configured (established 8192 bind 8192)227machine # [ 0.231033] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)228machine # [ 0.237023] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)229machine # [ 0.237075] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)230machine # [ 0.237163] NET: Registered PF_UNIX/PF_LOCAL protocol family231machine # [ 0.237216] NET: Registered PF_XDP protocol family232machine # [ 0.237235] PCI: CLS 0 bytes, default 64233machine # [ 0.237519] Trying to unpack rootfs image as initramfs...234machine # [ 0.243616] kvm [1]: HYP mode not available235machine # [ 0.355319] Initialise system trusted keyrings236machine # [ 0.355374] Key type blacklist registered237machine # [ 0.360362] workingset: timestamp_bits=42 max_order=18 bucket_order=0238machine # [ 0.360864] squashfs: version 4.0 (2009/01/31) Phillip Lougher239machine # [ 0.360920] 9p: Installing v9fs 9p2000 file system support240machine # [ 0.361031] integrity: Platform Keyring initialized241machine # [ 0.361043] integrity: Machine keyring initialized242machine # [ 0.384550] Key type asymmetric registered243machine # [ 0.384567] Asymmetric key parser 'x509' registered244machine # [ 0.384658] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)245machine # [ 0.389341] io scheduler mq-deadline registered246machine # [ 0.389352] io scheduler kyber registered247machine # [ 0.402350] pl061_gpio 9030000.pl061: PL061 GPIO chip registered248machine # [ 0.402999] ledtrig-cpu: registered to indicate activity on CPUs249machine # [ 0.405053] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:250machine # [ 0.405068] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000251machine # [ 0.405082] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000252machine # [ 0.405089] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000253machine # [ 0.405108] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits254machine # [ 0.405132] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]255machine # [ 0.405214] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00256machine # [ 0.405222] pci_bus 0000:00: root bus resource [bus 00-ff]257machine # [ 0.405227] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]258machine # [ 0.405230] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]259machine # [ 0.405233] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]260machine # [ 0.405292] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint261machine # [ 0.405755] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint262machine # [ 0.405944] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]263machine # [ 0.405956] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]264machine # [ 0.405983] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]265machine # [ 0.405996] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]266machine # [ 0.406472] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint267machine # [ 0.406659] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]268machine # [ 0.406671] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]269machine # [ 0.406697] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]270machine # [ 0.435305] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint271machine # [ 0.435543] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]272machine # [ 0.435557] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]273machine # [ 0.435584] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]274machine # [ 0.436145] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint275machine # [ 0.436342] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]276machine # [ 0.436354] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]277machine # [ 0.436381] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]278machine # [ 0.436394] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]279machine # [ 0.436863] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint280machine # [ 0.437053] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]281machine # [ 0.437079] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]282machine # [ 0.437543] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint283machine # [ 0.437733] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]284machine # [ 0.437760] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]285machine # [ 0.438166] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint286machine # [ 0.438348] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]287machine # [ 0.438636] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint288machine # [ 0.438826] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]289machine # [ 0.438852] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]290machine # [ 0.456813] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint291machine # [ 0.457010] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]292machine # [ 0.457037] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]293machine # [ 0.457511] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint294machine # [ 0.457702] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]295machine # [ 0.457731] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]296machine # [ 0.458215] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint297machine # [ 0.458527] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]298machine # [ 0.458545] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]299machine # [ 0.458571] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]300machine # [ 0.459054] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint301machine # [ 0.469261] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]302machine # [ 0.469277] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]303machine # [ 0.469310] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]304machine # [ 0.470001] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned305machine # [ 0.470008] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned306machine # [ 0.470011] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned307machine # [ 0.470060] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned308machine # [ 0.470112] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned309machine # [ 0.470158] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned310machine # [ 0.470202] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned311machine # [ 0.470251] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned312machine # [ 0.470295] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned313machine # [ 0.470340] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned314machine # [ 0.470384] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned315machine # [ 0.470428] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned316machine # [ 0.470518] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned317machine # [ 0.470561] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned318machine # [ 0.470579] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned319machine # [ 0.470597] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned320machine # [ 0.470615] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned321machine # [ 0.470632] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned322machine # [ 0.470650] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned323machine # [ 0.470668] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned324machine # [ 0.470687] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned325machine # [ 0.470706] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned326machine # [ 0.470724] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned327machine # [ 0.470742] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned328machine # [ 0.470761] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned329machine # [ 0.470778] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned330machine # [ 0.470796] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned331machine # [ 0.470813] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned332machine # [ 0.470830] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned333machine # [ 0.470848] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned334machine # [ 0.470866] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned335machine # [ 0.470891] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]336machine # [ 0.470896] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]337machine # [ 0.470899] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]338machine # [ 0.511957] pci 0000:00:07.0: enabling device (0000 -> 0002)339machine # [ 0.534868] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)340machine # [ 0.545797] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)341machine # [ 0.548885] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)342machine # [ 0.550780] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)343machine # [ 0.560542] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)344machine # [ 0.562728] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)345machine # [ 0.572507] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)346machine # [ 0.574315] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)347machine # [ 0.578094] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)348machine # [ 0.587642] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)349machine # [ 0.590094] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)350machine # [ 0.604532] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled351machine # [ 0.606540] msm_serial: driver initialized352machine # [ 0.606678] SuperH (H)SCI(F) driver initialized353machine # [ 0.606740] STM32 USART driver initialized354machine # [ 0.645571] loop: module loaded355machine # [ 0.645776] virtio_blk virtio2: 1/0/0 default/read/poll queues356machine # [ 0.646645] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)357machine # [ 0.659948] megasas: 07.734.00.00-rc1358machine # [ 0.660811] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]359machine # [ 0.662896] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000360machine # [ 0.662916] Intel/Sharp Extended Query Table at 0x0031361machine # [ 0.668458] Using buffer write method362machine # [ 0.668534] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]363machine # [ 0.670130] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000364machine # [ 0.670193] Intel/Sharp Extended Query Table at 0x0031365machine # [ 0.685562] Using buffer write method366machine # [ 0.685592] Concatenating MTD devices:367machine # [ 0.685594] (0): "0.flash"368machine # [ 0.685597] (1): "0.flash"369machine # [ 0.685599] into device "0.flash"370machine # [ 0.996701] Freeing initrd memory: 26088K371machine # [ 1.003654] tun: Universal TUN/TAP device driver, 1.6372machine # [ 1.006870] thunder_xcv, ver 1.0373machine # [ 1.006899] thunder_bgx, ver 1.0374machine # [ 1.006920] nicpf, ver 1.0375machine # [ 1.009590] e1000: Intel(R) PRO/1000 Network Driver376machine # [ 1.009596] e1000: Copyright (c) 1999-2006 Intel Corporation.377machine # [ 1.009627] e1000e: Intel(R) PRO/1000 Network Driver378machine # [ 1.009636] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.379machine # [ 1.009663] igb: Intel(R) Gigabit Ethernet Network Driver380machine # [ 1.009666] igb: Copyright (c) 2007-2014 Intel Corporation.381machine # [ 1.009688] igbvf: Intel(R) Gigabit Virtual Function Network Driver382machine # [ 1.009692] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.383machine # [ 1.009840] sky2: driver version 1.30384machine # [ 1.018018] usbcore: registered new interface driver usb-storage385machine # [ 1.018134] usbcore: registered new interface driver usbserial_generic386machine # [ 1.018146] usbserial: USB Serial support registered for generic387machine # [ 1.018821] hv_vmbus: registering driver hyperv_keyboard388machine # [ 1.022788] ehci-pci 0000:00:07.0: EHCI Host Controller389machine # [ 1.022818] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1390machine # [ 1.022996] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000391machine # [ 1.026340] rtc-pl031 9010000.pl031: registered as rtc0392machine # [ 1.026365] rtc-pl031 9010000.pl031: setting system clock to 2026-10-22T02:58:17 UTC (1792637897)393machine # [ 1.026696] i2c_dev: i2c /dev entries driver394machine # [ 1.032656] sdhci: Secure Digital Host Controller Interface driver395machine # [ 1.032662] sdhci: Copyright(c) Pierre Ossman396machine # [ 1.032966] Synopsys Designware Multimedia Card Interface Driver397machine # [ 1.033369] sdhci-pltfm: SDHCI platform and OF driver helper398machine # [ 1.037933] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00399machine # [ 1.038289] hub 1-0:1.0: USB hub found400machine # [ 1.038305] hub 1-0:1.0: 6 ports detected401machine # [ 1.038739] hid: raw HID events driver (C) Jiri Kosina402machine # [ 1.039023] usbcore: registered new interface driver usbhid403machine # [ 1.039027] usbhid: USB HID core driver404machine # [ 1.044065] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available405machine # [ 1.045815] drop_monitor: Initializing network drop monitor service406machine # [ 1.045981] NET: Registered PF_INET6 protocol family407machine # [ 1.046586] Segment Routing with IPv6408machine # [ 1.046598] In-situ OAM (IOAM) with IPv6409machine # [ 1.046625] NET: Registered PF_PACKET protocol family410machine # [ 1.046710] 9pnet: Installing 9P2000 support411machine # [ 1.046753] Key type dns_resolver registered412machine # [ 1.058872] registered taskstats version 1413machine # [ 1.059040] Loading compiled-in X.509 certificates414machine # [ 1.068272] Demotion targets for Node 0: null415machine # [ 1.068396] Key type .fscrypt registered416machine # [ 1.068399] Key type fscrypt-provisioning registered417machine # [ 1.068505] ima: No TPM chip found, activating TPM-bypass!418machine # [ 1.068528] ima: Allocated hash algorithm: sha1419machine # [ 1.068558] ima: No architecture policies found420machine # [ 1.069345] input: gpio-keys as /devices/platform/gpio-keys/input/input0421machine # [ 1.093775] clk: Disabling unused clocks422machine # [ 1.093796] PM: genpd: Disabling unused power domains423machine # [ 1.099899] Freeing unused kernel memory: 7808K424machine # [ 1.100108] Run /init as init process425machine # [ 1.118585] fuse: module verification failed: signature and/or required key missing - tainting kernel426machine # [ 1.122803] fuse: init (API version 7.45)427machine # [ 1.126433] virtiofs virtio6: discovered new tag: nix-store428machine # [ 1.128154] virtiofs virtio6: virtio_fs_setup_dax: No cache capability429machine # [ 1.144843] virtiofs virtio7: discovered new tag: shared430machine # [ 1.145763] virtiofs virtio7: virtio_fs_setup_dax: No cache capability431machine # [ 1.148660] virtiofs virtio8: discovered new tag: xchg432machine # [ 1.149421] virtiofs virtio8: virtio_fs_setup_dax: No cache capability433machine # [ 1.162118] systemd[1]: Successfully made /usr/ read-only.434machine # [ 1.162699] systemd[1]: systemd 263-558da31 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR)435machine # [ 1.162715] systemd[1]: Detected virtualization qemu.436machine # [ 1.162737] systemd[1]: Detected architecture arm64.437machine # [ 1.162743] systemd[1]: Running in initrd.438machine # [ 1.163034] systemd[1]: Initializing machine ID from random generator.439machine # [ 1.171171] systemd[1]: Hostname set to <machine>.440machine # [ 1.270092] systemd[1]: bpf-restrict-fs: LSM BPF program attached441machine # [ 1.287239] usb 1-1: new high-speed USB device number 2 using ehci-pci442machine # [ 1.332102] systemd[1]: Queued start job for default target Initrd Default Target.443machine # [ 1.341524] systemd[1]: Created slice Slice /system/modprobe.444machine # [ 1.341739] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.445machine # [ 1.341771] systemd[1]: Expecting device /dev/disk/by-label/nixos...446machine # [ 1.341796] systemd[1]: Reached target Path Units.447machine # [ 1.341811] systemd[1]: Reached target Slice Units.448machine # [ 1.341827] systemd[1]: Reached target Swaps.449machine # [ 1.341841] systemd[1]: Reached target Timer Units.450machine # [ 1.342008] systemd[1]: Listening on D-Bus System Message Bus Socket.451machine # [ 1.342178] systemd[1]: Listening on Journal Socket (/dev/log).452machine # [ 1.342339] systemd[1]: Listening on Journal Sockets.453machine # [ 1.342415] systemd[1]: Listening on udev Kernel Socket.454machine # [ 1.342573] systemd[1]: Listening on udev Varlink Socket.455machine # [ 1.342612] systemd[1]: Reached target Socket Units.456machine # [ 1.354098] systemd[1]: Starting Create List of Static Device Nodes...457machine # [ 1.354190] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs458machine # [ 1.360300] systemd[1]: Mounting Kernel Configuration File System...459machine # [ 1.374906] systemd[1]: Starting Journal Service...460machine # [ 1.387669] systemd[1]: Starting Load Kernel Modules...461machine # [ 1.387837] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os462machine # [ 1.419431] systemd[1]: Starting Coldplug All udev Devices...463machine # [ 1.426909] systemd-journald[71]: Collecting audit messages is disabled.464machine # [ 1.428325] systemd[1]: Finished Create List of Static Device Nodes.465machine # [ 1.450138] 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/input1466machine # [ 1.467866] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...467machine # [ 1.468785] systemd[1]: Mounted Kernel Configuration File System.468machine # [ 1.543470] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0469machine # [ 1.544615] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.470machine # [ 1.546547] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.471machine # [ 1.546781] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev472machine # [ 1.553374] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0473machine # [ 1.553650] [drm] features: -virgl +edid -resource_blob -host_visible474machine # [ 1.553659] [drm] features: -context_init475machine # [ 1.554461] [drm] number of scanouts: 1476machine # [ 1.554485] [drm] number of cap sets: 0477machine # [ 1.564030] systemd[1]: Starting Create Static Device Nodes in /dev...478machine # [ 1.583740] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic479machine # [ 1.583758] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0480machine # [ 1.619472] Console: switching to colour frame buffer device 160x50481machine # [ 1.614029] systemd-modules-load[73]: Inserted module 'dm_mod'482machine # [ 1.631495] systemd[1]: Started Journal Service.483machine # [ 1.637791] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device484machine # [ 1.627133] systemd-modules-load[73]: Module 'virtio_balloon' is built in485machine # [ 1.629110] systemd-modules-load[73]: Module 'virtio_console' is built in486machine # [ 1.636632] systemd[1]: Finished Create Static Device Nodes in /dev.487machine # [ 1.640399] systemd[1]: Reached target Preparation for Local File Systems.488machine # [ 1.649917] systemd[1]: Reached target Local File Systems.489machine # [ 1.651042] systemd-modules-load[73]: Inserted module 'virtio_gpu'490machine # [ 1.667122] usb 1-2: new high-speed USB device number 3 using ehci-pci491machine # [ 1.654670] systemd-modules-load[73]: Module 'virtio_rng' is built in492machine # [ 1.656392] systemd[1]: Starting Create System Files and Directories...493machine # [ 1.664159] systemd[1]: Starting Rule-based Manager for Device Events and Files...494machine # [ 1.665736] systemd[1]: Finished Load Kernel Modules.495machine # [ 1.690629] systemd[1]: Starting Apply Kernel Variables...496machine # [ 1.725070] systemd[1]: Finished Create System Files and Directories.497machine # [ 1.749373] systemd[1]: Finished Apply Kernel Variables.498machine # [ 1.769955] systemd-udevd[79]: Using default interface naming scheme 'v261'.499machine # [ 1.818955] 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/input2500machine # [ 1.824396] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0501machine # [ 1.813013] systemd[1]: Started Rule-based Manager for Device Events and Files.502machine # [ 1.913478] systemd[1]: Starting Virtual Console Setup...503machine # [ 2.001587] systemd-vconsole-setup[98]: Configuration of first virtual console was skipped, ignoring remaining ones.504machine # [ 2.005688] systemd[1]: Finished Virtual Console Setup.505machine # [ 2.717613] (udev-worker)[104]: Network interface NamePolicy= disabled on kernel command line.506machine # [ 2.730574] systemd[1]: Finished Coldplug All udev Devices.507machine # [ 2.731548] systemd[1]: Reached target System Initialization.508machine # [ 2.732559] systemd[1]: Reached target Basic System.509machine # [ 2.751135] (udev-worker)[91]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.510machine # [ 2.756388] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line.511machine # [ 2.767939] systemd[1]: Found device /dev/disk/by-label/nixos.512machine # [ 2.772194] systemd[1]: Reached target Initrd Root Device.513machine # [ 2.775547] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...514machine # [ 2.827846] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks515machine # [ 2.835985] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.516machine # [ 2.839328] systemd[1]: Mounting /sysroot...517machine # [ 2.900529] EXT4-fs (vda): mounted filesystem 46ffe815-2156-426f-8d85-6001848781d3 r/w with ordered data mode. Quota mode: none.518machine # [ 2.889935] systemd[1]: Mounted /sysroot.519machine # [ 2.892569] systemd[1]: Reached target Initrd Root File System.520machine # [ 2.895959] systemd[1]: Starting Mountpoints Configured in the Real Root...521machine # [ 2.936536] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload.522machine # [ 2.940935] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)...523machine # [ 2.945466] systemd[1]: Reloading...524machine # [ 3.150650] systemd[1]: Reloading finished in 206 ms.525machine # [ 3.187718] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace...526machine # [ 3.193192] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace...527machine # [ 3.198872] systemd[1]: initrd-parse-etc.service: Deactivated successfully.528machine # [ 3.202499] systemd[1]: Finished Mountpoints Configured in the Real Root.529machine # [ 3.205466] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.530machine # [ 3.407772] systemd[1]: Mounting /sysroot/nix/.ro-store...531machine # [ 3.419783] systemd[1]: Mounting /sysroot/nix/.rw-store...532machine # [ 3.434411] systemd[1]: Mounting /sysroot/run...533machine # [ 3.451992] systemd[1]: Mounting /sysroot/tmp/shared...534machine # [ 3.483373] systemd[1]: Mounting /sysroot/tmp/xchg...535machine # [ 3.522726] systemd[1]: Mounted /sysroot/nix/.rw-store.536machine # [ 3.539892] systemd[1]: Mounted /sysroot/nix/.ro-store.537machine # [ 3.542478] systemd[1]: Mounted /sysroot/run.538machine # [ 3.562308] systemd[1]: Mounted /sysroot/tmp/shared.539machine # [ 3.573268] systemd[1]: Starting rw-sysroot-nix-store.service...540machine # [ 3.578884] systemd[1]: Mounted /sysroot/tmp/xchg.541machine # [ 3.610040] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.542machine # [ 3.611571] systemd[1]: Finished rw-sysroot-nix-store.service.543machine # [ 4.075347] (udev-worker)[103]: mtd0ro: Failed to find and pin callout binary "/nix/store/2y5k9a77439362ij1h4pbjx5g55dn8d2-systemd-263-558da31/lib/udev/mtd_probe": No such file or directory544machine # [ 4.082035] (udev-worker)[103]: mtd0ro: /etc/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory545machine # [ 4.112945] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.546machine # [ 4.115407] systemd[1]: Stopped Virtual Console Setup.547machine # [ 4.116883] systemd[1]: Stopping Virtual Console Setup...548machine # [ 4.120308] systemd[1]: Starting Virtual Console Setup...549machine # [ 4.147960] systemd-vconsole-setup[150]: Configuration of first virtual console was skipped, ignoring remaining ones.550machine # [ 4.151949] systemd[1]: Finished Virtual Console Setup.551machine # [ 4.406728] systemd[1]: Mounting /sysroot/nix/store...552machine # [ 4.453311] systemd[1]: Mounted /sysroot/nix/store.553machine # [ 4.455912] systemd[1]: Reached target Initrd File Systems.554machine # [ 4.460861] systemd[1]: Starting Find NixOS closure...555machine # [ 4.472516] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...556machine # [ 4.514634] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.557machine # [ 4.517390] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.558machine # [ 4.531936] systemd[1]: Finished Find NixOS closure.559machine # [ 4.535236] systemd[1]: Reached target Initrd Default Target.560machine # [ 4.537356] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...561machine # [ 4.568891] systemd[1]: Stopped target Initrd Default Target.562machine # [ 4.572904] systemd[1]: Stopped target Basic System.563machine # [ 4.573941] systemd[1]: Stopped target Initrd Root Device.564machine # [ 4.575434] systemd[1]: Stopped target Path Units.565machine # [ 4.578626] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.566machine # [ 4.580484] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.567machine # [ 4.584888] systemd[1]: Stopped target Slice Units.568machine # [ 4.588866] systemd[1]: Stopped target Socket Units.569machine # [ 4.590663] systemd[1]: Stopped target System Initialization.570machine # [ 4.593484] systemd[1]: Stopped target Swaps.571machine # [ 4.596249] systemd[1]: Stopped target Timer Units.572machine # [ 4.601377] systemd[1]: dbus.socket: Deactivated successfully.573machine # [ 4.602371] systemd[1]: Closed D-Bus System Message Bus Socket.574machine # [ 4.604432] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.575machine # [ 4.607885] systemd[1]: Stopped Find NixOS closure.576machine # [ 4.612247] systemd[1]: Starting rw-sysroot-nix-store.service...577machine # [ 4.614512] systemd[1]: systemd-sysctl.service: Deactivated successfully.578machine # [ 4.615632] systemd[1]: Stopped Apply Kernel Variables.579machine # [ 4.616627] systemd[1]: systemd-modules-load.service: Deactivated successfully.580machine # [ 4.617681] systemd[1]: Stopped Load Kernel Modules.581machine # [ 4.618439] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.582machine # [ 4.619582] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.583machine # [ 4.626901] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.584machine # [ 4.631769] systemd[1]: Stopped Create System Files and Directories.585machine # [ 4.637061] systemd[1]: Stopped target Local File Systems.586machine # [ 4.637943] systemd[1]: Stopped target Preparation for Local File Systems.587machine # [ 4.638903] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.588machine # [ 4.639912] systemd[1]: Stopped Coldplug All udev Devices.589machine # [ 4.644490] systemd[1]: Stopping Rule-based Manager for Device Events and Files...590machine # [ 4.647099] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.591machine # [ 4.648229] systemd[1]: Stopped Virtual Console Setup.592machine # [ 4.649789] systemd[1]: systemd-udevd.service: Deactivated successfully.593machine # [ 4.652464] systemd[1]: Stopped Rule-based Manager for Device Events and Files.594machine # [ 4.654228] systemd[1]: systemd-udevd.service: Consumed 1.381s CPU time over 2.962s wall clock time, 25.4M memory peak.595machine # [ 4.655782] systemd[1]: initrd-cleanup.service: Deactivated successfully.596machine # [ 4.656936] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.597machine # [ 4.657889] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully.598machine # [ 4.658918] systemd[1]: Closed udev Varlink Socket.599machine # [ 4.659632] systemd[1]: Starting Cleanup udev Database...600machine # [ 4.665371] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.601machine # [ 4.668363] systemd[1]: Stopped Create Static Device Nodes in /dev.602machine # [ 4.672687] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.603machine # [ 4.674081] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.604machine # [ 4.675151] systemd[1]: kmod-static-nodes.service: Deactivated successfully.605machine # [ 4.680175] systemd[1]: Stopped Create List of Static Device Nodes.606machine # [ 4.681123] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.607machine # [ 4.682151] systemd[1]: Finished rw-sysroot-nix-store.service.608machine # [ 4.712882] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.609machine # [ 4.715871] systemd[1]: Finished Cleanup udev Database.610machine # [ 4.717562] systemd[1]: Reached target Switch Root.611machine # [ 4.720331] systemd[1]: Starting NixOS Activation...612machine # [ 4.800760] initrd-nixos-activation-start[173]: booting system configuration /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test613machine # [ 4.834380] initrd-nixos-activation-start[173]: running activation script...614machine # [ 5.071366] initrd-nixos-activation-start[196]: setting up /etc...615machine # [ 5.195791] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.616machine # [ 5.199100] systemd[1]: Finished NixOS Activation.617machine # [ 5.204458] systemd[1]: Starting Switch Root...618machine # [ 5.225024] systemd[1]: Switching root.619machine # [ 5.412929] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).620machine # [ 5.510736] NET: Registered PF_VSOCK protocol family621machine # [ 5.584189] systemd[1]: systemd 263-558da31 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR)622machine # [ 5.585067] systemd[1]: Detected virtualization qemu.623machine # [ 5.585108] systemd[1]: Detected architecture arm64.624machine # [ 5.585171] systemd[1]: Detected first boot.625machine # [ 5.586543] systemd[1]: Initializing machine ID from random generator.626machine # [ 5.710749] systemd[1]: bpf-restrict-fs: LSM BPF program attached627machine # [ 5.856538] systemd[1]: Applying preset policy.628machine # [ 6.068572] systemd[1]: Populated /etc with preset unit settings.629machine # [ 6.269523] systemd[1]: initrd-switch-root.service: Deactivated successfully.630machine # [ 6.269967] systemd[1]: Stopped initrd-switch-root.service.631machine # [ 6.272773] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.632machine # [ 6.274080] systemd[1]: Created slice Slice /system/getty.633machine # [ 6.274955] systemd[1]: Created slice User and Session Slice.634machine # [ 6.280213] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.635machine # [ 6.280618] systemd[1]: Started Forward Password Requests to Wall Directory Watch.636machine # [ 6.281224] systemd[1]: Expecting device /dev/hvc0...637machine # [ 6.281812] systemd[1]: Expecting device /dev/ttyAMA0...638machine # [ 6.282401] systemd[1]: Reached target Local Encrypted Volumes.639machine # [ 6.282952] systemd[1]: Stopped target initrd-fs.target.640machine # [ 6.288865] systemd[1]: Stopped target initrd-root-fs.target.641machine # [ 6.289216] systemd[1]: Stopped target initrd-switch-root.target.642machine # [ 6.289485] systemd[1]: Reached target Virtual Machines and Containers.643machine # [ 6.289747] systemd[1]: Reached target Path Units.644machine # [ 6.289997] systemd[1]: Reached target Remote File Systems.645machine # [ 6.290232] systemd[1]: Reached target Slice Units.646machine # [ 6.290481] systemd[1]: Reached target Swaps.647machine # [ 6.301504] systemd[1]: Listening on Query the User Interactively for a Password.648machine # [ 6.304907] systemd[1]: Listening on Process Core Dump Socket.649machine # [ 6.306310] systemd[1]: Listening on Credential Encryption/Decryption.650machine # [ 6.309782] systemd[1]: Listening on Factory Reset Management.651machine # [ 6.310388] systemd[1]: Listening on Hostname Service Socket.652machine # [ 6.316589] systemd[1]: Starting Journal Log Access Socket...653machine # [ 6.317560] systemd[1]: Listening on Journal Audit Socket.654machine # [ 6.321042] systemd[1]: Listening on Console Output Muting Service Socket.655machine # [ 6.321837] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.656machine # [ 6.322349] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os657machine # [ 6.322982] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki658machine # [ 6.333051] systemd[1]: Listening on Disk Repartitioning Service Socket.659machine # [ 6.333700] systemd[1]: Listening on udev Varlink Socket.660machine # [ 6.338162] systemd[1]: Mounting Huge Pages File System...661machine # [ 6.342468] systemd[1]: Mounting POSIX Message Queue File System...662machine # [ 6.351946] systemd[1]: Mounting Kernel Debug File System...663machine # [ 6.370122] systemd[1]: Mounting Kernel Trace File System...664machine # [ 6.380255] systemd[1]: Starting Create List of Static Device Nodes...665machine # [ 6.384240] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs666machine # [ 6.401187] systemd[1]: Mounting Kernel Configuration File System...667machine # [ 6.401756] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm668machine # [ 6.411740] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore669machine # [ 6.412290] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse670machine # [ 6.439618] systemd[1]: Mounting FUSE Control File System...671machine # [ 6.440203] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67672machine # [ 6.469061] systemd[1]: Starting Journal Service...673machine # [ 6.493904] systemd[1]: Starting Load Kernel Modules...674machine # [ 6.523388] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...675machine # [ 6.543802] systemd[1]: Starting Remount Root and Kernel File Systems...676machine # [ 6.544249] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os677machine # [ 6.565133] systemd[1]: Starting Coldplug All udev Devices...678machine # [ 6.580508] systemd-journald[267]: Collecting audit messages is enabled.679machine # [ 6.586521] systemd[1]: Listening on Journal Log Access Socket.680machine # [ 6.587012] systemd[1]: Mounted Huge Pages File System.681machine # [ 6.571491] systemd[1]: Queued start job for default target Multi-User System.682machine # [ 6.574057] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0.683machine # [ 6.575354] systemd[1]: Unnecessary job was removed for /sys/devices/platform/9000000.pl011/9000000.pl011:0/9000000.pl011:0.0/tty/ttyAMA0.684machine # [ 6.583550] systemd[1]: systemd-journald.service: Deactivated successfully.685machine # [ 6.591634] systemd-modules-load[268]: Module 'atkbd' is built in686machine # [ 6.613105] systemd[1]: Started Journal Service.687machine # [ 6.602341] systemd-modules-load[268]: Module 'loop' is built in688machine # [ 6.603396] systemd[1]: Mounted POSIX Message Queue File System.689machine # [ 6.611665] systemd[1]: Mounted Kernel Debug File System.690machine # [ 6.616776] systemd[1]: Mounted Kernel Trace File System.691machine # [ 6.617753] systemd[1]: Finished Create List of Static Device Nodes.692machine # [ 6.618767] systemd[1]: Finished Load Kernel Modules.693machine # [ 6.649860] systemd[1]: Starting Firewall...694machine # [ 6.666711] systemd[1]: Starting Apply Kernel Variables...695machine # [ 6.685888] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...696machine # [ 6.694309] systemd[1]: Mounted FUSE Control File System.697machine # [ 6.699098] systemd[1]: Mounted Kernel Configuration File System.698machine # [ 6.715170] EXT4-fs (vda): re-mounted 46ffe815-2156-426f-8d85-6001848781d3.699machine # [ 6.721639] systemd-oomd[269]: No swap; memory pressure usage will be degraded700machine # [ 6.745310] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.701machine # [ 6.754148] systemd[1]: Finished Remount Root and Kernel File Systems.702machine # [ 6.755224] systemd[1]: Listening on Disk Image Download Service Socket.703machine # [ 6.772357] systemd[1]: Starting Flush Journal to Persistent Storage...704machine # [ 6.773471] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore705machine # [ 6.793602] systemd[1]: Starting Load/Save OS Random Seed...706machine # [ 6.794627] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os707machine # [ 6.858762] systemd[1]: Finished Apply Kernel Variables.708machine # [ 6.904919] systemd-journald[267]: Received client request to flush runtime journal.709machine # [ 6.964723] systemd[1]: Finished Load/Save OS Random Seed.710machine # [ 6.965733] systemd[1]: Reached target First Boot Complete.711machine # [ 6.972435] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.712machine # [ 6.978347] systemd[1]: Starting Create Static Device Nodes in /dev...713machine # [ 6.981014] systemd[1]: Finished Flush Journal to Persistent Storage.714machine # [ 7.082805] systemd[1]: Finished Create Static Device Nodes in /dev.715machine # [ 7.083898] systemd[1]: Reached target Preparation for Local File Systems.716machine # [ 7.089631] systemd[1]: Starting Rule-based Manager for Device Events and Files...717machine # [ 7.244081] systemd-udevd[309]: Using default interface naming scheme 'v261'.718machine # [ 7.260619] systemd[1]: Mounting /run/wrappers...719machine # [ 7.338049] systemd[1]: Mounted /run/wrappers.720machine # [ 7.338914] systemd[1]: Reached target Local File Systems.721machine # [ 7.344164] systemd[1]: Listening on Boot Loader Control Service Socket.722machine # [ 7.351382] systemd[1]: Starting Create SUID/SGID Wrappers...723machine # [ 7.352615] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.724machine # [ 7.362078] systemd[1]: Starting Save Transient machine-id to Disk...725machine # [ 7.365934] systemd[1]: Starting Create System Files and Directories...726machine # [ 7.416876] systemd[1]: Started Rule-based Manager for Device Events and Files.727machine # [ 7.600748] systemd[1]: Finished Create System Files and Directories.728machine # [ 7.611107] systemd[1]: Starting Rebuild Journal Catalog...729machine # [ 7.624181] systemd[1]: Starting Record System Boot/Shutdown in UTMP...730machine # [ 7.637956] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.731machine # [ 7.648175] systemd[1]: Finished Save Transient machine-id to Disk.732machine # [ 7.745244] systemd[1]: Finished Record System Boot/Shutdown in UTMP.733machine # [ 7.796556] systemd[1]: Finished Rebuild Journal Catalog.734machine # [ 7.806394] systemd[1]: Starting Update is Completed...735machine # [ 7.867837] systemd[1]: Finished Update is Completed.736machine # [ 8.095742] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs737machine # [ 8.171066] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse738machine # [ 8.222059] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.739machine # [ 8.230472] systemd[1]: Finished Create SUID/SGID Wrappers.740machine # [ 8.420348] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.741machine # [ 8.473793] systemd[1]: Finished Coldplug All udev Devices.742machine # [ 8.477119] systemd[1]: Reached target System Initialization.743machine # [ 8.478117] systemd[1]: Started Discard unused filesystem blocks once a week.744machine # [ 8.479143] systemd[1]: Started Daily Cleanup of Temporary Directories.745machine # [ 8.489513] systemd[1]: Reached target Timer Units.746machine # [ 8.490335] systemd[1]: Listening on D-Bus System Message Bus Socket.747machine # [ 8.491279] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.748machine # [ 8.501114] systemd[1]: Reached target Socket Units.749machine # [ 8.501946] systemd[1]: Reached target Basic System.750machine # [ 8.502710] systemd[1]: Starting Import lastlog data into lastlog2 database...751machine # [ 8.503760] systemd[1]: Starting Name Service Cache Daemon (nsncd)...752machine # [ 8.516566] systemd[1]: Starting Post-Boot Actions...753machine # [ 8.537467] systemd[1]: Started Reset console on configuration changes.754machine # [ 8.588919] systemd[1]: Starting resolvconf update...755machine # [ 8.599729] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.756machine # [ 8.639866] systemd[1]: Started backdoor.service.757machine # [ 8.664196] systemd[1]: Starting D-Bus System Message Bus...758machine # [ 8.708413] systemd[1]: Finished Post-Boot Actions.759machine # [ 8.721841] systemd[1]: Started Name Service Cache Daemon (nsncd).760machine # [ 8.766436] systemd[1]: Reached target Host and Network Name Lookups.761machine # [ 8.781100] nsncd[435]: Oct 22 02:58:25.269 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"762machine # [ 8.800262] systemd[1]: Reached target User and Group Name Lookups.763machine # [ 8.801744] (udev-worker)[334]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.764machine # [ 8.829366] (udev-worker)[334]: Network interface NamePolicy= disabled on kernel command line.765machine # [ 8.830693] systemd[1]: Starting User Login Management...766machine # [ 8.853970] systemd[1]: Finished Import lastlog data into lastlog2 database.767machine # connecting to host...768machine # [ 8.944869] (udev-worker)[337]: Network interface NamePolicy= disabled on kernel command line.769machine: Guest shell says: b'Spawning backdoor root shell...\n'770machine: connected to guest root shell771machine: (connecting took 9.30 seconds)772machine: (finished: waiting for the VM to finish booting, in 9.76 seconds)773machine # [ 9.005651] dbus-broker-launch[447]: Looking up NSS user entry for 'systemd-timesync'...774machine # [ 9.020304] dbus-broker-launch[447]: NSS returned no entry for 'systemd-timesync'775machine # [ 9.021447] dbus-broker-launch[447]: Invalid user-name in /nix/store/dzw73qhbffhj63s97znfqy5r1pmm0dxp-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"776machine # [ 9.068948] systemd[1]: Started D-Bus System Message Bus.777machine # [ 9.132660] systemd-logind[468]: New seat seat0.778machine # [ 9.139493] dbus-broker-launch[447]: Ready779machine # [ 9.147512] systemd[1]: Started User Login Management.780machine # [ 9.153395] systemd[1]: Starting linger-users.service...781machine # [ 9.342507] systemd[1]: Finished Firewall.782machine # [ 9.381111] systemd[1]: Created slice Slice /user/1001.783machine # [ 9.382052] systemd[1]: Stopped target Host and Network Name Lookups.784machine # [ 9.383066] systemd[1]: Stopping Host and Network Name Lookups...785machine # [ 9.457185] systemd[1]: Stopped target User and Group Name Lookups.786machine # [ 9.478463] systemd[1]: Stopping User and Group Name Lookups...787machine # [ 9.479543] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...788machine # [ 9.505710] systemd[1]: Starting User Runtime Directory /run/user/1001...789machine # [ 9.506805] systemd[1]: linger-users.service: Deactivated successfully.790machine # [ 9.507776] systemd[1]: Finished linger-users.service.791machine # [ 9.571109] systemd[1]: Condition check resulted in Virtio network device being skipped.792machine # [ 9.596948] systemd[1]: Condition check resulted in Virtio network device being skipped.793machine # [ 9.621507] systemd[1]: nscd.service: Deactivated successfully.794machine # [ 9.622855] (systemd)[572]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0)795machine # [ 9.641002] systemd[1]: Stopped Name Service Cache Daemon (nsncd).796machine # [ 9.642031] systemd[1]: Starting Name Service Cache Daemon (nsncd)...797machine # [ 9.642974] systemd-logind[468]: Watching system buttons on /dev/input/event0 (gpio-keys)798machine # [ 9.664289] systemd[1]: Finished User Runtime Directory /run/user/1001.799machine # [ 9.665338] systemd[1]: Starting User Manager for UID 1001...800machine # [ 9.666192] systemd-logind[468]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'.801machine # [ 9.688666] mousedev: PS/2 mouse device common for all mice802machine # [ 9.693694] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy803machine # [ 9.846268] systemd[1]: Started Name Service Cache Daemon (nsncd).804machine # [ 9.847683] nsncd[567]: Oct 22 02:58:26.203 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"805machine # [ 9.925618] systemd[1]: Reached target Host and Network Name Lookups.806machine # [ 9.926649] systemd[1]: Reached target User and Group Name Lookups.807machine # [ 9.927578] systemd[1]: Finished resolvconf update.808machine # [ 9.960139] systemd[1]: Reached target Preparation for Network.809machine # [ 9.961096] systemd[1]: Starting DHCP Client...810machine # [ 9.961751] systemd[1]: Starting Address configuration of eth1...811machine # [ 9.962589] systemd[1]: Starting Extra networking commands....812machine # [ 9.963394] systemd-logind[468]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)813machine # [ 10.060312] systemd[572]: Queued start job for default target Main User Target.814machine # [ 10.061489] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy815machine # [ 10.161284] systemd[572]: Created slice User Application Slice.816machine # [ 10.162352] systemd[572]: Started Daily Cleanup of User's Temporary Directories.817machine # [ 10.208335] systemd[572]: Reached target Paths.818machine # [ 10.235291] systemd[572]: Reached target Timers.819machine # [ 10.240502] systemd[572]: Starting D-Bus User Message Bus Socket...820machine # [ 10.241652] systemd[572]: Starting Create User Files and Directories...821machine # [ 10.242708] systemd[572]: Finished Create User Files and Directories.822machine # [ 10.243637] systemd[572]: Listening on D-Bus User Message Bus Socket.823machine # [ 10.246419] systemd[572]: Reached target Sockets.824machine # [ 10.264124] systemd[572]: Reached target Basic System.825machine # [ 10.265025] systemd[1]: Started User Manager for UID 1001.826machine # [ 10.265840] systemd[572]: Starting Run user-specific NixOS activation...827machine # [ 10.266819] systemd[572]: Finished Run user-specific NixOS activation.828machine # [ 10.267740] systemd[572]: Reached target Main User Target.829machine # [ 10.292436] systemd[572]: Startup finished in 544ms.830machine # [ 10.353268] network-addresses-eth1-start[594]: adding address 192.168.1.1/24... done831machine # [ 10.378211] network-addresses-eth1-start[594]: adding address 2001:db8:1::1/64... done832machine # [ 10.455843] systemd[1]: Finished Address configuration of eth1.833machine # [ 10.860597] dhcpcd[610]: dhcpcd-10.3.2 starting834machine # [ 10.895739] dhcpcd[674]: dev: loaded udev835machine # [ 10.954306] 8021q: 802.1Q VLAN Support v1.8836machine # [ 10.954682] 8021q: adding VLAN 0 to HW filter on device eth1837machine # [ 11.081328] cfg80211: Loading compiled-in X.509 certificates for regulatory database838machine # [ 11.087517] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'839machine # [ 11.088008] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'840machine # [ 11.090282] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2841machine # [ 11.090610] cfg80211: failed to load regulatory.db842machine # [ 11.190071] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3843machine # [ 11.277054] systemd[1]: Finished Extra networking commands..844machine # [ 11.278048] systemd[1]: Reached target Network.845machine # [ 11.308386] systemd[1]: Starting Permit User Sessions...846machine # [ 11.537014] systemd[1]: Finished Permit User Sessions.847machine # [ 11.546277] systemd[1]: Started Getty on tty1.848machine # [ 11.547125] systemd[1]: Reached target Login Prompts.849machine # [ 11.599226] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.850machine # [ 11.621440] systemd[1]: Starting Virtual Console Setup...851machine # [ 11.650828] 8021q: adding VLAN 0 to HW filter on device eth0852machine # [ 11.643216] dhcpcd[674]: eth0: waiting for carrier853machine # [ 11.652128] dhcpcd[674]: eth0: carrier acquired854machine # [ 11.668508] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.855machine # [ 11.669710] systemd[1]: Stopped Virtual Console Setup.856machine # [ 11.679062] systemd[1]: Starting Virtual Console Setup...857machine # [ 11.680380] systemd-logind[468]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)858machine # [ 11.686090] dhcpcd[674]: DUID 00:01:00:01:32:6c:38:54:52:54:00:12:34:56859machine # [ 11.687095] dhcpcd[674]: eth0: IAID 00:12:34:56860machine # [ 11.687774] dhcpcd[674]: eth0: adding address fe80::5054:ff:fe12:3456861machine # [ 11.797057] systemd-vconsole-setup[706]: Configuration of first virtual console was skipped, ignoring remaining ones.862machine # [ 11.803903] systemd[1]: Finished Virtual Console Setup.863machine # [ 12.862537] dhcpcd[674]: eth0: soliciting a DHCP lease864machine # [ 12.865124] dhcpcd[674]: eth0: offered 10.0.2.15 from 10.0.2.2865machine # [ 12.872441] dhcpcd[674]: eth0: probing address 10.0.2.15/24866machine # [ 13.768455] dhcpcd[674]: eth0: soliciting an IPv6 router867machine # [ 13.770375] dhcpcd[674]: eth0: Router Advertisement from fe80::2868machine # [ 13.771758] dhcpcd[674]: eth0: adding address fec0::5054:ff:fe12:3456/64869machine # [ 13.773813] dhcpcd[674]: eth0: adding route to fec0::/64870machine # [ 13.775071] dhcpcd[674]: eth0: adding default route via fe80::2871machine # [ 17.102117] dhcpcd[674]: eth0: leased 10.0.2.15 for 86400 seconds872machine # [ 17.102340] dhcpcd[674]: eth0: adding route to 10.0.2.0/24873machine # [ 17.102421] dhcpcd[674]: eth0: adding default route via 10.0.2.2874machine # [ 17.214752] systemd[1]: Started DHCP Client.875machine # [ 17.217228] systemd[1]: Reached target Multi-User System.876machine # [ 17.218282] systemd[1]: Startup finished in 1.086s (kernel) + 4.384s (initrd) + 11.745s (userspace) = 17.216s.877machine: (finished: waiting for unit multi-user.target, in 18.37 seconds)878machine: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/bin/switch-to-configuration test879machine # Checking switch inhibitors... done880machine # [ 17.862486] nixos[822]: switching to system configuration /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test881machine # [ 17.865330] systemd[1]: Stopped target Remote File Systems.882machine # [ 17.867044] systemd[1]: Stopped target Local File Systems.883machine # activating the configuration...884machine # setting up /etc...885machine # [ 18.149578] systemd[1]: Reload requested from client PID 822 ('.switch-to-conf') (unit backdoor.service)...886machine # [ 18.151551] systemd[1]: Reloading...887machine # [ 18.450469] systemd[1]: Reloading finished in 297 ms.888machine # reloading user units for usertest...889machine # [ 18.502777] systemd[572]: Created slice User Core Session Slice.890machine # [ 18.505759] systemd[572]: Starting D-Bus User Message Bus...891machine # [ 18.538732] dbus-broker-launch[893]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/dzw73qhbffhj63s97znfqy5r1pmm0dxp-system-path/share/dbus-1/services/org.freedesktop.import1.service'892machine # [ 18.542147] dbus-broker-launch[893]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/dzw73qhbffhj63s97znfqy5r1pmm0dxp-system-path/share/dbus-1/services/org.freedesktop.machine1.service'893machine # [ 18.546033] dbus-broker-launch[893]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/dzw73qhbffhj63s97znfqy5r1pmm0dxp-system-path/share/dbus-1/services/org.freedesktop.portable1.service'894machine # [ 18.549140] dbus-broker-launch[893]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/dzw73qhbffhj63s97znfqy5r1pmm0dxp-system-path/share/dbus-1/services/org.freedesktop.systemd1.service'895machine # [ 18.554066] dbus-broker-launch[893]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored896machine # [ 18.556256] dbus-broker-launch[893]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored897machine # [ 18.557973] systemd[572]: Started D-Bus User Message Bus.898machine # [ 18.560498] dbus-broker-launch[893]: Ready899machine # [ 18.600872] systemd[572]: Reexecution requested from client PID 892 ('switch-to-confi')...900machine # [ 18.604954] systemd[572]: Reexecuting.901machine # [ 18.663103] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy902machine # [ 18.773219] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy903machine # [ 18.780089] systemd[572]: Reload requested from client PID 892 ('switch-to-confi')...904machine # [ 18.781537] systemd[572]: Reloading...905machine # [ 18.887021] systemd[572]: Reloading finished in 103 ms.906machine # [ 18.904262] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy907machine # restarting the following user units: nixos-activation.service908machine # [ 18.914723] systemd[572]: Stopped Run user-specific NixOS activation.909machine # [ 18.915788] systemd[572]: Stopping Run user-specific NixOS activation...910machine # [ 18.919524] systemd[572]: Starting Run user-specific NixOS activation...911machine # [ 18.946791] systemd[572]: Finished Run user-specific NixOS activation.912machine # restarting sysinit-reactivation.target913machine # [ 18.957817] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....914machine # [ 19.036356] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..915machine # [ 19.041380] systemd[1]: Reached target Reactivate sysinit units.916machine # [ 19.044800] systemd[1]: Reached target Remote File Systems.917machine # [ 19.052384] systemd[1]: Starting linger-users.service...918machine # [ 19.055817] systemd[1]: Reached target Local File Systems.919machine # [ 19.061455] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore920machine # [ 19.067515] systemd[1]: Starting Create SUID/SGID Wrappers...921machine # [ 19.072406] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.922machine # [ 19.073724] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67923machine # [ 19.075939] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore924machine # [ 19.082423] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os925machine # [ 19.083800] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os926machine # [ 19.085209] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os927machine # [ 19.086529] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki928machine # [ 19.147027] systemd[1]: linger-users.service: Deactivated successfully.929machine # [ 19.151357] systemd[1]: Finished linger-users.service.930machine # [ 19.272604] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.931machine # [ 19.276003] systemd[1]: Finished Create SUID/SGID Wrappers.932machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service933machine # [ 19.532091] nixos[822]: finished switching to system configuration /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test934machine: (finished: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/bin/switch-to-configuration test, in 1.93 seconds)935machine: must succeed: rm /etc/NIXOS936machine: (finished: must succeed: rm /etc/NIXOS, in 0.03 seconds)937machine: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/4abp65kirv7qfjfk7373ih47xb9njczd-nixos-system-other-test/bin/switch-to-configuration test938machine # this should succeed (config: /nix/store/4abp65kirv7qfjfk7373ih47xb9njczd-nixos-system-other-test, action: test)939machine # Checking switch inhibitors... done940machine # [ 19.786308] nixos[970]: switching to system configuration /nix/store/4abp65kirv7qfjfk7373ih47xb9njczd-nixos-system-other-test941machine # [ 19.789196] systemd[1]: Stopped target Local File Systems.942machine # activating the configuration...943machine # [ 19.792086] systemd[1]: Stopped target Remote File Systems.944machine # removing user ‘usertest’945machine # setting up /etc...946machine # [ 20.060740] systemd[1]: Reload requested from client PID 970 ('.switch-to-conf') (unit backdoor.service)...947machine # [ 20.062329] systemd[1]: Reloading...948machine # [ 20.372104] systemd[1]: Reloading finished in 308 ms.949machine # reloading user units for usertest...950machine # [ 20.460514] systemd[572]: Reexecution requested from client PID 1041 ('switch-to-confi')...951machine # [ 20.463993] systemd[572]: Reexecuting.952machine # [ 20.523124] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy953machine # [ 20.640716] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy954machine # [ 20.647711] systemd[572]: Reload requested from client PID 1041 ('switch-to-confi')...955machine # [ 20.651243] systemd[572]: Reloading...956machine # [ 20.757081] systemd[572]: Reloading finished in 106 ms.957machine # [ 20.772249] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy958machine # restarting the following user units: nixos-activation.service959machine # [ 20.783532] systemd[572]: Stopped Run user-specific NixOS activation.960machine # [ 20.784905] systemd[572]: Stopping Run user-specific NixOS activation...961machine # [ 20.788590] systemd[572]: Starting Run user-specific NixOS activation...962machine # [ 20.819222] systemd[572]: Finished Run user-specific NixOS activation.963machine # restarting sysinit-reactivation.target964machine # [ 20.824818] systemd[1]: Stopped target Reactivate sysinit units.965machine # [ 20.825827] systemd[1]: Stopping Reactivate sysinit units...966machine # [ 20.826667] systemd[1]: Reached target Reactivate sysinit units.967machine # reloading the following units: dbus-broker.service968machine # [ 20.830419] systemd[1]: Reloading D-Bus System Message Bus...969machine # [ 20.831640] dbus-broker-launch[447]: Caught SIGHUP, trigger reload.970machine # [ 20.837909] dbus-broker-launch[447]: Looking up NSS user entry for 'systemd-timesync'...971machine # [ 20.839997] dbus-broker-launch[447]: NSS returned no entry for 'systemd-timesync'972machine # [ 20.841296] dbus-broker-launch[447]: Invalid user-name in /nix/store/5q8ggmpjhlkgybj5rgsynhr5va1f69bw-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"973machine # [ 20.856976] systemd[1]: Reloaded D-Bus System Message Bus.974machine # restarting the following units: network-addresses-eth1.service975machine # [ 20.863041] systemd[1]: Stopping Address configuration of eth1...976machine # [ 20.894101] network-addresses-eth1-pre-stop[1053]: deleting address 192.168.1.1/24... done977machine # [ 20.900347] network-addresses-eth1-pre-stop[1053]: deleting address 2001:db8:1::1/64... done978machine # [ 20.906998] systemd[1]: network-addresses-eth1.service: Deactivated successfully.979machine # [ 20.911375] systemd[1]: Stopped Address configuration of eth1.980machine # [ 20.913628] systemd[1]: Starting Address configuration of eth1...981machine # [ 20.952809] network-addresses-eth1-start[1058]: adding address 192.168.1.2/24... done982machine # [ 20.959083] network-addresses-eth1-start[1058]: adding address 2001:db8:1::2/64... done983machine # [ 20.977394] systemd[1]: Finished Address configuration of eth1.984machine # [ 20.983185] systemd[1]: Reached target Local File Systems.985machine # [ 20.989217] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore986machine # [ 21.000653] systemd[1]: Starting Create SUID/SGID Wrappers...987machine # [ 21.001578] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.988machine # [ 21.002872] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67989machine # [ 21.021104] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore990machine # [ 21.022810] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os991machine # [ 21.031848] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os992machine # [ 21.036432] systemd[1]: Reached target Remote File Systems.993machine # [ 21.037292] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os994machine # [ 21.038609] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki995machine # [ 21.223392] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.996machine # [ 21.227814] systemd[1]: Finished Create SUID/SGID Wrappers.997machine # [ 21.230228] systemd[1]: Starting linger-users.service...998machine # [ 21.262192] linger-users-start[1131]: id: ‘usertest’: no such user999machine # [ 21.264371] linger-users-start[1129]: Removing linger for missing user usertest1000machine # [ 21.270777] systemd[1]: linger-users.service: Deactivated successfully.1001machine # [ 21.272648] systemd[1]: Finished linger-users.service.1002machine # [ 21.529878] nixos[970]: finished switching to system configuration /nix/store/4abp65kirv7qfjfk7373ih47xb9njczd-nixos-system-other-test1003machine: (finished: must succeed: /nix/store/kabiwhgyb1j3wv90hzpkic8zvq2cw8s3-stderr-runner /nix/store/4abp65kirv7qfjfk7373ih47xb9njczd-nixos-system-other-test/bin/switch-to-configuration test, in 1.97 seconds)1004subtest: services1005machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/bin/switch-to-configuration test 2>&11006machine # [ 21.748886] nixos[1137]: switching to system configuration /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test1007machine # [ 21.753335] systemd[1]: Stopped target Remote File Systems.1008machine # [ 21.754864] systemd[1]: Stopped target Local File Systems.1009machine # [ 22.051941] systemd[1]: Reload requested from client PID 1137 ('.switch-to-conf') (unit backdoor.service)...1010machine # [ 22.054371] systemd[1]: Reloading...1011machine # [ 22.381186] systemd[1]: Reloading finished in 325 ms.1012machine # [ 22.465597] systemd[572]: Reexecution requested from client PID 1206 ('switch-to-confi')...1013machine # [ 22.470029] systemd[572]: Reexecuting.1014machine # [ 22.527977] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1015machine # [ 22.640258] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1016machine # [ 22.647599] systemd[572]: Reload requested from client PID 1206 ('switch-to-confi')...1017machine # [ 22.650085] systemd[572]: Reloading...1018machine # [ 22.757655] systemd[572]: Reloading finished in 106 ms.1019machine # [ 22.772262] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1020machine # [ 22.781766] systemd[572]: Stopped Run user-specific NixOS activation.1021machine # [ 22.784379] systemd[572]: Stopping Run user-specific NixOS activation...1022machine # [ 22.786573] systemd[572]: Starting Run user-specific NixOS activation...1023machine # [ 22.817304] systemd[572]: Finished Run user-specific NixOS activation.1024machine # [ 22.821715] systemd[1]: Stopped target Reactivate sysinit units.1025machine # [ 22.826517] systemd[1]: Stopping Reactivate sysinit units...1026machine # [ 22.827482] systemd[1]: Reached target Reactivate sysinit units.1027machine # [ 22.829623] systemd[1]: Reloading D-Bus System Message Bus...1028machine # [ 22.832793] dbus-broker-launch[447]: Caught SIGHUP, trigger reload.1029machine # [ 22.834811] dbus-broker-launch[447]: Looking up NSS user entry for 'systemd-timesync'...1030machine # [ 22.837177] dbus-broker-launch[447]: NSS returned no entry for 'systemd-timesync'1031machine # [ 22.838291] dbus-broker-launch[447]: Invalid user-name in /nix/store/dzw73qhbffhj63s97znfqy5r1pmm0dxp-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1032machine # [ 22.863890] systemd[1]: Reloaded D-Bus System Message Bus.1033machine # [ 22.870452] systemd[1]: Stopping Address configuration of eth1...1034machine # [ 22.905817] network-addresses-eth1-pre-stop[1218]: deleting address 192.168.1.2/24... done1035machine # [ 22.912506] network-addresses-eth1-pre-stop[1218]: deleting address 2001:db8:1::2/64... done1036machine # [ 22.919658] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1037machine # [ 22.922364] systemd[1]: Stopped Address configuration of eth1.1038machine # [ 22.926950] systemd[1]: Starting Address configuration of eth1...1039machine # [ 22.970711] network-addresses-eth1-start[1223]: adding address 192.168.1.1/24... done1040machine # [ 22.978062] network-addresses-eth1-start[1223]: adding address 2001:db8:1::1/64... done1041machine # [ 22.987428] systemd[1]: Finished Address configuration of eth1.1042machine # [ 22.991620] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1043machine # [ 22.995113] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1044machine # [ 22.998522] systemd[1]: Reached target Remote File Systems.1045machine # [ 23.001271] systemd[1]: Reached target Local File Systems.1046machine # [ 23.006998] systemd[1]: Starting linger-users.service...1047machine # [ 23.019166] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1048machine # [ 23.028716] systemd[1]: Starting Create SUID/SGID Wrappers...1049machine # [ 23.031764] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1050machine # [ 23.036552] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671051machine # [ 23.044761] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1052machine # [ 23.050700] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1053machine # [ 23.055234] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1054machine # [ 23.078226] systemd[1]: linger-users.service: Deactivated successfully.1055machine # [ 23.081192] systemd[1]: Finished linger-users.service.1056machine # [ 23.229534] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1057machine # [ 23.231426] systemd[1]: Finished Create SUID/SGID Wrappers.1058machine # [ 23.489742] nixos[1137]: finished switching to system configuration /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test1059machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.96 seconds)1060machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/bin/switch-to-configuration test 2>&11061machine # [ 23.707881] nixos[1292]: switching to system configuration /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test1062machine # [ 23.710675] systemd[1]: Stopped target Remote File Systems.1063machine # [ 23.713869] systemd[1]: Stopped target Local File Systems.1064machine # [ 23.985728] systemd[1]: Reload requested from client PID 1292 ('.switch-to-conf') (unit backdoor.service)...1065machine # [ 23.987717] systemd[1]: Reloading...1066machine # [ 24.300797] systemd[1]: Reloading finished in 310 ms.1067machine # [ 24.412747] systemd[572]: Reexecution requested from client PID 1361 ('switch-to-confi')...1068machine # [ 24.416073] systemd[572]: Reexecuting.1069machine # [ 24.470946] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1070machine # [ 24.578754] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1071machine # [ 24.585627] systemd[572]: Reload requested from client PID 1361 ('switch-to-confi')...1072machine # [ 24.589700] systemd[572]: Reloading...1073machine # [ 24.694948] systemd[572]: Reloading finished in 106 ms.1074machine # [ 24.712285] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1075machine # [ 24.721808] systemd[572]: Stopped Run user-specific NixOS activation.1076machine # [ 24.724199] systemd[572]: Stopping Run user-specific NixOS activation...1077machine # [ 24.726624] systemd[572]: Starting Run user-specific NixOS activation...1078machine # [ 24.761508] systemd[572]: Finished Run user-specific NixOS activation.1079machine # [ 24.765794] systemd[1]: Stopped target Reactivate sysinit units.1080machine # [ 24.767873] systemd[1]: Stopping Reactivate sysinit units...1081machine # [ 24.770265] systemd[1]: Reached target Reactivate sysinit units.1082machine # [ 24.774876] systemd[1]: Reached target Remote File Systems.1083machine # [ 24.779219] systemd[1]: Starting linger-users.service...1084machine # [ 24.784294] systemd[1]: Reached target Local File Systems.1085machine # [ 24.793178] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1086machine # [ 24.794893] systemd[1]: Starting Create SUID/SGID Wrappers...1087machine # [ 24.795710] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1088machine # [ 24.807474] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671089machine # [ 24.816785] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1090machine # [ 24.818497] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1091machine # [ 24.827070] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1092machine # [ 24.834193] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1093machine # [ 24.835609] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1094machine # [ 24.879880] systemd[1]: linger-users.service: Deactivated successfully.1095machine # [ 24.884928] systemd[1]: Finished linger-users.service.1096machine # [ 25.017284] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1097machine # [ 25.020505] systemd[1]: Finished Create SUID/SGID Wrappers.1098machine # [ 25.276173] nixos[1292]: finished switching to system configuration /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test1099machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.79 seconds)1100machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11101machine # [ 25.501389] nixos[1433]: switching to system configuration /nix/store/fs6npkhwlp2gfhxh7f3hxxzvllnrsw1c-nixos-system-machine-test1102machine # [ 25.504134] systemd[1]: Stopped target Remote File Systems.1103machine # [ 25.506559] systemd[1]: Stopped target Local File Systems.1104machine # [ 25.792460] systemd[1]: Reload requested from client PID 1433 ('.switch-to-conf') (unit backdoor.service)...1105machine # [ 25.794502] systemd[1]: Reloading...1106machine # [ 26.107391] systemd[1]: Reloading finished in 311 ms.1107machine # [ 26.194211] systemd[572]: Reexecution requested from client PID 1502 ('switch-to-confi')...1108machine # [ 26.198904] systemd[572]: Reexecuting.1109machine # [ 26.251418] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1110machine # [ 26.362583] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1111machine # [ 26.369451] systemd[572]: Reload requested from client PID 1502 ('switch-to-confi')...1112machine # [ 26.371690] systemd[572]: Reloading...1113machine # [ 26.477239] systemd[572]: Reloading finished in 105 ms.1114machine # [ 26.492208] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1115machine # [ 26.502166] systemd[572]: Stopped Run user-specific NixOS activation.1116machine # [ 26.504651] systemd[572]: Stopping Run user-specific NixOS activation...1117machine # [ 26.506813] systemd[572]: Starting Run user-specific NixOS activation...1118machine # [ 26.539960] systemd[572]: Finished Run user-specific NixOS activation.1119machine # [ 26.544857] systemd[1]: Stopped target Reactivate sysinit units.1120machine # [ 26.545843] systemd[1]: Stopping Reactivate sysinit units...1121machine # [ 26.546667] systemd[1]: Reached target Reactivate sysinit units.1122machine # [ 26.552792] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1123machine # [ 26.554272] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1124machine # [ 26.557878] systemd[1]: Reached target Local File Systems.1125machine # [ 26.560837] systemd[1]: Reached target Remote File Systems.1126machine # [ 26.562927] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1127machine # [ 26.571434] systemd[1]: Starting Create SUID/SGID Wrappers...1128machine # [ 26.577086] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1129machine # [ 26.578392] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671130machine # [ 26.583579] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1131machine # [ 26.585789] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1132machine # [ 26.587152] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1133machine # [ 26.751472] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1134machine # [ 26.753553] systemd[1]: Finished Create SUID/SGID Wrappers.1135machine # [ 26.759714] systemd[1]: Starting linger-users.service...1136machine # [ 26.763284] systemd[1]: Starting test.service...1137machine # [ 26.807772] systemd[1]: Finished test.service.1138machine # [ 26.827728] systemd[1]: linger-users.service: Deactivated successfully.1139machine # [ 26.830019] systemd[1]: Finished linger-users.service.1140machine # [ 27.087842] nixos[1433]: finished switching to system configuration /nix/store/fs6npkhwlp2gfhxh7f3hxxzvllnrsw1c-nixos-system-machine-test1141machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.81 seconds)1142machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11143machine # [ 27.305747] nixos[1575]: switching to system configuration /nix/store/fs6npkhwlp2gfhxh7f3hxxzvllnrsw1c-nixos-system-machine-test1144machine # [ 27.308531] systemd[1]: Stopped target Remote File Systems.1145machine # [ 27.311610] systemd[1]: Stopped target Local File Systems.1146machine # [ 27.619931] systemd[1]: Reload requested from client PID 1575 ('.switch-to-conf') (unit backdoor.service)...1147machine # [ 27.628292] systemd[1]: Reloading...1148machine # [ 27.972884] systemd[1]: Reloading finished in 348 ms.1149machine # [ 28.086028] systemd[572]: Reexecution requested from client PID 1644 ('switch-to-confi')...1150machine # [ 28.090772] systemd[572]: Reexecuting.1151machine # [ 28.147855] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1152machine # [ 28.263028] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1153machine # [ 28.271116] systemd[572]: Reload requested from client PID 1644 ('switch-to-confi')...1154machine # [ 28.274750] systemd[572]: Reloading...1155machine # [ 28.384250] systemd[572]: Reloading finished in 110 ms.1156machine # [ 28.400292] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1157machine # [ 28.410708] systemd[572]: Stopped Run user-specific NixOS activation.1158machine # [ 28.413336] systemd[572]: Stopping Run user-specific NixOS activation...1159machine # [ 28.415905] systemd[572]: Starting Run user-specific NixOS activation...1160machine # [ 28.450062] systemd[572]: Finished Run user-specific NixOS activation.1161machine # [ 28.454332] systemd[1]: Stopped target Reactivate sysinit units.1162machine # [ 28.456409] systemd[1]: Stopping Reactivate sysinit units...1163machine # [ 28.457288] systemd[1]: Reached target Reactivate sysinit units.1164machine # [ 28.461922] systemd[1]: Reached target Local File Systems.1165machine # [ 28.466102] systemd[1]: Reached target Remote File Systems.1166machine # [ 28.468930] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1167machine # [ 28.471387] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1168machine # [ 28.477078] systemd[1]: Starting linger-users.service...1169machine # [ 28.479908] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1170machine # [ 28.495965] systemd[1]: Starting Create SUID/SGID Wrappers...1171machine # [ 28.496990] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1172machine # [ 28.498292] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671173machine # [ 28.502268] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1174machine # [ 28.503902] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1175machine # [ 28.508860] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1176machine # [ 28.561774] systemd[1]: linger-users.service: Deactivated successfully.1177machine # [ 28.564558] systemd[1]: Finished linger-users.service.1178machine # [ 28.697242] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1179machine # [ 28.700910] systemd[1]: Finished Create SUID/SGID Wrappers.1180machine # [ 28.955022] nixos[1575]: finished switching to system configuration /nix/store/fs6npkhwlp2gfhxh7f3hxxzvllnrsw1c-nixos-system-machine-test1181machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.87 seconds)1182machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&11183machine # [ 29.189524] nixos[1716]: switching to system configuration /nix/store/lzpwy4bhqy8di0nc5irkqrp6aap6agya-nixos-system-machine-test1184machine # [ 29.192693] systemd[1]: Stopped target Local File Systems.1185machine # [ 29.194716] systemd[1]: Stopped target Remote File Systems.1186machine # [ 29.501883] systemd[1]: Reload requested from client PID 1716 ('.switch-to-conf') (unit backdoor.service)...1187machine # [ 29.503907] systemd[1]: Reloading...1188machine # [ 29.863326] systemd[1]: Reloading finished in 357 ms.1189machine # [ 29.945391] systemd[572]: Reexecution requested from client PID 1785 ('switch-to-confi')...1190machine # [ 29.949363] systemd[572]: Reexecuting.1191machine # [ 29.995275] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1192machine # [ 30.103248] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1193machine # [ 30.110383] systemd[572]: Reload requested from client PID 1785 ('switch-to-confi')...1194machine # [ 30.113052] systemd[572]: Reloading...1195machine # [ 30.223183] systemd[572]: Reloading finished in 109 ms.1196machine # [ 30.236251] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1197machine # [ 30.248598] systemd[572]: Stopped Run user-specific NixOS activation.1198machine # [ 30.251027] systemd[572]: Stopping Run user-specific NixOS activation...1199machine # [ 30.253397] systemd[572]: Starting Run user-specific NixOS activation...1200machine # [ 30.284205] systemd[572]: Finished Run user-specific NixOS activation.1201machine # [ 30.287844] systemd[1]: Stopped target Reactivate sysinit units.1202machine # [ 30.289295] systemd[1]: Stopping Reactivate sysinit units...1203machine # [ 30.290118] systemd[1]: Reached target Reactivate sysinit units.1204machine # [ 30.294529] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1205machine # [ 30.297560] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1206machine # [ 30.300356] systemd[1]: Reached target Remote File Systems.1207machine # [ 30.303631] systemd[1]: Starting linger-users.service...1208machine # [ 30.308511] systemd[1]: Reached target Local File Systems.1209machine # [ 30.309347] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1210machine # [ 30.327587] systemd[1]: Starting Create SUID/SGID Wrappers...1211machine # [ 30.330790] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1212machine # [ 30.332334] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671213machine # [ 30.334599] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1214machine # [ 30.336460] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1215machine # [ 30.337770] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1216machine # [ 30.399947] systemd[1]: linger-users.service: Deactivated successfully.1217machine # [ 30.403567] systemd[1]: Finished linger-users.service.1218machine # [ 30.523491] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1219machine # [ 30.527458] systemd[1]: Finished Create SUID/SGID Wrappers.1220machine # [ 30.781686] nixos[1716]: finished switching to system configuration /nix/store/lzpwy4bhqy8di0nc5irkqrp6aap6agya-nixos-system-machine-test1221machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 1.83 seconds)1222machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11223machine # [ 31.056347] nixos[1856]: switching to system configuration /nix/store/02xxghd394vm6b94phmga3r2w3kiyyhn-nixos-system-machine-test1224machine # [ 31.059433] systemd[1]: test.service: Deactivated successfully.1225machine # [ 31.062908] systemd[1]: Stopped Test unit.1226machine # [ 31.063619] systemd[1]: Stopped target Local File Systems.1227machine # [ 31.066787] systemd[1]: Stopped target Remote File Systems.1228machine # [ 31.353763] systemd[1]: Reload requested from client PID 1856 ('.switch-to-conf') (unit backdoor.service)...1229machine # [ 31.355749] systemd[1]: Reloading...1230machine # [ 31.671172] systemd[1]: Reloading finished in 313 ms.1231machine # [ 31.761701] systemd[572]: Reexecution requested from client PID 1926 ('switch-to-confi')...1232machine # [ 31.765788] systemd[572]: Reexecuting.1233machine # [ 31.823604] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1234machine # [ 31.935348] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1235machine # [ 31.943258] systemd[572]: Reload requested from client PID 1926 ('switch-to-confi')...1236machine # [ 31.947219] systemd[572]: Reloading...1237machine # [ 32.052505] systemd[572]: Reloading finished in 106 ms.1238machine # [ 32.069692] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1239machine # [ 32.078707] systemd[572]: Stopped Run user-specific NixOS activation.1240machine # [ 32.081254] systemd[572]: Stopping Run user-specific NixOS activation...1241machine # [ 32.083561] systemd[572]: Starting Run user-specific NixOS activation...1242machine # [ 32.117049] systemd[572]: Finished Run user-specific NixOS activation.1243machine # [ 32.121561] systemd[1]: Stopped target Reactivate sysinit units.1244machine # [ 32.124836] systemd[1]: Stopping Reactivate sysinit units...1245machine # [ 32.125747] systemd[1]: Reached target Reactivate sysinit units.1246machine # [ 32.131488] systemd[1]: Starting test.service...1247machine # [ 32.135443] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1248machine # [ 32.141362] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1249machine # [ 32.145019] systemd[1]: Reached target Local File Systems.1250machine # [ 32.150475] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1251machine # [ 32.155460] systemd[1]: Starting Create SUID/SGID Wrappers...1252machine # [ 32.161004] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1253machine # [ 32.162287] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671254machine # [ 32.170691] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1255machine # [ 32.175624] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1256machine # [ 32.182676] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1257machine # [ 32.187967] systemd[1]: Reached target Remote File Systems.1258machine # [ 32.195986] systemd[1]: Finished test.service.1259machine # [ 32.342038] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1260machine # [ 32.347018] systemd[1]: Finished Create SUID/SGID Wrappers.1261machine # [ 32.349353] systemd[1]: Starting linger-users.service...1262machine # [ 32.389720] systemd[1]: linger-users.service: Deactivated successfully.1263machine # [ 32.392462] systemd[1]: Finished linger-users.service.1264machine # [ 32.647866] nixos[1856]: finished switching to system configuration /nix/store/02xxghd394vm6b94phmga3r2w3kiyyhn-nixos-system-machine-test1265machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.87 seconds)1266machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&11267machine # [ 32.878434] nixos[1999]: switching to system configuration /nix/store/89hgfl7546jyh2d52psxkwdh6yzfzl81-nixos-system-machine-test1268machine # [ 32.880997] systemd[1]: Stopped target Remote File Systems.1269machine # [ 32.883483] systemd[1]: Stopped target Local File Systems.1270machine # [ 33.170746] systemd[1]: Reload requested from client PID 1999 ('.switch-to-conf') (unit backdoor.service)...1271machine # [ 33.173011] systemd[1]: Reloading...1272machine # [ 33.495010] systemd[1]: Reloading finished in 320 ms.1273machine # [ 33.581213] systemd[572]: Reexecution requested from client PID 2068 ('switch-to-confi')...1274machine # [ 33.586210] systemd[572]: Reexecuting.1275machine # [ 33.639033] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1276machine # [ 33.745761] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1277machine # [ 33.752249] systemd[572]: Reload requested from client PID 2068 ('switch-to-confi')...1278machine # [ 33.755884] systemd[572]: Reloading...1279machine # [ 33.861112] systemd[572]: Reloading finished in 106 ms.1280machine # [ 33.876165] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1281machine # [ 33.886210] systemd[572]: Stopped Run user-specific NixOS activation.1282machine # [ 33.888577] systemd[572]: Stopping Run user-specific NixOS activation...1283machine # [ 33.890648] systemd[572]: Starting Run user-specific NixOS activation...1284machine # [ 33.923304] systemd[572]: Finished Run user-specific NixOS activation.1285machine # [ 33.927600] systemd[1]: Stopped target Reactivate sysinit units.1286machine # [ 33.929581] systemd[1]: Stopping Reactivate sysinit units...1287machine # [ 33.930473] systemd[1]: Reached target Reactivate sysinit units.1288machine # [ 33.934239] systemd[1]: test.service: Deactivated successfully.1289machine # [ 33.935163] systemd[1]: Stopped test.service.1290machine # [ 33.935802] systemd[1]: Stopping test.service...1291machine # [ 33.938503] systemd[1]: Starting test.service...1292machine # [ 33.960725] systemd[1]: Finished test.service.1293machine # [ 33.963932] systemd[1]: Reached target Remote File Systems.1294machine # [ 33.970373] systemd[1]: Starting linger-users.service...1295machine # [ 33.976560] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1296machine # [ 33.978007] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1297machine # [ 33.985100] systemd[1]: Reached target Local File Systems.1298machine # [ 33.993109] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1299machine # [ 33.994719] systemd[1]: Starting Create SUID/SGID Wrappers...1300machine # [ 33.995600] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1301machine # [ 34.002804] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671302machine # [ 34.011090] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1303machine # [ 34.015770] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1304machine # [ 34.021888] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1305machine # [ 34.065342] systemd[1]: linger-users.service: Deactivated successfully.1306machine # [ 34.069907] systemd[1]: Finished linger-users.service.1307machine # [ 34.198124] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1308machine # [ 34.201589] systemd[1]: Finished Create SUID/SGID Wrappers.1309machine # [ 34.456822] nixos[1999]: finished switching to system configuration /nix/store/89hgfl7546jyh2d52psxkwdh6yzfzl81-nixos-system-machine-test1310machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.81 seconds)1311machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&11312machine # [ 34.684410] nixos[2142]: switching to system configuration /nix/store/k5ybrrkqj2wibcyyh0kv85md825hpi03-nixos-system-machine-test1313machine # [ 34.688154] systemd[1]: Stopped target Local File Systems.1314machine # [ 34.690381] systemd[1]: Stopped target Remote File Systems.1315machine # [ 34.973826] systemd[1]: Reload requested from client PID 2142 ('.switch-to-conf') (unit backdoor.service)...1316machine # [ 34.975781] systemd[1]: Reloading...1317machine # [ 35.289157] systemd[1]: Reloading finished in 311 ms.1318machine # [ 35.380537] systemd[572]: Reexecution requested from client PID 2211 ('switch-to-confi')...1319machine # [ 35.384263] systemd[572]: Reexecuting.1320machine # [ 35.438929] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1321machine # [ 35.548402] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1322machine # [ 35.555675] systemd[572]: Reload requested from client PID 2211 ('switch-to-confi')...1323machine # [ 35.558937] systemd[572]: Reloading...1324machine # [ 35.663438] systemd[572]: Reloading finished in 105 ms.1325machine # [ 35.680176] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1326machine # [ 35.689877] systemd[572]: Stopped Run user-specific NixOS activation.1327machine # [ 35.692223] systemd[572]: Stopping Run user-specific NixOS activation...1328machine # [ 35.694676] systemd[572]: Starting Run user-specific NixOS activation...1329machine # [ 35.728157] systemd[572]: Finished Run user-specific NixOS activation.1330machine # [ 35.731812] systemd[1]: Stopped target Reactivate sysinit units.1331machine # [ 35.736301] systemd[1]: Stopping Reactivate sysinit units...1332machine # [ 35.737229] systemd[1]: Reached target Reactivate sysinit units.1333machine # [ 35.739324] systemd[1]: Reloading test.service...1334machine # [ 35.765636] systemd[1]: Reloaded test.service.1335machine # [ 35.770437] systemd[1]: Reached target Remote File Systems.1336machine # [ 35.774734] systemd[1]: Starting linger-users.service...1337machine # [ 35.784972] systemd[1]: Reached target Local File Systems.1338machine # [ 35.789438] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1339machine # [ 35.796627] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1340machine # [ 35.798111] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1341machine # [ 35.809560] systemd[1]: Starting Create SUID/SGID Wrappers...1342machine # [ 35.810540] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1343machine # [ 35.811784] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671344machine # [ 35.822624] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1345machine # [ 35.824674] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1346machine # [ 35.826303] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1347machine # [ 35.864514] systemd[1]: linger-users.service: Deactivated successfully.1348machine # [ 35.866898] systemd[1]: Finished linger-users.service.1349machine # [ 36.007781] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1350machine # [ 36.010537] systemd[1]: Finished Create SUID/SGID Wrappers.1351machine # [ 36.266771] nixos[2142]: finished switching to system configuration /nix/store/k5ybrrkqj2wibcyyh0kv85md825hpi03-nixos-system-machine-test1352machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 1.81 seconds)1353machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&11354machine # [ 36.510772] nixos[2284]: switching to system configuration /nix/store/94mf2bvp763s7jynh1fw6p32r84z3kxk-nixos-system-machine-test1355machine # [ 36.513611] systemd[1]: Stopped target Local File Systems.1356machine # [ 36.516237] systemd[1]: Stopped target Remote File Systems.1357machine # [ 36.821379] systemd[1]: Reload requested from client PID 2284 ('.switch-to-conf') (unit backdoor.service)...1358machine # [ 36.823441] systemd[1]: Reloading...1359machine # [ 37.167140] systemd[1]: Reloading finished in 342 ms.1360machine # [ 37.256438] systemd[572]: Reexecution requested from client PID 2353 ('switch-to-confi')...1361machine # [ 37.257858] systemd[572]: Reexecuting.1362machine # [ 37.315812] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1363machine # [ 37.431006] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1364machine # [ 37.438349] systemd[572]: Reload requested from client PID 2353 ('switch-to-confi')...1365machine # [ 37.442258] systemd[572]: Reloading...1366machine # [ 37.549834] systemd[572]: Reloading finished in 108 ms.1367machine # [ 37.564182] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1368machine # [ 37.575129] systemd[572]: Stopped Run user-specific NixOS activation.1369machine # [ 37.577590] systemd[572]: Stopping Run user-specific NixOS activation...1370machine # [ 37.580314] systemd[572]: Starting Run user-specific NixOS activation...1371machine # [ 37.623635] systemd[572]: Finished Run user-specific NixOS activation.1372machine # [ 37.631552] systemd[1]: Stopped target Reactivate sysinit units.1373machine # [ 37.638541] systemd[1]: Stopping Reactivate sysinit units...1374machine # [ 37.639440] systemd[1]: Reached target Reactivate sysinit units.1375machine # [ 37.648169] systemd[1]: Reached target Remote File Systems.1376machine # [ 37.649061] systemd[1]: Reached target Local File Systems.1377machine # [ 37.649865] systemd[1]: Starting linger-users.service...1378machine # [ 37.660715] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1379machine # [ 37.668413] systemd[1]: Starting Create SUID/SGID Wrappers...1380machine # [ 37.669338] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1381machine # [ 37.670596] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671382machine # [ 37.687338] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1383machine # [ 37.697094] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1384machine # [ 37.705025] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1385machine # [ 37.712673] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1386machine # [ 37.714075] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1387machine # [ 37.782756] systemd[1]: linger-users.service: Deactivated successfully.1388machine # [ 37.785680] systemd[1]: Finished linger-users.service.1389machine # [ 37.925268] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1390machine # [ 37.928462] systemd[1]: Finished Create SUID/SGID Wrappers.1391machine # [ 38.184618] nixos[2284]: finished switching to system configuration /nix/store/94mf2bvp763s7jynh1fw6p32r84z3kxk-nixos-system-machine-test1392machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.92 seconds)1393machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&11394machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.32 seconds)1395machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/bin/switch-to-configuration test 2>&11396machine # [ 38.697539] nixos[2435]: switching to system configuration /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test1397machine # [ 38.701156] systemd[1]: Stopped target Local File Systems.1398machine # [ 38.703406] systemd[1]: test.service: Deactivated successfully.1399machine # [ 38.706665] systemd[1]: Stopped test.service.1400machine # [ 38.707401] systemd[1]: Stopped target Remote File Systems.1401machine # [ 39.000502] systemd[1]: Reload requested from client PID 2435 ('.switch-to-conf') (unit backdoor.service)...1402machine # [ 39.002190] systemd[1]: Reloading...1403machine # [ 39.333520] systemd[1]: Reloading finished in 329 ms.1404machine # [ 39.422809] systemd[572]: Reexecution requested from client PID 2504 ('switch-to-confi')...1405machine # [ 39.425476] systemd[572]: Reexecuting.1406machine # [ 39.492964] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1407machine # [ 39.620672] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1408machine # [ 39.627954] systemd[572]: Reload requested from client PID 2504 ('switch-to-confi')...1409machine # [ 39.631746] systemd[572]: Reloading...1410machine # [ 39.742455] systemd[572]: Reloading finished in 111 ms.1411machine # [ 39.760201] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1412machine # [ 39.772656] systemd[572]: Stopped Run user-specific NixOS activation.1413machine # [ 39.775222] systemd[572]: Stopping Run user-specific NixOS activation...1414machine # [ 39.777575] systemd[572]: Starting Run user-specific NixOS activation...1415machine # [ 39.809484] systemd[572]: Finished Run user-specific NixOS activation.1416machine # [ 39.814031] systemd[1]: Stopped target Reactivate sysinit units.1417machine # [ 39.817343] systemd[1]: Stopping Reactivate sysinit units...1418machine # [ 39.818298] systemd[1]: Reached target Reactivate sysinit units.1419machine # [ 39.820469] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1420machine # [ 39.821872] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1421machine # [ 39.826510] systemd[1]: Reached target Remote File Systems.1422machine # [ 39.829104] systemd[1]: Reached target Local File Systems.1423machine # [ 39.831803] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1424machine # [ 39.841761] systemd[1]: Starting Create SUID/SGID Wrappers...1425machine # [ 39.842703] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1426machine # [ 39.852378] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671427machine # [ 39.854707] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1428machine # [ 39.857461] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1429machine # [ 39.858802] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1430machine # [ 40.026710] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1431machine # [ 40.028816] systemd[1]: Finished Create SUID/SGID Wrappers.1432machine # [ 40.034059] systemd[1]: Starting linger-users.service...1433machine # [ 40.080515] systemd[1]: linger-users.service: Deactivated successfully.1434machine # [ 40.083522] systemd[1]: Finished linger-users.service.1435machine # [ 40.341588] nixos[2435]: finished switching to system configuration /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test1436machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.84 seconds)1437machine: must succeed: /nix/store/cmyahhd8vhs6g56lz10bwkqlczjrvwnv-separate-activation-script/bin/switch-to-configuration test 2>&11438machine # [ 40.592500] nixos[2575]: switching to system configuration /nix/store/6djlmxgpnzk3y8bs36l60zhw875563js-nixos-system-machine-test1439machine # [ 40.595296] systemd[1]: Stopped target Local File Systems.1440machine # [ 40.598169] systemd[1]: Stopped target Remote File Systems.1441machine # [ 40.923105] systemd[1]: Reload requested from client PID 2575 ('.switch-to-conf') (unit backdoor.service)...1442machine # [ 40.925521] systemd[1]: Reloading...1443machine # [ 41.294283] systemd[1]: Reloading finished in 367 ms.1444machine # [ 41.436898] systemd[572]: Stopped Run user-specific NixOS activation.1445machine # [ 41.440832] systemd[572]: Reexecution requested from client PID 2644 ('switch-to-confi')...1446machine # [ 41.443749] systemd[572]: Reexecuting.1447machine # [ 41.495459] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1448machine # [ 41.617143] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1449machine # [ 41.624566] systemd[572]: Reload requested from client PID 2644 ('switch-to-confi')...1450machine # [ 41.625936] systemd[572]: Reloading...1451machine # [ 41.740627] systemd[572]: Reloading finished in 113 ms.1452machine # [ 41.756215] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1453machine # [ 41.769205] systemd[1]: Stopped target Reactivate sysinit units.1454machine # [ 41.771436] systemd[1]: Stopping Reactivate sysinit units...1455machine # [ 41.773038] systemd[1]: Reached target Reactivate sysinit units.1456machine # [ 41.782675] systemd[1]: Reached target Remote File Systems.1457machine # [ 41.788168] systemd[1]: Starting linger-users.service...1458machine # [ 41.793539] systemd[1]: Starting test.service...1459machine # [ 41.804808] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1460machine # [ 41.806307] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1461machine # [ 41.821952] systemd[1]: Reached target Local File Systems.1462machine # [ 41.822996] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1463machine # [ 41.832273] systemd[1]: Starting Create SUID/SGID Wrappers...1464machine # [ 41.833395] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1465machine # [ 41.834667] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671466machine # [ 41.844919] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1467machine # [ 41.846738] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1468machine # [ 41.858098] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1469machine # [ 41.888863] systemd[1]: Finished test.service.1470machine # [ 41.932267] systemd[1]: linger-users.service: Deactivated successfully.1471machine # [ 41.935511] systemd[1]: Finished linger-users.service.1472machine # [ 42.095070] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1473machine # [ 42.097463] systemd[1]: Finished Create SUID/SGID Wrappers.1474machine # [ 42.357554] nixos[2575]: finished switching to system configuration /nix/store/6djlmxgpnzk3y8bs36l60zhw875563js-nixos-system-machine-test1475machine: (finished: must succeed: /nix/store/cmyahhd8vhs6g56lz10bwkqlczjrvwnv-separate-activation-script/bin/switch-to-configuration test 2>&1, in 2.02 seconds)1476machine: must succeed: ! test -e /run/current-system/activate1477machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.03 seconds)1478machine: must succeed: ! test -e /run/current-system/dry-activate1479machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.03 seconds)1480machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration1481machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.02 seconds)1482machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&11483machine # [ 42.704731] nixos[2724]: switching to system configuration /nix/store/ff3xx8p5l10ikjd36nkk2y0javwgfvd9-nixos-system-machine-test1484machine # [ 42.708573] systemd[1]: test.service: Deactivated successfully.1485machine # [ 42.709615] systemd[1]: Stopped test.service.1486machine # [ 42.712631] systemd[1]: Stopped target Local File Systems.1487machine # [ 42.714472] systemd[1]: Stopped target Remote File Systems.1488machine # [ 43.065990] systemd[1]: Reload requested from client PID 2724 ('.switch-to-conf') (unit backdoor.service)...1489machine # [ 43.068268] systemd[1]: Reloading...1490machine # [ 43.435757] systemd[1]: Reloading finished in 366 ms.1491machine # [ 43.536940] systemd[572]: Reexecution requested from client PID 2793 ('switch-to-confi')...1492machine # [ 43.541854] systemd[572]: Reexecuting.1493machine # [ 43.600723] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1494machine # [ 43.732941] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1495machine # [ 43.740322] systemd[572]: Reload requested from client PID 2793 ('switch-to-confi')...1496machine # [ 43.742664] systemd[572]: Reloading...1497machine # [ 43.869030] systemd[572]: Reloading finished in 125 ms.1498machine # [ 43.884245] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1499machine # [ 43.901399] systemd[572]: Starting Run user-specific NixOS activation...1500machine # [ 43.939858] systemd[572]: Finished Run user-specific NixOS activation.1501machine # [ 43.946610] systemd[572]: Stopped Run user-specific NixOS activation.1502machine # [ 43.947754] systemd[572]: Stopping Run user-specific NixOS activation...1503machine # [ 43.956492] systemd[572]: Starting Run user-specific NixOS activation...1504machine # [ 43.959143] systemd[1]: Stopped target Reactivate sysinit units.1505machine # [ 43.962960] systemd[1]: Stopping Reactivate sysinit units...1506machine # [ 43.963903] systemd[1]: Reached target Reactivate sysinit units.1507machine # [ 43.979958] systemd[1]: Started test.service.1508machine # [ 44.002126] systemd[1]: Reached target Local File Systems.1509machine # [ 44.003178] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1510machine # [ 44.027836] systemd[1]: Starting Create SUID/SGID Wrappers...1511machine # [ 44.036573] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1512machine # [ 44.038227] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671513machine # [ 44.055201] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1514machine # [ 44.074680] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1515machine # [ 44.084241] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1516machine # [ 44.091263] systemd[1]: Reached target Remote File Systems.1517machine # [ 44.094073] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1518machine # [ 44.095445] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1519machine # [ 44.104073] systemd[572]: Finished Run user-specific NixOS activation.1520machine # [ 44.108761] systemd[1]: test.service: Deactivated successfully.1521machine # [ 44.371203] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1522machine # [ 44.379466] systemd[1]: Finished Create SUID/SGID Wrappers.1523machine # [ 44.383605] systemd[1]: Starting linger-users.service...1524machine # [ 44.425711] systemd[1]: linger-users.service: Deactivated successfully.1525machine # [ 44.428894] systemd[1]: Finished linger-users.service.1526machine # [ 44.686342] nixos[2724]: finished switching to system configuration /nix/store/ff3xx8p5l10ikjd36nkk2y0javwgfvd9-nixos-system-machine-test1527machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 2.25 seconds)1528machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&11529machine # [ 44.938455] nixos[2870]: switching to system configuration /nix/store/ykfkvr51vvl324vcxhj69jxksp3j7vc8-nixos-system-machine-test1530machine # [ 44.941268] systemd[1]: Stopped target Remote File Systems.1531machine # [ 44.944293] systemd[1]: Stopped target Local File Systems.1532machine # [ 45.280945] systemd[1]: Reload requested from client PID 2870 ('.switch-to-conf') (unit backdoor.service)...1533machine # [ 45.282604] systemd[1]: Reloading...1534machine # [ 45.655807] systemd[1]: Reloading finished in 371 ms.1535machine # [ 45.751223] systemd[572]: Reexecution requested from client PID 2939 ('switch-to-confi')...1536machine # [ 45.755663] systemd[572]: Reexecuting.1537machine # [ 45.811322] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1538machine # [ 45.934490] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1539machine # [ 45.944143] systemd[572]: Reload requested from client PID 2939 ('switch-to-confi')...1540machine # [ 45.948243] systemd[572]: Reloading...1541machine # [ 46.069355] systemd[572]: Reloading finished in 121 ms.1542machine # [ 46.087044] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1543machine # [ 46.096911] systemd[572]: Stopped Run user-specific NixOS activation.1544machine # [ 46.099457] systemd[572]: Stopping Run user-specific NixOS activation...1545machine # [ 46.101935] systemd[572]: Starting Run user-specific NixOS activation...1546machine # [ 46.134417] systemd[572]: Finished Run user-specific NixOS activation.1547machine # [ 46.138875] systemd[1]: Stopped target Reactivate sysinit units.1548machine # [ 46.141712] systemd[1]: Stopping Reactivate sysinit units...1549machine # [ 46.142687] systemd[1]: Reached target Reactivate sysinit units.1550machine # [ 46.148596] systemd[1]: Reached target Remote File Systems.1551machine # [ 46.154724] systemd[1]: Starting escaped\x2ddash.service...1552machine # [ 46.159508] systemd[1]: Starting linger-users.service...1553machine # [ 46.168313] systemd[1]: Reached target Local File Systems.1554machine # [ 46.174132] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1555machine # [ 46.175611] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1556machine # [ 46.188593] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1557machine # [ 46.190217] systemd[1]: Starting Create SUID/SGID Wrappers...1558machine # [ 46.191035] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1559machine # [ 46.204888] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671560machine # [ 46.207276] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1561machine # [ 46.224815] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1562machine # [ 46.232966] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1563machine # [ 46.244448] systemd[1]: Finished escaped\x2ddash.service.1564machine # [ 46.287113] systemd[1]: linger-users.service: Deactivated successfully.1565machine # [ 46.289908] systemd[1]: Finished linger-users.service.1566machine # [ 46.451575] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1567machine # [ 46.454607] systemd[1]: Finished Create SUID/SGID Wrappers.1568machine # [ 46.712512] nixos[2870]: finished switching to system configuration /nix/store/ykfkvr51vvl324vcxhj69jxksp3j7vc8-nixos-system-machine-test1569machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 2.02 seconds)1570machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&11571machine # [ 46.981111] nixos[3012]: switching to system configuration /nix/store/31a3panbs2rydcd1235q3a58hq96g381-nixos-system-machine-test1572machine # [ 46.987135] systemd[1]: Stopped target Local File Systems.1573machine # [ 46.990575] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1574machine # [ 46.991684] systemd[1]: Stopped escaped\x2ddash.service.1575machine # [ 46.993177] systemd[1]: Stopped target Remote File Systems.1576machine # [ 47.317257] systemd[1]: Reload requested from client PID 3012 ('.switch-to-conf') (unit backdoor.service)...1577machine # [ 47.319267] systemd[1]: Reloading...1578machine # [ 47.706817] systemd[1]: Reloading finished in 385 ms.1579machine # [ 47.804607] systemd[572]: Reexecution requested from client PID 3081 ('switch-to-confi')...1580machine # [ 47.808541] systemd[572]: Reexecuting.1581machine # [ 47.872213] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1582machine # [ 47.994703] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1583machine # [ 48.002352] systemd[572]: Reload requested from client PID 3081 ('switch-to-confi')...1584machine # [ 48.004928] systemd[572]: Reloading...1585machine # [ 48.118266] systemd[572]: Reloading finished in 111 ms.1586machine # [ 48.132315] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1587machine # [ 48.143187] systemd[572]: Stopped Run user-specific NixOS activation.1588machine # [ 48.144362] systemd[572]: Stopping Run user-specific NixOS activation...1589machine # [ 48.146812] systemd[572]: Starting Run user-specific NixOS activation...1590machine # [ 48.177913] systemd[572]: Finished Run user-specific NixOS activation.1591machine # [ 48.181894] systemd[1]: Stopped target Reactivate sysinit units.1592machine # [ 48.184207] systemd[1]: Stopping Reactivate sysinit units...1593machine # [ 48.185119] systemd[1]: Reached target Reactivate sysinit units.1594machine # [ 48.190410] systemd[1]: Starting escaped\x2ddash.service...1595machine # [ 48.197824] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1596machine # [ 48.199260] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1597machine # [ 48.209186] systemd[1]: Reached target Local File Systems.1598machine # [ 48.210196] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1599machine # [ 48.215372] systemd[1]: Starting Create SUID/SGID Wrappers...1600machine # [ 48.219462] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1601machine # [ 48.229677] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671602machine # [ 48.237939] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1603machine # [ 48.239660] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1604machine # [ 48.243159] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1605machine # [ 48.246151] systemd[1]: Reached target Remote File Systems.1606machine # [ 48.253038] systemd[1]: Finished escaped\x2ddash.service.1607machine # [ 48.404749] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1608machine # [ 48.408391] systemd[1]: Finished Create SUID/SGID Wrappers.1609machine # [ 48.411756] systemd[1]: Starting linger-users.service...1610machine # [ 48.453436] systemd[1]: linger-users.service: Deactivated successfully.1611machine # [ 48.456296] systemd[1]: Finished linger-users.service.1612machine # [ 48.713359] nixos[3012]: finished switching to system configuration /nix/store/31a3panbs2rydcd1235q3a58hq96g381-nixos-system-machine-test1613machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 2.00 seconds)1614machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&11615machine # [ 48.944933] nixos[3154]: switching to system configuration /nix/store/gpzzbfjp6i4zvkqlac89sfpbiap1hr5c-nixos-system-machine-test1616machine # [ 48.947648] systemd[1]: Stopped target Local File Systems.1617machine # [ 48.951486] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1618machine # [ 48.953855] systemd[1]: Stopped escaped\x2ddash.service.1619machine # [ 48.954680] systemd[1]: Stopped target Remote File Systems.1620machine # [ 49.249717] systemd[1]: Reload requested from client PID 3154 ('.switch-to-conf') (unit backdoor.service)...1621machine # [ 49.251692] systemd[1]: Reloading...1622machine # [ 49.567143] systemd[1]: Reloading finished in 313 ms.1623machine # [ 49.656508] systemd[572]: Reexecution requested from client PID 3223 ('switch-to-confi')...1624machine # [ 49.658040] systemd[572]: Reexecuting.1625machine # [ 49.716506] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1626machine # [ 49.831861] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1627machine # [ 49.838754] systemd[572]: Reload requested from client PID 3223 ('switch-to-confi')...1628machine # [ 49.842459] systemd[572]: Reloading...1629machine # [ 49.947290] systemd[572]: Reloading finished in 105 ms.1630machine # [ 49.965658] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1631machine # [ 49.974206] systemd[572]: Stopped Run user-specific NixOS activation.1632machine # [ 49.976694] systemd[572]: Stopping Run user-specific NixOS activation...1633machine # [ 49.978977] systemd[572]: Starting Run user-specific NixOS activation...1634machine # [ 50.011743] systemd[572]: Finished Run user-specific NixOS activation.1635machine # [ 50.015687] systemd[1]: Stopped target Reactivate sysinit units.1636machine # [ 50.017182] systemd[1]: Stopping Reactivate sysinit units...1637machine # [ 50.018042] systemd[1]: Reached target Reactivate sysinit units.1638machine # [ 50.020923] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1639machine # [ 50.024871] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1640machine # [ 50.028485] systemd[1]: Reached target Remote File Systems.1641machine # [ 50.032194] systemd[1]: Starting -.service...1642machine # [ 50.035453] systemd[1]: Starting linger-users.service...1643machine # [ 50.052644] systemd[1]: Reached target Local File Systems.1644machine # [ 50.053979] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1645machine # [ 50.061103] systemd[1]: Starting Create SUID/SGID Wrappers...1646machine # [ 50.068601] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1647machine # [ 50.076323] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671648machine # [ 50.078606] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1649machine # [ 50.089578] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1650machine # [ 50.090903] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1651machine # [ 50.102711] systemd[1]: Finished -.service.1652machine # [ 50.135848] systemd[1]: linger-users.service: Deactivated successfully.1653machine # [ 50.138282] systemd[1]: Finished linger-users.service.1654machine # [ 50.268990] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1655machine # [ 50.271354] systemd[1]: Finished Create SUID/SGID Wrappers.1656machine # [ 50.528428] nixos[3154]: finished switching to system configuration /nix/store/gpzzbfjp6i4zvkqlac89sfpbiap1hr5c-nixos-system-machine-test1657machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.81 seconds)1658machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&11659machine # [ 50.752469] nixos[3296]: switching to system configuration /nix/store/mq380y2gl9nkbvdxy9wk2izmcp48d123-nixos-system-machine-test1660machine # [ 50.757344] systemd[1]: Stopped target Local File Systems.1661machine # [ 50.758220] systemd[1]: Stopped target Remote File Systems.1662machine # [ 51.070481] systemd[1]: Reload requested from client PID 3296 ('.switch-to-conf') (unit backdoor.service)...1663machine # [ 51.072670] systemd[1]: Reloading...1664machine # [ 51.413354] systemd[1]: Reloading finished in 339 ms.1665machine # [ 51.497333] systemd[572]: Reexecution requested from client PID 3365 ('switch-to-confi')...1666machine # [ 51.501355] systemd[572]: Reexecuting.1667machine # [ 51.559794] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1668machine # [ 51.675668] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1669machine # [ 51.684228] systemd[572]: Reload requested from client PID 3365 ('switch-to-confi')...1670machine # [ 51.685661] systemd[572]: Reloading...1671machine # [ 51.797979] systemd[572]: Reloading finished in 110 ms.1672machine # [ 51.812179] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1673machine # [ 51.822092] systemd[572]: Stopped Run user-specific NixOS activation.1674machine # [ 51.824707] systemd[572]: Stopping Run user-specific NixOS activation...1675machine # [ 51.827083] systemd[572]: Starting Run user-specific NixOS activation...1676machine # [ 51.860607] systemd[572]: Finished Run user-specific NixOS activation.1677machine # [ 51.865114] systemd[1]: Stopped target Reactivate sysinit units.1678machine # [ 51.869683] systemd[1]: Stopping Reactivate sysinit units...1679machine # [ 51.870628] systemd[1]: Reached target Reactivate sysinit units.1680machine # [ 51.872791] systemd[1]: Reloading -.service...1681machine # [ 51.898996] systemd[1]: Reloaded -.service.1682machine # [ 51.902957] systemd[1]: Reached target Remote File Systems.1683machine # [ 51.905859] systemd[1]: Reached target Local File Systems.1684machine # [ 51.911028] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1685machine # [ 51.914641] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1686machine # [ 51.920211] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1687machine # [ 51.930100] systemd[1]: Starting Create SUID/SGID Wrappers...1688machine # [ 51.931135] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1689machine # [ 51.932738] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671690machine # [ 51.935078] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1691machine # [ 51.940505] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1692machine # [ 51.941931] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1693machine # [ 52.107092] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1694machine # [ 52.112974] systemd[1]: Finished Create SUID/SGID Wrappers.1695machine # [ 52.116512] systemd[1]: Starting linger-users.service...1696machine # [ 52.166875] systemd[1]: linger-users.service: Deactivated successfully.1697machine # [ 52.170341] systemd[1]: Finished linger-users.service.1698machine # [ 52.424535] nixos[3296]: finished switching to system configuration /nix/store/mq380y2gl9nkbvdxy9wk2izmcp48d123-nixos-system-machine-test1699machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.90 seconds)1700machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&11701machine # [ 52.661088] nixos[3438]: switching to system configuration /nix/store/7k90apj497ay3yjqh1all38zz650i1d6-nixos-system-machine-test1702machine # [ 52.663661] systemd[1]: -.service: Deactivated successfully.1703machine # [ 52.667701] systemd[1]: Stopped -.service.1704machine # [ 52.668675] systemd[1]: Stopped target Remote File Systems.1705machine # [ 52.669481] systemd[1]: Stopped target Local File Systems.1706machine # [ 52.965224] systemd[1]: Reload requested from client PID 3438 ('.switch-to-conf') (unit backdoor.service)...1707machine # [ 52.967429] systemd[1]: Reloading...1708machine # [ 53.293042] systemd[1]: Reloading finished in 324 ms.1709machine # [ 53.389320] systemd[572]: Reexecution requested from client PID 3507 ('switch-to-confi')...1710machine # [ 53.393648] systemd[572]: Reexecuting.1711machine # [ 53.447796] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1712machine # [ 53.565501] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1713machine # [ 53.572670] systemd[572]: Reload requested from client PID 3507 ('switch-to-confi')...1714machine # [ 53.576170] systemd[572]: Reloading...1715machine # [ 53.684974] systemd[572]: Reloading finished in 109 ms.1716machine # [ 53.700197] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1717machine # [ 53.710577] systemd[572]: Stopped Run user-specific NixOS activation.1718machine # [ 53.713056] systemd[572]: Stopping Run user-specific NixOS activation...1719machine # [ 53.715237] systemd[572]: Starting Run user-specific NixOS activation...1720machine # [ 53.747329] systemd[572]: Finished Run user-specific NixOS activation.1721machine # [ 53.751401] systemd[1]: Stopped target Reactivate sysinit units.1722machine # [ 53.753337] systemd[1]: Stopping Reactivate sysinit units...1723machine # [ 53.754243] systemd[1]: Reached target Reactivate sysinit units.1724machine # [ 53.758261] systemd[1]: Reached target Remote File Systems.1725machine # [ 53.764151] systemd[1]: Starting linger-users.service...1726machine # [ 53.769897] systemd[1]: Starting required-service.service...1727machine # [ 53.770830] systemd[1]: Starting test-service.service...1728machine # [ 53.790620] systemd[1]: Reached target Local File Systems.1729machine # [ 53.791568] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1730machine # [ 53.806692] systemd[1]: Starting Create SUID/SGID Wrappers...1731machine # [ 53.807650] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1732machine # [ 53.821003] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671733machine # [ 53.833232] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1734machine # [ 53.843486] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1735machine # [ 53.850217] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1736machine # [ 53.851609] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1737machine # [ 53.864451] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1738machine # [ 53.865869] systemd[1]: Finished test-service.service.1739machine # [ 53.866634] systemd[1]: Finished required-service.service.1740machine # [ 53.894396] systemd[1]: linger-users.service: Deactivated successfully.1741machine # [ 53.898128] systemd[1]: Finished linger-users.service.1742machine # [ 54.037169] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1743machine # [ 54.041015] systemd[1]: Finished Create SUID/SGID Wrappers.1744machine # [ 54.295770] nixos[3438]: finished switching to system configuration /nix/store/7k90apj497ay3yjqh1all38zz650i1d6-nixos-system-machine-test1745machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.87 seconds)1746machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&11747machine # [ 54.523753] nixos[3582]: switching to system configuration /nix/store/1jm7a27f9anlbalqjqz93brw19pwb05n-nixos-system-machine-test1748machine # [ 54.527078] systemd[1]: Stopped target Remote File Systems.1749machine # [ 54.528946] systemd[1]: required-service.service: Deactivated successfully.1750machine # [ 54.532541] systemd[1]: Stopped required-service.service.1751machine # [ 54.534015] systemd[1]: test-service.service: Deactivated successfully.1752machine # [ 54.534975] systemd[1]: Stopped test-service.service.1753machine # [ 54.535711] systemd[1]: Stopped target Local File Systems.1754machine # [ 54.826543] systemd[1]: Reload requested from client PID 3582 ('.switch-to-conf') (unit backdoor.service)...1755machine # [ 54.828786] systemd[1]: Reloading...1756machine # [ 55.150764] systemd[1]: Reloading finished in 320 ms.1757machine # [ 55.232995] systemd[572]: Reexecution requested from client PID 3651 ('switch-to-confi')...1758machine # [ 55.237343] systemd[572]: Reexecuting.1759machine # [ 55.291321] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1760machine # [ 55.405709] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1761machine # [ 55.412662] systemd[572]: Reload requested from client PID 3651 ('switch-to-confi')...1762machine # [ 55.415179] systemd[572]: Reloading...1763machine # [ 55.522307] systemd[572]: Reloading finished in 106 ms.1764machine # [ 55.536168] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1765machine # [ 55.546144] systemd[572]: Stopped Run user-specific NixOS activation.1766machine # [ 55.548595] systemd[572]: Stopping Run user-specific NixOS activation...1767machine # [ 55.550752] systemd[572]: Starting Run user-specific NixOS activation...1768machine # [ 55.584136] systemd[572]: Finished Run user-specific NixOS activation.1769machine # [ 55.587797] systemd[1]: Stopped target Reactivate sysinit units.1770machine # [ 55.589992] systemd[1]: Stopping Reactivate sysinit units...1771machine # [ 55.590891] systemd[1]: Reached target Reactivate sysinit units.1772machine # [ 55.596580] systemd[1]: Reached target Remote File Systems.1773machine # [ 55.601830] systemd[1]: Starting linger-users.service...1774machine # [ 55.606040] systemd[1]: Starting required-service.service...1775machine # [ 55.616391] systemd[1]: Starting test-service.service...1776machine # [ 55.624667] systemd[1]: Reached target Local File Systems.1777machine # [ 55.630889] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1778machine # [ 55.636433] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1779machine # [ 55.637796] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1780machine # [ 55.646768] systemd[1]: Starting Create SUID/SGID Wrappers...1781machine # [ 55.647725] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1782machine # [ 55.659576] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671783machine # [ 55.670021] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1784machine # [ 55.680460] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1785machine # [ 55.681864] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1786machine # [ 55.697592] systemd[1]: Finished test-service.service.1787machine # [ 55.705359] systemd[1]: Finished required-service.service.1788machine # [ 55.740126] systemd[1]: linger-users.service: Deactivated successfully.1789machine # [ 55.742283] systemd[1]: Finished linger-users.service.1790machine # [ 55.880346] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1791machine # [ 55.883486] systemd[1]: Finished Create SUID/SGID Wrappers.1792machine # [ 56.139390] nixos[3582]: finished switching to system configuration /nix/store/1jm7a27f9anlbalqjqz93brw19pwb05n-nixos-system-machine-test1793machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.84 seconds)1794machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&11795machine # [ 56.384518] nixos[3726]: switching to system configuration /nix/store/5v1w1znf2s3qn992q1hicxs3nqd2k8zl-nixos-system-machine-test1796machine # [ 56.387577] systemd[1]: required-service.service: Deactivated successfully.1797machine # [ 56.391121] systemd[1]: Stopped required-service.service.1798machine # [ 56.392945] systemd[1]: test-service.service: Deactivated successfully.1799machine # [ 56.394760] systemd[1]: Stopped test-service.service.1800machine # [ 56.395531] systemd[1]: Stopped target Remote File Systems.1801machine # [ 56.396820] systemd[1]: Stopped target Local File Systems.1802machine # [ 56.699378] systemd[1]: Reload requested from client PID 3726 ('.switch-to-conf') (unit backdoor.service)...1803machine # [ 56.701798] systemd[1]: Reloading...1804machine # [ 57.023278] systemd[1]: Reloading finished in 320 ms.1805machine # [ 57.111636] systemd[572]: Reexecution requested from client PID 3795 ('switch-to-confi')...1806machine # [ 57.116674] systemd[572]: Reexecuting.1807machine # [ 57.159291] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1808machine # [ 57.272079] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1809machine # [ 57.279152] systemd[572]: Reload requested from client PID 3795 ('switch-to-confi')...1810machine # [ 57.281743] systemd[572]: Reloading...1811machine # [ 57.393861] systemd[572]: Reloading finished in 109 ms.1812machine # [ 57.408183] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1813machine # [ 57.418871] systemd[572]: Stopped Run user-specific NixOS activation.1814machine # [ 57.421418] systemd[572]: Stopping Run user-specific NixOS activation...1815machine # [ 57.423795] systemd[572]: Starting Run user-specific NixOS activation...1816machine # [ 57.456357] systemd[572]: Finished Run user-specific NixOS activation.1817machine # [ 57.460937] systemd[1]: Stopped target Reactivate sysinit units.1818machine # [ 57.462888] systemd[1]: Stopping Reactivate sysinit units...1819machine # [ 57.463773] systemd[1]: Reached target Reactivate sysinit units.1820machine # [ 57.469377] systemd[1]: Starting required-service.service...1821machine # [ 57.479467] systemd[1]: Reached target Local File Systems.1822machine # [ 57.481053] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1823machine # [ 57.490740] systemd[1]: Starting Create SUID/SGID Wrappers...1824machine # [ 57.491763] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1825machine # [ 57.498407] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671826machine # [ 57.511066] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1827machine # [ 57.516149] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1828machine # [ 57.521369] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1829machine # [ 57.526447] systemd[1]: Reached target Remote File Systems.1830machine # [ 57.527378] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1831machine # [ 57.534062] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1832machine # [ 57.543405] systemd[1]: Finished required-service.service.1833machine # [ 57.691660] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1834machine # [ 57.696681] systemd[1]: Finished Create SUID/SGID Wrappers.1835machine # [ 57.700274] systemd[1]: Starting linger-users.service...1836machine # [ 57.704232] systemd[1]: Starting test-service.service...1837machine # [ 57.743623] systemd[1]: Finished test-service.service.1838machine # [ 57.766964] systemd[1]: linger-users.service: Deactivated successfully.1839machine # [ 57.769661] systemd[1]: Finished linger-users.service.1840machine # [ 58.026374] nixos[3726]: finished switching to system configuration /nix/store/5v1w1znf2s3qn992q1hicxs3nqd2k8zl-nixos-system-machine-test1841machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.89 seconds)1842machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&11843machine # [ 58.263085] nixos[3870]: switching to system configuration /nix/store/sb4702phq0kf63a9iq7psx4abimvldc1-nixos-system-machine-test1844machine # [ 58.265774] systemd[1]: Stopped target Local File Systems.1845machine # [ 58.268512] systemd[1]: test-service.service: Deactivated successfully.1846machine # [ 58.269524] systemd[1]: Stopped test-service.service.1847machine # [ 58.271071] systemd[1]: required-service.service: Deactivated successfully.1848machine # [ 58.273644] systemd[1]: Stopped required-service.service.1849machine # [ 58.274481] systemd[1]: Stopped target Remote File Systems.1850machine # [ 58.570144] systemd[1]: Reload requested from client PID 3870 ('.switch-to-conf') (unit backdoor.service)...1851machine # [ 58.572337] systemd[1]: Reloading...1852machine # [ 58.894859] systemd[1]: Reloading finished in 321 ms.1853machine # [ 58.977641] systemd[572]: Reexecution requested from client PID 3939 ('switch-to-confi')...1854machine # [ 58.981414] systemd[572]: Reexecuting.1855machine # [ 59.039490] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1856machine # [ 59.150646] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1857machine # [ 59.157653] systemd[572]: Reload requested from client PID 3939 ('switch-to-confi')...1858machine # [ 59.161298] systemd[572]: Reloading...1859machine # [ 59.265532] systemd[572]: Reloading finished in 105 ms.1860machine # [ 59.280175] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1861machine # [ 59.289715] systemd[572]: Stopped Run user-specific NixOS activation.1862machine # [ 59.292122] systemd[572]: Stopping Run user-specific NixOS activation...1863machine # [ 59.294561] systemd[572]: Starting Run user-specific NixOS activation...1864machine # [ 59.322997] systemd[572]: Finished Run user-specific NixOS activation.1865machine # [ 59.326820] systemd[1]: Stopped target Reactivate sysinit units.1866machine # [ 59.332481] systemd[1]: Stopping Reactivate sysinit units...1867machine # [ 59.333401] systemd[1]: Reached target Reactivate sysinit units.1868machine # [ 59.334258] systemd[1]: Reached target Local File Systems.1869machine # [ 59.335039] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1870machine # [ 59.344744] systemd[1]: Starting Create SUID/SGID Wrappers...1871machine # [ 59.355352] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1872machine # [ 59.359367] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671873machine # [ 59.361795] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1874machine # [ 59.363387] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1875machine # [ 59.365391] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1876machine # [ 59.366689] systemd[1]: Reached target Remote File Systems.1877machine # [ 59.368001] systemd[1]: Created slice Slice /system/instantiated.1878machine # [ 59.369784] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1879machine # [ 59.372744] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1880machine # [ 59.519993] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1881machine # [ 59.521928] systemd[1]: Finished Create SUID/SGID Wrappers.1882machine # [ 59.526633] systemd[1]: Starting instantiated@one.service...1883machine # [ 59.531721] systemd[1]: Starting instantiated@two.service...1884machine # [ 59.536374] systemd[1]: Starting linger-users.service...1885machine # [ 59.587261] systemd[1]: Finished instantiated@one.service.1886machine # [ 59.591158] systemd[1]: Finished instantiated@two.service.1887machine # [ 59.606980] systemd[1]: linger-users.service: Deactivated successfully.1888machine # [ 59.610061] systemd[1]: Finished linger-users.service.1889machine # [ 59.865447] nixos[3870]: finished switching to system configuration /nix/store/sb4702phq0kf63a9iq7psx4abimvldc1-nixos-system-machine-test1890machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.84 seconds)1891machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&11892machine # [ 60.105951] nixos[4014]: switching to system configuration /nix/store/1wmfl9vwnihrj1gg0na8dsn872miqc59-nixos-system-machine-test1893machine # [ 60.108608] systemd[1]: instantiated@two.service: Deactivated successfully.1894machine # [ 60.112438] systemd[1]: Stopped instantiated@two.service.1895machine # [ 60.113322] systemd[1]: Stopped target Remote File Systems.1896machine # [ 60.114144] systemd[1]: instantiated@one.service: Deactivated successfully.1897machine # [ 60.115137] systemd[1]: Stopped instantiated@one.service.1898machine # [ 60.116662] systemd[1]: Stopped target Local File Systems.1899machine # [ 60.401250] systemd[1]: Reload requested from client PID 4014 ('.switch-to-conf') (unit backdoor.service)...1900machine # [ 60.403226] systemd[1]: Reloading...1901machine # [ 60.725932] systemd[1]: Reloading finished in 320 ms.1902machine # [ 60.809134] systemd[572]: Reexecution requested from client PID 4083 ('switch-to-confi')...1903machine # [ 60.813444] systemd[572]: Reexecuting.1904machine # [ 60.871499] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1905machine # [ 60.985716] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1906machine # [ 60.992311] systemd[572]: Reload requested from client PID 4083 ('switch-to-confi')...1907machine # [ 60.996062] systemd[572]: Reloading...1908machine # [ 61.101266] systemd[572]: Reloading finished in 106 ms.1909machine # [ 61.116170] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1910machine # [ 61.126773] systemd[572]: Stopped Run user-specific NixOS activation.1911machine # [ 61.129189] systemd[572]: Stopping Run user-specific NixOS activation...1912machine # [ 61.131284] systemd[572]: Starting Run user-specific NixOS activation...1913machine # [ 61.164344] systemd[572]: Finished Run user-specific NixOS activation.1914machine # [ 61.168332] systemd[1]: Stopped target Reactivate sysinit units.1915machine # [ 61.169751] systemd[1]: Stopping Reactivate sysinit units...1916machine # [ 61.170578] systemd[1]: Reached target Reactivate sysinit units.1917machine # [ 61.174295] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1918machine # [ 61.179660] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1919machine # [ 61.182555] systemd[1]: Starting instantiated@one.service...1920machine # [ 61.186950] systemd[1]: Reached target Local File Systems.1921machine # [ 61.196308] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1922machine # [ 61.200951] systemd[1]: Starting Create SUID/SGID Wrappers...1923machine # [ 61.201864] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1924machine # [ 61.203149] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671925machine # [ 61.216985] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1926machine # [ 61.218735] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1927machine # [ 61.226135] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1928machine # [ 61.227496] systemd[1]: Reached target Remote File Systems.1929machine # [ 61.245035] systemd[1]: Finished instantiated@one.service.1930machine # [ 61.390488] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1931machine # [ 61.393522] systemd[1]: Finished Create SUID/SGID Wrappers.1932machine # [ 61.397369] systemd[1]: Starting instantiated@two.service...1933machine # [ 61.401642] systemd[1]: Starting linger-users.service...1934machine # [ 61.440112] systemd[1]: Finished instantiated@two.service.1935machine # [ 61.457466] systemd[1]: linger-users.service: Deactivated successfully.1936machine # [ 61.460591] systemd[1]: Finished linger-users.service.1937machine # [ 61.715065] nixos[4014]: finished switching to system configuration /nix/store/1wmfl9vwnihrj1gg0na8dsn872miqc59-nixos-system-machine-test1938machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.85 seconds)1939(finished: subtest: services, in 40.18 seconds)1940subtest: failing units1941machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11942machine # [ 61.934423] nixos[4158]: switching to system configuration /nix/store/02xxghd394vm6b94phmga3r2w3kiyyhn-nixos-system-machine-test1943machine # [ 61.937331] systemd[1]: instantiated@one.service: Deactivated successfully.1944machine # [ 61.941064] systemd[1]: Stopped instantiated@one.service.1945machine # [ 61.941927] systemd[1]: Stopped target Local File Systems.1946machine # [ 61.942702] systemd[1]: instantiated@two.service: Deactivated successfully.1947machine # [ 61.943658] systemd[1]: Stopped instantiated@two.service.1948machine # [ 61.945659] systemd[1]: Stopped target Remote File Systems.1949machine # [ 62.216258] systemd[1]: Reload requested from client PID 4158 ('.switch-to-conf') (unit backdoor.service)...1950machine # [ 62.218203] systemd[1]: Reloading...1951machine # [ 62.521166] systemd[1]: Reloading finished in 301 ms.1952machine # [ 62.604431] systemd[572]: Reexecution requested from client PID 4227 ('switch-to-confi')...1953machine # [ 62.607843] systemd[572]: Reexecuting.1954machine # [ 62.671644] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1955machine # [ 62.789435] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1956machine # [ 62.796070] systemd[572]: Reload requested from client PID 4227 ('switch-to-confi')...1957machine # [ 62.798409] systemd[572]: Reloading...1958machine # [ 62.904948] systemd[572]: Reloading finished in 105 ms.1959machine # [ 62.920161] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1960machine # [ 62.930111] systemd[572]: Stopped Run user-specific NixOS activation.1961machine # [ 62.932554] systemd[572]: Stopping Run user-specific NixOS activation...1962machine # [ 62.934620] systemd[572]: Starting Run user-specific NixOS activation...1963machine # [ 62.966594] systemd[572]: Finished Run user-specific NixOS activation.1964machine # [ 62.970712] systemd[1]: Stopped target Reactivate sysinit units.1965machine # [ 62.973562] systemd[1]: Stopping Reactivate sysinit units...1966machine # [ 62.974463] systemd[1]: Reached target Reactivate sysinit units.1967machine # [ 62.978437] systemd[1]: Reached target Local File Systems.1968machine # [ 62.979277] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1969machine # [ 62.989515] systemd[1]: Starting Create SUID/SGID Wrappers...1970machine # [ 62.990399] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1971machine # [ 62.991634] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671972machine # [ 63.002464] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1973machine # [ 63.004243] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1974machine # [ 63.005509] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1975machine # [ 63.006740] systemd[1]: Reached target Remote File Systems.1976machine # [ 63.007533] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1977machine # [ 63.010155] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1978machine # [ 63.158171] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1979machine # [ 63.160129] systemd[1]: Finished Create SUID/SGID Wrappers.1980machine # [ 63.166024] systemd[1]: Starting linger-users.service...1981machine # [ 63.169272] systemd[1]: Starting test.service...1982machine # [ 63.207728] systemd[1]: Finished test.service.1983machine # [ 63.225464] systemd[1]: linger-users.service: Deactivated successfully.1984machine # [ 63.228180] systemd[1]: Finished linger-users.service.1985machine # [ 63.484473] nixos[4158]: finished switching to system configuration /nix/store/02xxghd394vm6b94phmga3r2w3kiyyhn-nixos-system-machine-test1986machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.77 seconds)1987machine: must fail: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&11988machine # [ 63.715025] nixos[4300]: switching to system configuration /nix/store/3kybcslfnz9ljg9zdmv0cvc50k6ydz06-nixos-system-machine-test1989machine # [ 63.717786] systemd[1]: test.service: Deactivated successfully.1990machine # [ 63.721370] systemd[1]: Stopped test.service.1991machine # [ 63.722148] systemd[1]: Stopped target Local File Systems.1992machine # [ 63.722931] systemd[1]: Stopped target Remote File Systems.1993machine # [ 64.015283] systemd[1]: Reload requested from client PID 4300 ('.switch-to-conf') (unit backdoor.service)...1994machine # [ 64.017492] systemd[1]: Reloading...1995machine # [ 64.346172] systemd[1]: Reloading finished in 327 ms.1996machine # [ 64.450377] systemd[572]: Reexecution requested from client PID 4369 ('switch-to-confi')...1997machine # [ 64.454832] systemd[572]: Reexecuting.1998machine # [ 64.520701] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1999machine # [ 64.658879] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2000machine # [ 64.666733] systemd[572]: Reload requested from client PID 4369 ('switch-to-confi')...2001machine # [ 64.669500] systemd[572]: Reloading...2002machine # [ 64.785637] systemd[572]: Reloading finished in 113 ms.2003machine # [ 64.801789] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2004machine # [ 64.811429] systemd[572]: Stopped Run user-specific NixOS activation.2005machine # [ 64.814417] systemd[572]: Stopping Run user-specific NixOS activation...2006machine # [ 64.816979] systemd[572]: Starting Run user-specific NixOS activation...2007machine # [ 64.858669] systemd[572]: Finished Run user-specific NixOS activation.2008machine # [ 64.863418] systemd[1]: Stopped target Reactivate sysinit units.2009machine # [ 64.866776] systemd[1]: Stopping Reactivate sysinit units...2010machine # [ 64.867745] systemd[1]: Reached target Reactivate sysinit units.2011machine # [ 64.870324] systemd[1]: Reached target Remote File Systems.2012machine # [ 64.873007] systemd[1]: Reached target Local File Systems.2013machine # [ 64.879408] systemd[1]: Starting test.service...2014machine # [ 64.890205] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2015machine # [ 64.891722] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2016machine # [ 64.896671] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2017machine # [ 64.906633] systemd[1]: Starting Create SUID/SGID Wrappers...2018machine # [ 64.907797] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2019machine # [ 64.921486] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672020machine # [ 64.928580] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2021machine # [ 64.933453] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2022machine # [ 64.934905] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2023machine # [ 64.953374] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE2024machine # [ 64.959609] systemd[1]: test.service: Failed with result 'exit-code'.2025machine # [ 64.962015] systemd[1]: Failed to start test.service.2026machine # [ 65.145890] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2027machine # [ 65.151838] systemd[1]: Finished Create SUID/SGID Wrappers.2028machine # [ 65.154863] systemd[1]: Starting linger-users.service...2029machine # [ 65.208568] systemd[1]: linger-users.service: Deactivated successfully.2030machine # [ 65.212209] systemd[1]: Finished linger-users.service.2031machine # [ 65.493805] nixos[4300]: switching to system configuration /nix/store/3kybcslfnz9ljg9zdmv0cvc50k6ydz06-nixos-system-machine-test failed (status 4)2032machine: (finished: must fail: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 2.01 seconds)2033machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12034machine # [ 65.730793] nixos[4443]: switching to system configuration /nix/store/w4id3z1vbq7s1k8r1hmrh863g3jgg6is-nixos-system-machine-test2035machine # [ 65.733610] systemd[1]: Stopped target Remote File Systems.2036machine # [ 65.736053] systemd[1]: Stopped target Local File Systems.2037machine # [ 66.034760] systemd[1]: Reload requested from client PID 4443 ('.switch-to-conf') (unit backdoor.service)...2038machine # [ 66.037056] systemd[1]: Reloading...2039machine # [ 66.361246] systemd[1]: Reloading finished in 322 ms.2040machine # [ 66.453211] systemd[572]: Reexecution requested from client PID 4511 ('switch-to-confi')...2041machine # [ 66.458261] systemd[572]: Reexecuting.2042machine # [ 66.511489] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2043machine # [ 66.626018] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2044machine # [ 66.633158] systemd[572]: Reload requested from client PID 4511 ('switch-to-confi')...2045machine # [ 66.635465] systemd[572]: Reloading...2046machine # [ 66.746768] systemd[572]: Reloading finished in 110 ms.2047machine # [ 66.764201] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2048machine # [ 66.773910] systemd[572]: Stopped Run user-specific NixOS activation.2049machine # [ 66.776128] systemd[572]: Stopping Run user-specific NixOS activation...2050machine # [ 66.778662] systemd[572]: Starting Run user-specific NixOS activation...2051machine # [ 66.812823] systemd[572]: Finished Run user-specific NixOS activation.2052machine # [ 66.816814] systemd[1]: Stopped target Reactivate sysinit units.2053machine # [ 66.818907] systemd[1]: Stopping Reactivate sysinit units...2054machine # [ 66.819885] systemd[1]: Reached target Reactivate sysinit units.2055machine # [ 66.825684] systemd[1]: Reached target Local File Systems.2056machine # [ 66.826575] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2057machine # [ 66.837613] systemd[1]: Starting Create SUID/SGID Wrappers...2058machine # [ 66.838490] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2059machine # [ 66.839779] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672060machine # [ 66.844671] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2061machine # [ 66.846403] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2062machine # [ 66.847701] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2063machine # [ 66.858601] systemd[1]: Reached target Remote File Systems.2064machine # [ 66.859571] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2065machine # [ 66.866597] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2066machine # [ 67.016526] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2067machine # [ 67.020593] systemd[1]: Finished Create SUID/SGID Wrappers.2068machine # [ 67.024469] systemd[1]: Started autorestart.service.2069machine # [ 67.029470] systemd[1]: Starting linger-users.service...2070machine # [ 67.069285] systemd[1]: autorestart.service: Deactivated successfully.2071machine # [ 67.089312] systemd[1]: linger-users.service: Deactivated successfully.2072machine # [ 67.092617] systemd[1]: Finished linger-users.service.2073machine # [ 67.348590] nixos[4443]: finished switching to system configuration /nix/store/w4id3z1vbq7s1k8r1hmrh863g3jgg6is-nixos-system-machine-test2074machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.85 seconds)2075machine # [ 67.391706] systemd[1]: Stopped autorestart.service.2076machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12077machine # [ 67.592523] nixos[4590]: switching to system configuration /nix/store/w4id3z1vbq7s1k8r1hmrh863g3jgg6is-nixos-system-machine-test2078machine # [ 67.595013] systemd[1]: Stopped target Local File Systems.2079machine # [ 67.597072] systemd[1]: Stopped target Remote File Systems.2080machine # [ 67.877416] systemd[1]: Reload requested from client PID 4590 ('.switch-to-conf') (unit backdoor.service)...2081machine # [ 67.879515] systemd[1]: Reloading...2082machine # [ 68.198617] systemd[1]: Reloading finished in 317 ms.2083machine # [ 68.282754] systemd[572]: Reexecution requested from client PID 4659 ('switch-to-confi')...2084machine # [ 68.287247] systemd[572]: Reexecuting.2085machine # [ 68.339463] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2086machine # [ 68.451520] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2087machine # [ 68.458730] systemd[572]: Reload requested from client PID 4659 ('switch-to-confi')...2088machine # [ 68.461612] systemd[572]: Reloading...2089machine # [ 68.570733] systemd[572]: Reloading finished in 108 ms.2090machine # [ 68.588208] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2091machine # [ 68.597652] systemd[572]: Stopped Run user-specific NixOS activation.2092machine # [ 68.600072] systemd[572]: Stopping Run user-specific NixOS activation...2093machine # [ 68.602300] systemd[572]: Starting Run user-specific NixOS activation...2094machine # [ 68.636357] systemd[572]: Finished Run user-specific NixOS activation.2095machine # [ 68.641042] systemd[1]: Stopped target Reactivate sysinit units.2096machine # [ 68.642047] systemd[1]: Stopping Reactivate sysinit units...2097machine # [ 68.642854] systemd[1]: Reached target Reactivate sysinit units.2098machine # [ 68.646191] systemd[1]: Reached target Local File Systems.2099machine # [ 68.649895] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2100machine # [ 68.653871] systemd[1]: Starting Create SUID/SGID Wrappers...2101machine # [ 68.654797] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2102machine # [ 68.662716] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672103machine # [ 68.671289] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2104machine # [ 68.677035] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2105machine # [ 68.678396] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2106machine # [ 68.679610] systemd[1]: Reached target Remote File Systems.2107machine # [ 68.680531] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2108machine # [ 68.681878] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2109machine # [ 68.872476] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2110machine # [ 68.876362] systemd[1]: Finished Create SUID/SGID Wrappers.2111machine # [ 68.880297] systemd[1]: Started autorestart.service.2112machine # [ 68.886084] systemd[1]: Starting linger-users.service...2113machine # [ 68.926196] systemd[1]: autorestart.service: Deactivated successfully.2114machine # [ 68.946964] systemd[1]: linger-users.service: Deactivated successfully.2115machine # [ 68.949939] systemd[1]: Finished linger-users.service.2116machine # [ 69.207222] nixos[4590]: finished switching to system configuration /nix/store/w4id3z1vbq7s1k8r1hmrh863g3jgg6is-nixos-system-machine-test2117machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.82 seconds)2118machine # [ 69.251087] systemd[1]: Stopped autorestart.service.2119machine: must fail: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&12120machine # [ 69.478386] nixos[4737]: switching to system configuration /nix/store/pma3xfdgq771rzks9invgrmsqbx0z0ak-nixos-system-machine-test2121machine # [ 69.480904] systemd[1]: Stopped target Remote File Systems.2122machine # [ 69.483226] systemd[1]: Stopped target Local File Systems.2123machine # [ 69.784510] systemd[1]: Reload requested from client PID 4737 ('.switch-to-conf') (unit backdoor.service)...2124machine # [ 69.786595] systemd[1]: Reloading...2125machine # [ 70.126806] systemd[1]: Reloading finished in 338 ms.2126machine # [ 70.215391] systemd[572]: Reexecution requested from client PID 4806 ('switch-to-confi')...2127machine # [ 70.219872] systemd[572]: Reexecuting.2128machine # [ 70.275675] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2129machine # [ 70.392583] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2130machine # [ 70.400146] systemd[572]: Reload requested from client PID 4806 ('switch-to-confi')...2131machine # [ 70.401675] systemd[572]: Reloading...2132machine # [ 70.509512] systemd[572]: Reloading finished in 106 ms.2133machine # [ 70.528181] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2134machine # [ 70.538762] systemd[572]: Stopped Run user-specific NixOS activation.2135machine # [ 70.541699] systemd[572]: Stopping Run user-specific NixOS activation...2136machine # [ 70.543964] systemd[572]: Starting Run user-specific NixOS activation...2137machine # [ 70.576398] systemd[572]: Finished Run user-specific NixOS activation.2138machine # [ 70.580579] systemd[1]: Stopped target Reactivate sysinit units.2139machine # [ 70.583484] systemd[1]: Stopping Reactivate sysinit units...2140machine # [ 70.585218] systemd[1]: Reached target Reactivate sysinit units.2141machine # [ 70.586902] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2142machine # [ 70.590971] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2143machine # [ 70.597943] systemd[1]: Reached target Local File Systems.2144machine # [ 70.598836] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2145machine # [ 70.604999] systemd[1]: Starting Create SUID/SGID Wrappers...2146machine # [ 70.605953] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2147machine # [ 70.607248] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672148machine # [ 70.618563] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2149machine # [ 70.621532] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2150machine # [ 70.622888] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2151machine # [ 70.625468] systemd[1]: Reached target Remote File Systems.2152machine # [ 70.781661] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2153machine # [ 70.786367] systemd[1]: Finished Create SUID/SGID Wrappers.2154machine # [ 70.788544] systemd[1]: Started autorestart.service.2155machine # [ 70.793544] systemd[1]: Starting linger-users.service...2156machine # [ 70.830123] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE2157machine # [ 70.835191] systemd[1]: autorestart.service: Failed with result 'exit-code'.2158machine # [ 70.853998] systemd[1]: linger-users.service: Deactivated successfully.2159machine # [ 70.855747] systemd[1]: Finished linger-users.service.2160machine # [ 71.134758] nixos[4737]: switching to system configuration /nix/store/pma3xfdgq771rzks9invgrmsqbx0z0ak-nixos-system-machine-test failed (status 4)2161machine: (finished: must fail: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.88 seconds)2162(finished: subtest: failing units, in 9.42 seconds)2163subtest: unit file parser2164machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12165machine # [ 71.349293] nixos[4880]: switching to system configuration /nix/store/89hgfl7546jyh2d52psxkwdh6yzfzl81-nixos-system-machine-test2166machine # [ 71.352068] systemd[1]: Stopped target Local File Systems.2167machine # [ 71.355991] systemd[1]: Stopped autorestart.service.2168machine # [ 71.356912] systemd[1]: Stopped target Remote File Systems.2169machine # [ 71.639386] systemd[1]: Reload requested from client PID 4880 ('.switch-to-conf') (unit backdoor.service)...2170machine # [ 71.641851] systemd[1]: Reloading...2171machine # [ 71.953177] systemd[1]: Reloading finished in 309 ms.2172machine # [ 72.037526] systemd[572]: Reexecution requested from client PID 4949 ('switch-to-confi')...2173machine # [ 72.041693] systemd[572]: Reexecuting.2174machine # [ 72.099894] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2175machine # [ 72.216624] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2176machine # [ 72.223626] systemd[572]: Reload requested from client PID 4949 ('switch-to-confi')...2177machine # [ 72.227285] systemd[572]: Reloading...2178machine # [ 72.332972] systemd[572]: Reloading finished in 106 ms.2179machine # [ 72.348177] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2180machine # [ 72.358032] systemd[572]: Stopped Run user-specific NixOS activation.2181machine # [ 72.360507] systemd[572]: Stopping Run user-specific NixOS activation...2182machine # [ 72.362690] systemd[572]: Starting Run user-specific NixOS activation...2183machine # [ 72.396433] systemd[572]: Finished Run user-specific NixOS activation.2184machine # [ 72.401096] systemd[1]: Stopped target Reactivate sysinit units.2185machine # [ 72.402613] systemd[1]: Stopping Reactivate sysinit units...2186machine # [ 72.403483] systemd[1]: Reached target Reactivate sysinit units.2187machine # [ 72.408784] systemd[1]: Reached target Remote File Systems.2188machine # [ 72.412121] systemd[1]: Starting linger-users.service...2189machine # [ 72.415377] systemd[1]: Starting test.service...2190machine # [ 72.424354] systemd[1]: Reached target Local File Systems.2191machine # [ 72.432607] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2192machine # [ 72.434044] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2193machine # [ 72.438977] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2194machine # [ 72.449357] systemd[1]: Starting Create SUID/SGID Wrappers...2195machine # [ 72.450309] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2196machine # [ 72.462615] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672197machine # [ 72.471459] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2198machine # [ 72.479090] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2199machine # [ 72.486905] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2200machine # [ 72.493938] systemd[1]: Finished test.service.2201machine # [ 72.527072] systemd[1]: linger-users.service: Deactivated successfully.2202machine # [ 72.531379] systemd[1]: Finished linger-users.service.2203machine # [ 72.667469] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2204machine # [ 72.671079] systemd[1]: Finished Create SUID/SGID Wrappers.2205machine # [ 72.926272] nixos[4880]: finished switching to system configuration /nix/store/89hgfl7546jyh2d52psxkwdh6yzfzl81-nixos-system-machine-test2206machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.79 seconds)2207machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&12208machine # [ 73.166731] nixos[5022]: switching to system configuration /nix/store/cqhvhkk6k0zv5q4c9s16qdlk3yy2ldl6-nixos-system-machine-test2209machine # [ 73.172390] systemd[1]: Stopped target Remote File Systems.2210machine # [ 73.173341] systemd[1]: Stopped target Local File Systems.2211machine # [ 73.477821] systemd[1]: Reload requested from client PID 5022 ('.switch-to-conf') (unit backdoor.service)...2212machine # [ 73.479848] systemd[1]: Reloading...2213machine # [ 73.805856] systemd[1]: Reloading finished in 324 ms.2214machine # [ 73.899427] systemd[572]: Reexecution requested from client PID 5091 ('switch-to-confi')...2215machine # [ 73.902062] systemd[572]: Reexecuting.2216machine # [ 73.960917] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2217machine # [ 74.084187] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2218machine # [ 74.091307] systemd[572]: Reload requested from client PID 5091 ('switch-to-confi')...2219machine # [ 74.094235] systemd[572]: Reloading...2220machine # [ 74.205806] systemd[572]: Reloading finished in 110 ms.2221machine # [ 74.220225] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2222machine # [ 74.230983] systemd[572]: Stopped Run user-specific NixOS activation.2223machine # [ 74.233707] systemd[572]: Stopping Run user-specific NixOS activation...2224machine # [ 74.236710] systemd[572]: Starting Run user-specific NixOS activation...2225machine # [ 74.275645] systemd[572]: Finished Run user-specific NixOS activation.2226machine # [ 74.281202] systemd[1]: Stopped target Reactivate sysinit units.2227machine # [ 74.282266] systemd[1]: Stopping Reactivate sysinit units...2228machine # [ 74.283101] systemd[1]: Reached target Reactivate sysinit units.2229machine # [ 74.286524] systemd[1]: test.service: Deactivated successfully.2230machine # [ 74.290232] systemd[1]: Stopped test.service.2231machine # [ 74.291074] systemd[1]: Stopping test.service...2232machine # [ 74.294476] systemd[1]: Starting test.service...2233machine # [ 74.322056] systemd[1]: Finished test.service.2234machine # [ 74.326878] systemd[1]: Reached target Remote File Systems.2235machine # [ 74.331263] systemd[1]: Starting linger-users.service...2236machine # [ 74.343110] systemd[1]: Reached target Local File Systems.2237machine # [ 74.345907] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2238machine # [ 74.347351] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2239machine # [ 74.351457] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2240machine # [ 74.361742] systemd[1]: Starting Create SUID/SGID Wrappers...2241machine # [ 74.362720] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2242machine # [ 74.367762] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672243machine # [ 74.374475] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2244machine # [ 74.379572] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2245machine # [ 74.383179] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2246machine # [ 74.428856] systemd[1]: linger-users.service: Deactivated successfully.2247machine # [ 74.432513] systemd[1]: Finished linger-users.service.2248machine # [ 74.571840] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2249machine # [ 74.573893] systemd[1]: Finished Create SUID/SGID Wrappers.2250machine # [ 74.831326] nixos[5022]: finished switching to system configuration /nix/store/cqhvhkk6k0zv5q4c9s16qdlk3yy2ldl6-nixos-system-machine-test2251machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.91 seconds)2252machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&12253machine # [ 75.074456] nixos[5164]: switching to system configuration /nix/store/0if8ap48y7crpsfs866y3mmjsjs1djvb-nixos-system-machine-test2254machine # [ 75.077257] systemd[1]: Stopped target Remote File Systems.2255machine # [ 75.079746] systemd[1]: Stopped target Local File Systems.2256machine # [ 75.390203] systemd[1]: Reload requested from client PID 5164 ('.switch-to-conf') (unit backdoor.service)...2257machine # [ 75.392470] systemd[1]: Reloading...2258machine # [ 75.717887] systemd[1]: Reloading finished in 323 ms.2259machine # [ 75.807562] systemd[572]: Reexecution requested from client PID 5233 ('switch-to-confi')...2260machine # [ 75.811375] systemd[572]: Reexecuting.2261machine # [ 75.863978] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2262machine # [ 75.981831] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2263machine # [ 75.988572] systemd[572]: Reload requested from client PID 5233 ('switch-to-confi')...2264machine # [ 75.992072] systemd[572]: Reloading...2265machine # [ 76.102068] systemd[572]: Reloading finished in 110 ms.2266machine # [ 76.120184] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2267machine # [ 76.130842] systemd[572]: Stopped Run user-specific NixOS activation.2268machine # [ 76.133395] systemd[572]: Stopping Run user-specific NixOS activation...2269machine # [ 76.135713] systemd[572]: Starting Run user-specific NixOS activation...2270machine # [ 76.168123] systemd[572]: Finished Run user-specific NixOS activation.2271machine # [ 76.172106] systemd[1]: Stopped target Reactivate sysinit units.2272machine # [ 76.176592] systemd[1]: Stopping Reactivate sysinit units...2273machine # [ 76.177531] systemd[1]: Reached target Reactivate sysinit units.2274machine # [ 76.178402] systemd[1]: test.service: Deactivated successfully.2275machine # [ 76.179274] systemd[1]: Stopped test.service.2276machine # [ 76.180862] systemd[1]: Stopping test.service...2277machine # [ 76.182587] systemd[1]: Starting test.service...2278machine # [ 76.209544] systemd[1]: Finished test.service.2279machine # [ 76.215175] systemd[1]: Reached target Local File Systems.2280machine # [ 76.221154] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2281machine # [ 76.222763] systemd[1]: Starting Create SUID/SGID Wrappers...2282machine # [ 76.223591] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2283machine # [ 76.237733] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672284machine # [ 76.241798] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2285machine # [ 76.243518] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2286machine # [ 76.245091] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2287machine # [ 76.246343] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2288machine # [ 76.247710] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2289machine # [ 76.249920] systemd[1]: Reached target Remote File Systems.2290machine # [ 76.407559] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2291machine # [ 76.412206] systemd[1]: Finished Create SUID/SGID Wrappers.2292machine # [ 76.414362] systemd[1]: Starting linger-users.service...2293machine # [ 76.458866] systemd[1]: linger-users.service: Deactivated successfully.2294machine # [ 76.461396] systemd[1]: Finished linger-users.service.2295machine # [ 76.717994] nixos[5164]: finished switching to system configuration /nix/store/0if8ap48y7crpsfs866y3mmjsjs1djvb-nixos-system-machine-test2296machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.89 seconds)2297machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12298machine # [ 76.956699] nixos[5306]: switching to system configuration /nix/store/89hgfl7546jyh2d52psxkwdh6yzfzl81-nixos-system-machine-test2299machine # [ 76.959239] systemd[1]: Stopped target Remote File Systems.2300machine # [ 76.961759] systemd[1]: Stopped target Local File Systems.2301machine # [ 77.256350] systemd[1]: Reload requested from client PID 5306 ('.switch-to-conf') (unit backdoor.service)...2302machine # [ 77.257977] systemd[1]: Reloading...2303machine # [ 77.582481] systemd[1]: Reloading finished in 322 ms.2304machine # [ 77.672449] systemd[572]: Reexecution requested from client PID 5375 ('switch-to-confi')...2305machine # [ 77.676117] systemd[572]: Reexecuting.2306machine # [ 77.736085] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2307machine # [ 77.857213] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2308machine # [ 77.865045] systemd[572]: Reload requested from client PID 5375 ('switch-to-confi')...2309machine # [ 77.866452] systemd[572]: Reloading...2310machine # [ 77.979564] systemd[572]: Reloading finished in 111 ms.2311machine # [ 77.996348] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2312machine # [ 78.008115] systemd[572]: Stopped Run user-specific NixOS activation.2313machine # [ 78.009221] systemd[572]: Stopping Run user-specific NixOS activation...2314machine # [ 78.012131] systemd[572]: Starting Run user-specific NixOS activation...2315machine # [ 78.045088] systemd[572]: Finished Run user-specific NixOS activation.2316machine # [ 78.049206] systemd[1]: Stopped target Reactivate sysinit units.2317machine # [ 78.051256] systemd[1]: Stopping Reactivate sysinit units...2318machine # [ 78.055374] systemd[1]: Reached target Reactivate sysinit units.2319machine # [ 78.056691] systemd[1]: test.service: Deactivated successfully.2320machine # [ 78.057703] systemd[1]: Stopped test.service.2321machine # [ 78.058371] systemd[1]: Stopping test.service...2322machine # [ 78.059999] systemd[1]: Starting test.service...2323machine # [ 78.087319] systemd[1]: Finished test.service.2324machine # [ 78.095450] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2325machine # [ 78.099080] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2326machine # [ 78.103260] systemd[1]: Reached target Local File Systems.2327machine # [ 78.104561] systemd[1]: Reached target Remote File Systems.2328machine # [ 78.109863] systemd[1]: Starting linger-users.service...2329machine # [ 78.116819] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2330machine # [ 78.124293] systemd[1]: Starting Create SUID/SGID Wrappers...2331machine # [ 78.125258] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2332machine # [ 78.126531] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672333machine # [ 78.136637] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2334machine # [ 78.138404] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2335machine # [ 78.139819] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2336machine # [ 78.208821] systemd[1]: linger-users.service: Deactivated successfully.2337machine # [ 78.213226] systemd[1]: Finished linger-users.service.2338machine # [ 78.345241] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2339machine # [ 78.348494] systemd[1]: Finished Create SUID/SGID Wrappers.2340machine # [ 78.604269] nixos[5306]: finished switching to system configuration /nix/store/89hgfl7546jyh2d52psxkwdh6yzfzl81-nixos-system-machine-test2341machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.89 seconds)2342machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&12343machine # [ 78.842673] nixos[5448]: switching to system configuration /nix/store/5f88nm5yhgcfci103bzpsnqd85v4l82b-nixos-system-machine-test2344machine # [ 78.845824] systemd[1]: Stopped target Remote File Systems.2345machine # [ 78.848653] systemd[1]: Stopped target Local File Systems.2346machine # [ 79.152464] systemd[1]: Reload requested from client PID 5448 ('.switch-to-conf') (unit backdoor.service)...2347machine # [ 79.154556] systemd[1]: Reloading...2348machine # [ 79.498080] systemd[1]: Reloading finished in 341 ms.2349machine # [ 79.599440] systemd[572]: Reexecution requested from client PID 5517 ('switch-to-confi')...2350machine # [ 79.601897] systemd[572]: Reexecuting.2351machine # [ 79.659531] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2352machine # [ 79.781075] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2353machine # [ 79.788124] systemd[572]: Reload requested from client PID 5517 ('switch-to-confi')...2354machine # [ 79.792272] systemd[572]: Reloading...2355machine # [ 79.901627] systemd[572]: Reloading finished in 110 ms.2356machine # [ 79.920232] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2357machine # [ 79.932187] systemd[572]: Stopped Run user-specific NixOS activation.2358machine # [ 79.934777] systemd[572]: Stopping Run user-specific NixOS activation...2359machine # [ 79.937289] systemd[572]: Starting Run user-specific NixOS activation...2360machine # [ 79.970686] systemd[572]: Finished Run user-specific NixOS activation.2361machine # [ 79.975768] systemd[1]: Stopped target Reactivate sysinit units.2362machine # [ 79.979846] systemd[1]: Stopping Reactivate sysinit units...2363machine # [ 79.984690] systemd[1]: Reached target Reactivate sysinit units.2364machine # [ 79.985679] systemd[1]: Reached target Remote File Systems.2365machine # [ 79.989609] systemd[1]: Starting linger-users.service...2366machine # [ 79.998890] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2367machine # [ 80.004668] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2368machine # [ 80.013608] systemd[1]: Reached target Local File Systems.2369machine # [ 80.014576] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2370machine # [ 80.023740] systemd[1]: Starting Create SUID/SGID Wrappers...2371machine # [ 80.028216] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2372machine # [ 80.031545] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672373machine # [ 80.038919] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2374machine # [ 80.044896] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2375machine # [ 80.051241] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2376machine # [ 80.098619] systemd[1]: linger-users.service: Deactivated successfully.2377machine # [ 80.103704] systemd[1]: Finished linger-users.service.2378machine # [ 80.257744] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2379machine # [ 80.259899] systemd[1]: Finished Create SUID/SGID Wrappers.2380machine # [ 80.517540] nixos[5448]: finished switching to system configuration /nix/store/5f88nm5yhgcfci103bzpsnqd85v4l82b-nixos-system-machine-test2381machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.91 seconds)2382machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&12383machine # [ 80.761737] nixos[5588]: switching to system configuration /nix/store/f7x7r7b0sbq3akafyp7mnam7wkwq20dg-nixos-system-machine-test2384machine # [ 80.767740] systemd[1]: Stopped target Remote File Systems.2385machine # [ 80.770298] systemd[1]: Stopped target Local File Systems.2386machine # [ 81.069101] systemd[1]: Reload requested from client PID 5588 ('.switch-to-conf') (unit backdoor.service)...2387machine # [ 81.071151] systemd[1]: Reloading...2388machine # [ 81.422419] systemd[1]: Reloading finished in 349 ms.2389machine # [ 81.516481] systemd[572]: Reexecution requested from client PID 5657 ('switch-to-confi')...2390machine # [ 81.520375] systemd[572]: Reexecuting.2391machine # [ 81.584235] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2392machine # [ 81.706041] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2393machine # [ 81.713634] systemd[572]: Reload requested from client PID 5657 ('switch-to-confi')...2394machine # [ 81.718118] systemd[572]: Reloading...2395machine # [ 81.831558] systemd[572]: Reloading finished in 114 ms.2396machine # [ 81.848178] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2397machine # [ 81.858238] systemd[572]: Stopped Run user-specific NixOS activation.2398machine # [ 81.860810] systemd[572]: Stopping Run user-specific NixOS activation...2399machine # [ 81.862997] systemd[572]: Starting Run user-specific NixOS activation...2400machine # [ 81.898852] systemd[572]: Finished Run user-specific NixOS activation.2401machine # [ 81.903361] systemd[1]: Stopped target Reactivate sysinit units.2402machine # [ 81.905187] systemd[1]: Stopping Reactivate sysinit units...2403machine # [ 81.906054] systemd[1]: Reached target Reactivate sysinit units.2404machine # [ 81.910112] systemd[1]: test.service: Deactivated successfully.2405machine # [ 81.911075] systemd[1]: Stopped test.service.2406machine # [ 81.911750] systemd[1]: Stopping test.service...2407machine # [ 81.914790] systemd[1]: Starting test.service...2408machine # [ 81.938397] systemd[1]: Finished test.service.2409machine # [ 81.943029] systemd[1]: Reached target Remote File Systems.2410machine # [ 81.951293] systemd[1]: Starting linger-users.service...2411machine # [ 81.956859] systemd[1]: Reached target Local File Systems.2412machine # [ 81.960442] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2413machine # [ 81.961878] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2414machine # [ 81.969087] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2415machine # [ 81.977646] systemd[1]: Starting Create SUID/SGID Wrappers...2416machine # [ 81.978566] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2417machine # [ 81.979964] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672418machine # [ 81.989238] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2419machine # [ 81.992725] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2420machine # [ 81.995133] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2421machine # [ 82.042135] systemd[1]: linger-users.service: Deactivated successfully.2422machine # [ 82.043934] systemd[1]: Finished linger-users.service.2423machine # [ 82.189861] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2424machine # [ 82.192733] systemd[1]: Finished Create SUID/SGID Wrappers.2425machine # [ 82.450261] nixos[5588]: finished switching to system configuration /nix/store/f7x7r7b0sbq3akafyp7mnam7wkwq20dg-nixos-system-machine-test2426machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.93 seconds)2427machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&12428machine # [ 82.689629] nixos[5730]: switching to system configuration /nix/store/30v6341dy5z6wxlrk1aprw0gjjlgl61k-nixos-system-machine-test2429machine # [ 82.692959] systemd[1]: Stopped target Local File Systems.2430machine # [ 82.695471] systemd[1]: Stopped target Remote File Systems.2431machine # [ 82.991512] systemd[1]: Reload requested from client PID 5730 ('.switch-to-conf') (unit backdoor.service)...2432machine # [ 82.993910] systemd[1]: Reloading...2433machine # [ 83.335305] systemd[1]: Reloading finished in 339 ms.2434machine # [ 83.422855] systemd[572]: Reexecution requested from client PID 5799 ('switch-to-confi')...2435machine # [ 83.427069] systemd[572]: Reexecuting.2436machine # [ 83.483525] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2437machine # [ 83.596229] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2438machine # [ 83.602697] systemd[572]: Reload requested from client PID 5799 ('switch-to-confi')...2439machine # [ 83.606498] systemd[572]: Reloading...2440machine # [ 83.711076] systemd[572]: Reloading finished in 105 ms.2441machine # [ 83.732182] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2442machine # [ 83.743493] systemd[572]: Stopped Run user-specific NixOS activation.2443machine # [ 83.744701] systemd[572]: Stopping Run user-specific NixOS activation...2444machine # [ 83.746920] systemd[572]: Starting Run user-specific NixOS activation...2445machine # [ 83.780761] systemd[572]: Finished Run user-specific NixOS activation.2446machine # [ 83.784704] systemd[1]: Stopped target Reactivate sysinit units.2447machine # [ 83.786647] systemd[1]: Stopping Reactivate sysinit units...2448machine # [ 83.787542] systemd[1]: Reached target Reactivate sysinit units.2449machine # [ 83.789717] systemd[1]: test.service: Deactivated successfully.2450machine # [ 83.792328] systemd[1]: Stopped test.service.2451machine # [ 83.793091] systemd[1]: Stopping test.service...2452machine # [ 83.795304] systemd[1]: Starting test.service...2453machine # [ 83.821203] systemd[1]: Finished test.service.2454machine # [ 83.825083] systemd[1]: Reached target Remote File Systems.2455machine # [ 83.830344] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2456machine # [ 83.833575] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2457machine # [ 83.836667] systemd[1]: Reached target Local File Systems.2458machine # [ 83.841742] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2459machine # [ 83.847939] systemd[1]: Starting Create SUID/SGID Wrappers...2460machine # [ 83.850121] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2461machine # [ 83.851446] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672462machine # [ 83.858356] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2463machine # [ 83.860322] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2464machine # [ 83.861663] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2465machine # [ 84.026148] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2466machine # [ 84.029487] systemd[1]: Finished Create SUID/SGID Wrappers.2467machine # [ 84.033629] systemd[1]: Starting linger-users.service...2468machine # [ 84.074572] systemd[1]: linger-users.service: Deactivated successfully.2469machine # [ 84.078061] systemd[1]: Finished linger-users.service.2470machine # [ 84.332344] nixos[5730]: finished switching to system configuration /nix/store/30v6341dy5z6wxlrk1aprw0gjjlgl61k-nixos-system-machine-test2471machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.88 seconds)2472machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&12473machine # [ 84.569399] nixos[5872]: switching to system configuration /nix/store/2g711v7a5dp9dhxs7f21qxp884cfariz-nixos-system-machine-test2474machine # [ 84.572762] systemd[1]: Stopped target Local File Systems.2475machine # [ 84.574893] systemd[1]: Stopped target Remote File Systems.2476machine # [ 84.861700] systemd[1]: Reload requested from client PID 5872 ('.switch-to-conf') (unit backdoor.service)...2477machine # [ 84.863756] systemd[1]: Reloading...2478machine # [ 85.190808] systemd[1]: Reloading finished in 325 ms.2479machine # [ 85.278848] systemd[572]: Reexecution requested from client PID 5941 ('switch-to-confi')...2480machine # [ 85.283399] systemd[572]: Reexecuting.2481machine # [ 85.339769] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2482machine # [ 85.457897] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2483machine # [ 85.464936] systemd[572]: Reload requested from client PID 5941 ('switch-to-confi')...2484machine # [ 85.468299] systemd[572]: Reloading...2485machine # [ 85.576185] systemd[572]: Reloading finished in 108 ms.2486machine # [ 85.592173] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2487machine # [ 85.601813] systemd[572]: Stopped Run user-specific NixOS activation.2488machine # [ 85.604364] systemd[572]: Stopping Run user-specific NixOS activation...2489machine # [ 85.606502] systemd[572]: Starting Run user-specific NixOS activation...2490machine # [ 85.639732] systemd[572]: Finished Run user-specific NixOS activation.2491machine # [ 85.644882] systemd[1]: Stopped target Reactivate sysinit units.2492machine # [ 85.645893] systemd[1]: Stopping Reactivate sysinit units...2493machine # [ 85.646726] systemd[1]: Reached target Reactivate sysinit units.2494machine # [ 85.648963] systemd[1]: test.service: Deactivated successfully.2495machine # [ 85.652202] systemd[1]: Stopped test.service.2496machine # [ 85.652951] systemd[1]: Stopping test.service...2497machine # [ 85.654677] systemd[1]: Starting test.service...2498machine # [ 85.680863] systemd[1]: Finished test.service.2499machine # [ 85.684528] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2500machine # [ 85.688756] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2501machine # [ 85.692357] systemd[1]: Reached target Remote File Systems.2502machine # [ 85.695924] systemd[1]: Starting linger-users.service...2503machine # [ 85.700549] systemd[1]: Reached target Local File Systems.2504machine # [ 85.711234] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2505machine # [ 85.721193] systemd[1]: Starting Create SUID/SGID Wrappers...2506machine # [ 85.722130] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2507machine # [ 85.723395] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672508machine # [ 85.733011] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2509machine # [ 85.736543] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2510machine # [ 85.738369] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2511machine # [ 85.787149] systemd[1]: linger-users.service: Deactivated successfully.2512machine # [ 85.789907] systemd[1]: Finished linger-users.service.2513machine # [ 85.925303] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2514machine # [ 85.928984] systemd[1]: Finished Create SUID/SGID Wrappers.2515machine # [ 86.183247] nixos[5872]: finished switching to system configuration /nix/store/2g711v7a5dp9dhxs7f21qxp884cfariz-nixos-system-machine-test2516machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 1.85 seconds)2517machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12518machine # [ 86.411423] nixos[6014]: switching to system configuration /nix/store/89hgfl7546jyh2d52psxkwdh6yzfzl81-nixos-system-machine-test2519machine # [ 86.415237] systemd[1]: Stopped target Remote File Systems.2520machine # [ 86.417094] systemd[1]: Stopped target Local File Systems.2521machine # [ 86.702336] systemd[1]: Reload requested from client PID 6014 ('.switch-to-conf') (unit backdoor.service)...2522machine # [ 86.704595] systemd[1]: Reloading...2523machine # [ 87.027053] systemd[1]: Reloading finished in 321 ms.2524machine # [ 87.120600] systemd[572]: Reexecution requested from client PID 6083 ('switch-to-confi')...2525machine # [ 87.123494] systemd[572]: Reexecuting.2526machine # [ 87.185039] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2527machine # [ 87.307925] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2528machine # [ 87.316229] systemd[572]: Reload requested from client PID 6083 ('switch-to-confi')...2529machine # [ 87.317770] systemd[572]: Reloading...2530machine # [ 87.434569] systemd[572]: Reloading finished in 115 ms.2531machine # [ 87.452199] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2532machine # [ 87.462313] systemd[572]: Stopped Run user-specific NixOS activation.2533machine # [ 87.464854] systemd[572]: Stopping Run user-specific NixOS activation...2534machine # [ 87.467131] systemd[572]: Starting Run user-specific NixOS activation...2535machine # [ 87.502691] systemd[572]: Finished Run user-specific NixOS activation.2536machine # [ 87.506869] systemd[1]: Stopped target Reactivate sysinit units.2537machine # [ 87.508533] systemd[1]: Stopping Reactivate sysinit units...2538machine # [ 87.509453] systemd[1]: Reached target Reactivate sysinit units.2539machine # [ 87.512392] systemd[1]: test.service: Deactivated successfully.2540machine # [ 87.513388] systemd[1]: Stopped test.service.2541machine # [ 87.514060] systemd[1]: Stopping test.service...2542machine # [ 87.518439] systemd[1]: Starting test.service...2543machine # [ 87.546279] systemd[1]: Finished test.service.2544machine # [ 87.552188] systemd[1]: Reached target Local File Systems.2545machine # [ 87.554254] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2546machine # [ 87.555788] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2547machine # [ 87.559525] systemd[1]: Reached target Remote File Systems.2548machine # [ 87.566092] systemd[1]: Starting linger-users.service...2549machine # [ 87.578415] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2550machine # [ 87.589221] systemd[1]: Starting Create SUID/SGID Wrappers...2551machine # [ 87.590157] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2552machine # [ 87.591433] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672553machine # [ 87.599919] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2554machine # [ 87.606750] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2555machine # [ 87.611777] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2556machine # [ 87.655539] systemd[1]: linger-users.service: Deactivated successfully.2557machine # [ 87.660625] systemd[1]: Finished linger-users.service.2558machine # [ 87.807796] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2559machine # [ 87.811509] systemd[1]: Finished Create SUID/SGID Wrappers.2560machine # [ 88.065685] nixos[6014]: finished switching to system configuration /nix/store/89hgfl7546jyh2d52psxkwdh6yzfzl81-nixos-system-machine-test2561machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.88 seconds)2562machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&12563machine # [ 88.322958] nixos[6156]: switching to system configuration /nix/store/k6g5yaclvin488sysz1yy3z4l6h2s6zk-nixos-system-machine-test2564machine # [ 88.325676] systemd[1]: Stopped target Local File Systems.2565machine # [ 88.328155] systemd[1]: Stopped target Remote File Systems.2566machine # [ 88.642558] systemd[1]: Reload requested from client PID 6156 ('.switch-to-conf') (unit backdoor.service)...2567machine # [ 88.644830] systemd[1]: Reloading...2568machine # [ 88.989550] systemd[1]: Reloading finished in 342 ms.2569machine # [ 89.080426] systemd[572]: Reexecution requested from client PID 6225 ('switch-to-confi')...2570machine # [ 89.081885] systemd[572]: Reexecuting.2571machine # [ 89.139851] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2572machine # [ 89.255933] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2573machine # [ 89.263303] systemd[572]: Reload requested from client PID 6225 ('switch-to-confi')...2574machine # [ 89.266033] systemd[572]: Reloading...2575machine # [ 89.376819] systemd[572]: Reloading finished in 109 ms.2576machine # [ 89.392184] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2577machine # [ 89.402053] systemd[572]: Stopped Run user-specific NixOS activation.2578machine # [ 89.404679] systemd[572]: Stopping Run user-specific NixOS activation...2579machine # [ 89.406913] systemd[572]: Starting Run user-specific NixOS activation...2580machine # [ 89.440891] systemd[572]: Finished Run user-specific NixOS activation.2581machine # [ 89.444475] systemd[1]: Stopped target Reactivate sysinit units.2582machine # [ 89.448351] systemd[1]: Stopping Reactivate sysinit units...2583machine # [ 89.449263] systemd[1]: Reached target Reactivate sysinit units.2584machine # [ 89.451782] systemd[1]: Reloading test.service...2585machine # [ 89.477145] systemd[1]: Reloaded test.service.2586machine # [ 89.480264] systemd[1]: Reached target Remote File Systems.2587machine # [ 89.486206] systemd[1]: Reached target Local File Systems.2588machine # [ 89.487105] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2589machine # [ 89.493095] systemd[1]: Starting Create SUID/SGID Wrappers...2590machine # [ 89.494003] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2591machine # [ 89.495277] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672592machine # [ 89.503183] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2593machine # [ 89.514618] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2594machine # [ 89.516987] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2595machine # [ 89.520392] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2596machine # [ 89.521796] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2597machine # [ 89.678744] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2598machine # [ 89.683094] systemd[1]: Finished Create SUID/SGID Wrappers.2599machine # [ 89.688357] systemd[1]: Starting linger-users.service...2600machine # [ 89.726619] systemd[1]: linger-users.service: Deactivated successfully.2601machine # [ 89.729970] systemd[1]: Finished linger-users.service.2602machine # [ 89.984269] nixos[6156]: finished switching to system configuration /nix/store/k6g5yaclvin488sysz1yy3z4l6h2s6zk-nixos-system-machine-test2603machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.92 seconds)2604machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&12605machine # [ 90.223279] nixos[6298]: switching to system configuration /nix/store/g4ni3fh3psz3y0l6j219nfvlf2xn6565-nixos-system-machine-test2606machine # [ 90.229561] systemd[1]: Stopped target Remote File Systems.2607machine # [ 90.230483] systemd[1]: Stopped target Local File Systems.2608machine # [ 90.536121] systemd[1]: Reload requested from client PID 6298 ('.switch-to-conf') (unit backdoor.service)...2609machine # [ 90.538409] systemd[1]: Reloading...2610machine # [ 90.870840] systemd[1]: Reloading finished in 331 ms.2611machine # [ 90.955276] systemd[572]: Reexecution requested from client PID 6367 ('switch-to-confi')...2612machine # [ 90.959699] systemd[572]: Reexecuting.2613machine # [ 91.016791] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2614machine # [ 91.130270] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2615machine # [ 91.137145] systemd[572]: Reload requested from client PID 6367 ('switch-to-confi')...2616machine # [ 91.138470] systemd[572]: Reloading...2617machine # [ 91.246447] systemd[572]: Reloading finished in 106 ms.2618machine # [ 91.264197] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2619machine # [ 91.274739] systemd[572]: Stopped Run user-specific NixOS activation.2620machine # [ 91.277117] systemd[572]: Stopping Run user-specific NixOS activation...2621machine # [ 91.279321] systemd[572]: Starting Run user-specific NixOS activation...2622machine # [ 91.312146] systemd[572]: Finished Run user-specific NixOS activation.2623machine # [ 91.317128] systemd[1]: Stopped target Reactivate sysinit units.2624machine # [ 91.318120] systemd[1]: Stopping Reactivate sysinit units...2625machine # [ 91.324166] systemd[1]: Reached target Reactivate sysinit units.2626machine # [ 91.328394] systemd[1]: Reloading test.service...2627machine # [ 91.349328] systemd[1]: Reloaded test.service.2628machine # [ 91.355167] systemd[1]: Reached target Remote File Systems.2629machine # [ 91.361214] systemd[1]: Starting linger-users.service...2630machine # [ 91.365934] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2631machine # [ 91.367356] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2632machine # [ 91.376841] systemd[1]: Reached target Local File Systems.2633machine # [ 91.377697] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2634machine # [ 91.384853] systemd[1]: Starting Create SUID/SGID Wrappers...2635machine # [ 91.385832] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2636machine # [ 91.387151] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672637machine # [ 91.396550] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2638machine # [ 91.398380] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2639machine # [ 91.407426] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2640machine # [ 91.454274] systemd[1]: linger-users.service: Deactivated successfully.2641machine # [ 91.458647] systemd[1]: Finished linger-users.service.2642machine # [ 91.592485] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2643machine # [ 91.596411] systemd[1]: Finished Create SUID/SGID Wrappers.2644machine # [ 91.850705] nixos[6298]: finished switching to system configuration /nix/store/g4ni3fh3psz3y0l6j219nfvlf2xn6565-nixos-system-machine-test2645machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.87 seconds)2646machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&12647machine # [ 92.102153] nixos[6440]: switching to system configuration /nix/store/yzh31zcgca0s5snv4c6hp2j51vcnbvys-nixos-system-machine-test2648machine # [ 92.104947] systemd[1]: Stopped target Remote File Systems.2649machine # [ 92.107498] systemd[1]: Stopped target Local File Systems.2650machine # [ 92.418151] systemd[1]: Reload requested from client PID 6440 ('.switch-to-conf') (unit backdoor.service)...2651machine # [ 92.420354] systemd[1]: Reloading...2652machine # [ 92.757556] systemd[1]: Reloading finished in 334 ms.2653machine # [ 92.846008] systemd[572]: Reexecution requested from client PID 6509 ('switch-to-confi')...2654machine # [ 92.850331] systemd[572]: Reexecuting.2655machine # [ 92.899315] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2656machine # [ 93.013801] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2657machine # [ 93.021609] systemd[572]: Reload requested from client PID 6509 ('switch-to-confi')...2658machine # [ 93.023043] systemd[572]: Reloading...2659machine # [ 93.134216] systemd[572]: Reloading finished in 109 ms.2660machine # [ 93.148194] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2661machine # [ 93.158458] systemd[572]: Stopped Run user-specific NixOS activation.2662machine # [ 93.161233] systemd[572]: Stopping Run user-specific NixOS activation...2663machine # [ 93.163761] systemd[572]: Starting Run user-specific NixOS activation...2664machine # [ 93.198111] systemd[572]: Finished Run user-specific NixOS activation.2665machine # [ 93.202518] systemd[1]: Stopped target Reactivate sysinit units.2666machine # [ 93.204961] systemd[1]: Stopping Reactivate sysinit units...2667machine # [ 93.205917] systemd[1]: Reached target Reactivate sysinit units.2668machine # [ 93.210398] systemd[1]: test.service: Deactivated successfully.2669machine # [ 93.216279] systemd[1]: Stopped test.service.2670machine # [ 93.217097] systemd[1]: Stopping test.service...2671machine # [ 93.217800] systemd[1]: Starting test.service...2672machine # [ 93.244617] systemd[1]: Finished test.service.2673machine # [ 93.249989] systemd[1]: Reached target Local File Systems.2674machine # [ 93.254151] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2675machine # [ 93.259203] systemd[1]: Starting Create SUID/SGID Wrappers...2676machine # [ 93.263606] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2677machine # [ 93.268871] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672678machine # [ 93.271227] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2679machine # [ 93.283354] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2680machine # [ 93.285080] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2681machine # [ 93.286391] systemd[1]: Reached target Remote File Systems.2682machine # [ 93.287212] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2683machine # [ 93.289048] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2684machine # [ 93.463627] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2685machine # [ 93.468632] systemd[1]: Finished Create SUID/SGID Wrappers.2686machine # [ 93.471857] systemd[1]: Starting linger-users.service...2687machine # [ 93.518444] systemd[1]: linger-users.service: Deactivated successfully.2688machine # [ 93.520521] systemd[1]: Finished linger-users.service.2689machine # [ 93.776806] nixos[6440]: finished switching to system configuration /nix/store/yzh31zcgca0s5snv4c6hp2j51vcnbvys-nixos-system-machine-test2690machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.93 seconds)2691machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&12692machine # [ 94.003401] nixos[6582]: switching to system configuration /nix/store/f7x7r7b0sbq3akafyp7mnam7wkwq20dg-nixos-system-machine-test2693machine # [ 94.006202] systemd[1]: Stopped target Local File Systems.2694machine # [ 94.008709] systemd[1]: Stopped target Remote File Systems.2695machine # [ 94.299998] systemd[1]: Reload requested from client PID 6582 ('.switch-to-conf') (unit backdoor.service)...2696machine # [ 94.302122] systemd[1]: Reloading...2697machine # [ 94.625073] systemd[1]: Reloading finished in 321 ms.2698machine # [ 94.716238] systemd[572]: Reexecution requested from client PID 6651 ('switch-to-confi')...2699machine # [ 94.720088] systemd[572]: Reexecuting.2700machine # [ 94.776807] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2701machine # [ 94.889367] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2702machine # [ 94.897088] systemd[572]: Reload requested from client PID 6651 ('switch-to-confi')...2703machine # [ 94.900304] systemd[572]: Reloading...2704machine # [ 95.018254] systemd[572]: Reloading finished in 116 ms.2705machine # [ 95.040282] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2706machine # [ 95.051660] systemd[572]: Stopped Run user-specific NixOS activation.2707machine # [ 95.054349] systemd[572]: Stopping Run user-specific NixOS activation...2708machine # [ 95.057024] systemd[572]: Starting Run user-specific NixOS activation...2709machine # [ 95.089518] systemd[572]: Finished Run user-specific NixOS activation.2710machine # [ 95.093853] systemd[1]: Stopped target Reactivate sysinit units.2711machine # [ 95.096253] systemd[1]: Stopping Reactivate sysinit units...2712machine # [ 95.097156] systemd[1]: Reached target Reactivate sysinit units.2713machine # [ 95.100294] systemd[1]: Reached target Remote File Systems.2714machine # [ 95.106941] systemd[1]: Starting linger-users.service...2715machine # [ 95.116661] systemd[1]: Reached target Local File Systems.2716machine # [ 95.117548] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2717machine # [ 95.130441] systemd[1]: Starting Create SUID/SGID Wrappers...2718machine # [ 95.131367] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2719machine # [ 95.133777] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672720machine # [ 95.137227] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2721machine # [ 95.138889] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2722machine # [ 95.143845] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2723machine # [ 95.147043] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2724machine # [ 95.151597] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2725machine # [ 95.198274] systemd[1]: linger-users.service: Deactivated successfully.2726machine # [ 95.201451] systemd[1]: Finished linger-users.service.2727machine # [ 95.337142] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2728machine # [ 95.340814] systemd[1]: Finished Create SUID/SGID Wrappers.2729machine # [ 95.594982] nixos[6582]: finished switching to system configuration /nix/store/f7x7r7b0sbq3akafyp7mnam7wkwq20dg-nixos-system-machine-test2730machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.82 seconds)2731(finished: subtest: unit file parser, in 24.46 seconds)2732subtest: restart and reload by activation script2733machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&12734machine # [ 95.817610] nixos[6722]: switching to system configuration /nix/store/94mf2bvp763s7jynh1fw6p32r84z3kxk-nixos-system-machine-test2735machine # [ 95.820856] systemd[1]: Stopped target Remote File Systems.2736machine # [ 95.823551] systemd[1]: Stopped target Local File Systems.2737machine # [ 96.102888] systemd[1]: Reload requested from client PID 6722 ('.switch-to-conf') (unit backdoor.service)...2738machine # [ 96.105102] systemd[1]: Reloading...2739machine # [ 96.407636] systemd[1]: Reloading finished in 301 ms.2740machine # [ 96.493990] systemd[572]: Reexecution requested from client PID 6791 ('switch-to-confi')...2741machine # [ 96.497670] systemd[572]: Reexecuting.2742machine # [ 96.543144] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2743machine # [ 96.650419] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2744machine # [ 96.657186] systemd[572]: Reload requested from client PID 6791 ('switch-to-confi')...2745machine # [ 96.661019] systemd[572]: Reloading...2746machine # [ 96.764321] systemd[572]: Reloading finished in 104 ms.2747machine # [ 96.780190] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2748machine # [ 96.791413] systemd[572]: Stopped Run user-specific NixOS activation.2749machine # [ 96.792763] systemd[572]: Stopping Run user-specific NixOS activation...2750machine # [ 96.794972] systemd[572]: Starting Run user-specific NixOS activation...2751machine # [ 96.826584] systemd[572]: Finished Run user-specific NixOS activation.2752machine # [ 96.830995] systemd[1]: Stopped target Reactivate sysinit units.2753machine # [ 96.833262] systemd[1]: Stopping Reactivate sysinit units...2754machine # [ 96.834132] systemd[1]: Reached target Reactivate sysinit units.2755machine # [ 96.838254] systemd[1]: Reached target Local File Systems.2756machine # [ 96.841524] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2757machine # [ 96.844144] systemd[1]: Starting Create SUID/SGID Wrappers...2758machine # [ 96.845021] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2759machine # [ 96.853868] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672760machine # [ 96.860379] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2761machine # [ 96.862031] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2762machine # [ 96.863301] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2763machine # [ 96.868180] systemd[1]: Reached target Remote File Systems.2764machine # [ 96.869019] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2765machine # [ 96.870278] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2766machine # [ 97.021900] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2767machine # [ 97.026963] systemd[1]: Finished Create SUID/SGID Wrappers.2768machine # [ 97.029337] systemd[1]: Starting linger-users.service...2769machine # [ 97.068519] systemd[1]: linger-users.service: Deactivated successfully.2770machine # [ 97.070705] systemd[1]: Finished linger-users.service.2771machine # [ 97.326398] nixos[6722]: finished switching to system configuration /nix/store/94mf2bvp763s7jynh1fw6p32r84z3kxk-nixos-system-machine-test2772machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.73 seconds)2773machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12774machine # [ 97.553858] nixos[6862]: switching to system configuration /nix/store/66z1hr66r4qr3v7glkkz8y6q5als56mb-nixos-system-machine-test2775machine # [ 97.556599] systemd[1]: Stopped target Remote File Systems.2776machine # [ 97.560159] systemd[1]: test.service: Deactivated successfully.2777machine # [ 97.561082] systemd[1]: Stopped test.service.2778machine # [ 97.561770] systemd[1]: Stopped target Local File Systems.2779machine # [ 97.854270] systemd[1]: Reload requested from client PID 6862 ('.switch-to-conf') (unit backdoor.service)...2780machine # [ 97.856979] systemd[1]: Reloading...2781machine # [ 98.193585] systemd[1]: Reloading finished in 333 ms.2782machine # [ 98.288736] systemd[572]: Reexecution requested from client PID 6932 ('switch-to-confi')...2783machine # [ 98.291249] systemd[572]: Reexecuting.2784machine # [ 98.348400] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2785machine # [ 98.465411] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2786machine # [ 98.472518] systemd[572]: Reload requested from client PID 6932 ('switch-to-confi')...2787machine # [ 98.476154] systemd[572]: Reloading...2788machine # [ 98.588231] systemd[572]: Reloading finished in 112 ms.2789machine # [ 98.604212] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2790machine # [ 98.613571] systemd[572]: Stopped Run user-specific NixOS activation.2791machine # [ 98.616155] systemd[572]: Stopping Run user-specific NixOS activation...2792machine # [ 98.618422] systemd[572]: Starting Run user-specific NixOS activation...2793machine # [ 98.654085] systemd[572]: Finished Run user-specific NixOS activation.2794machine # [ 98.658446] systemd[1]: Stopped target Reactivate sysinit units.2795machine # [ 98.660931] systemd[1]: Stopping Reactivate sysinit units...2796machine # [ 98.661873] systemd[1]: Reached target Reactivate sysinit units.2797machine # [ 98.668265] systemd[1]: Created slice Slice /system/templated-simple-service.2798machine # [ 98.672704] systemd[1]: Starting templated-simple-service@instance.service...2799machine # [ 98.692649] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2800machine # [ 98.702777] systemd[1]: Starting simple-restart-service.service...2801machine # [ 98.703850] systemd[1]: Reached target Local File Systems.2802machine # [ 98.720700] systemd[1]: Created slice Slice /system/templated-reload-triggers.2803machine # [ 98.721806] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart.2804machine # [ 98.722984] systemd[1]: Reached target Remote File Systems.2805machine # [ 98.742838] systemd[1]: Starting linger-users.service...2806machine # [ 98.743868] systemd[1]: Starting reload-triggers-and-restart.service...2807machine # [ 98.764292] systemd[1]: Starting reload-triggers.service...2808machine # [ 98.787990] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2809machine # [ 98.812344] systemd[1]: Starting templated-reload-triggers@instance.service...2810machine # [ 98.813608] systemd[1]: Created slice Slice /system/templated-simple-restart-service.2811machine # [ 98.849560] systemd[1]: Starting templated-simple-restart-service@instance.service...2812machine # [ 98.850830] systemd[1]: Created slice Slice /system/templated-simple-reload-service.2813machine # [ 98.890752] systemd[1]: Starting templated-simple-reload-service@instance.service...2814machine # [ 98.924826] systemd[1]: Finished templated-simple-service@instance.service.2815machine # [ 98.943226] systemd[1]: Starting no-restart-service.service...2816machine # [ 98.959895] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2817machine # [ 98.984304] systemd[1]: Starting Create SUID/SGID Wrappers...2818machine # [ 99.004198] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2819machine # [ 99.018860] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672820machine # [ 99.036455] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2821machine # [ 99.038311] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2822machine # [ 99.039659] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2823machine # [ 99.041510] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as.2824machine # [ 99.042804] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2825machine # [ 99.050089] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2826machine # [ 99.051606] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2827machine # [ 99.058131] systemd[1]: Finished simple-restart-service.service.2828machine # [ 99.059104] systemd[1]: Created slice Slice /system/templated-no-restart-service.2829machine # [ 99.065505] systemd[1]: Finished reload-triggers-and-restart.service.2830machine # [ 99.066507] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2831machine # [ 99.067758] systemd[1]: Finished reload-triggers.service.2832machine # [ 99.074918] systemd[1]: Finished templated-reload-triggers@instance.service.2833machine # [ 99.080846] systemd[1]: Finished templated-simple-reload-service@instance.service.2834machine # [ 99.082011] systemd[1]: Finished templated-simple-restart-service@instance.service.2835machine # [ 99.083150] systemd[1]: Finished no-restart-service.service.2836machine # [ 99.086795] systemd[1]: linger-users.service: Deactivated successfully.2837machine # [ 99.089005] systemd[1]: Finished linger-users.service.2838machine # [ 99.228194] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2839machine # [ 99.231215] systemd[1]: Finished Create SUID/SGID Wrappers.2840machine # [ 99.235415] systemd[1]: Starting simple-reload-service.service...2841machine # [ 99.244452] systemd[1]: Starting simple-service.service...2842machine # [ 99.245389] systemd[1]: Starting templated-no-restart-service@instance.service...2843machine # [ 99.263863] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2844machine # [ 99.319275] systemd[1]: Finished simple-reload-service.service.2845machine # [ 99.323206] systemd[1]: Finished simple-service.service.2846machine # [ 99.324379] systemd[1]: Finished templated-no-restart-service@instance.service.2847machine # [ 99.325479] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2848machine # [ 99.578762] nixos[6862]: finished switching to system configuration /nix/store/66z1hr66r4qr3v7glkkz8y6q5als56mb-nixos-system-machine-test2849machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.25 seconds)2850machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12851machine # [ 99.846559] nixos[7033]: switching to system configuration /nix/store/66z1hr66r4qr3v7glkkz8y6q5als56mb-nixos-system-machine-test2852machine # [ 99.850690] systemd[1]: Stopped target Local File Systems.2853machine # [ 99.851797] systemd[1]: Stopped target Remote File Systems.2854machine # [ 100.167929] systemd[1]: Reload requested from client PID 7033 ('.switch-to-conf') (unit backdoor.service)...2855machine # [ 100.170201] systemd[1]: Reloading...2856machine # [ 100.507664] systemd[1]: Reloading finished in 335 ms.2857machine # [ 100.604576] systemd[572]: Reexecution requested from client PID 7104 ('switch-to-confi')...2858machine # [ 100.608342] systemd[572]: Reexecuting.2859machine # [ 100.667442] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2860machine # [ 100.786860] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2861machine # [ 100.794008] systemd[572]: Reload requested from client PID 7104 ('switch-to-confi')...2862machine # [ 100.798316] systemd[572]: Reloading...2863machine # [ 100.910024] systemd[572]: Reloading finished in 112 ms.2864machine # [ 100.924220] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2865machine # [ 100.935329] systemd[572]: Stopped Run user-specific NixOS activation.2866machine # [ 100.936550] systemd[572]: Stopping Run user-specific NixOS activation...2867machine # [ 100.939132] systemd[572]: Starting Run user-specific NixOS activation...2868machine # [ 100.975416] systemd[572]: Finished Run user-specific NixOS activation.2869machine # [ 100.980164] systemd[1]: Stopped target Reactivate sysinit units.2870machine # [ 100.983236] systemd[1]: Stopping Reactivate sysinit units...2871machine # [ 100.987929] systemd[1]: Reached target Reactivate sysinit units.2872machine # [ 100.992282] systemd[1]: Reloading reload-triggers-and-restart.service...2873machine # [ 100.997324] systemd[1]: Reloading reload-triggers.service...2874machine # [ 101.008400] systemd[1]: Reloading simple-reload-service.service...2875machine # [ 101.020550] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service...2876machine # [ 101.036185] systemd[1]: Reloading templated-reload-triggers@instance.service...2877machine # [ 101.037440] systemd[1]: Reloading templated-simple-reload-service@instance.service...2878machine # [ 101.109724] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service.2879machine # [ 101.118960] systemd[1]: Reloaded simple-reload-service.service.2880machine # [ 101.125807] systemd[1]: Reloaded reload-triggers-and-restart.service.2881machine # [ 101.126852] systemd[1]: Reloaded templated-reload-triggers@instance.service.2882machine # [ 101.127871] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2883machine # [ 101.132973] systemd[1]: Reloaded reload-triggers.service.2884machine # [ 101.136463] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2885machine # [ 101.140434] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2886machine # [ 101.141538] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2887machine # [ 101.143986] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2888machine # [ 101.148634] systemd[1]: simple-restart-service.service: Deactivated successfully.2889machine # [ 101.149792] systemd[1]: Stopped simple-restart-service.service.2890machine # [ 101.150677] systemd[1]: Stopping simple-restart-service.service...2891machine # [ 101.153776] systemd[1]: Starting simple-restart-service.service...2892machine # [ 101.165037] systemd[1]: simple-service.service: Deactivated successfully.2893machine # [ 101.177522] systemd[1]: Stopped simple-service.service.2894machine # [ 101.178409] systemd[1]: Stopping simple-service.service...2895machine # [ 101.179213] systemd[1]: Starting simple-service.service...2896machine # [ 101.203869] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2897machine # [ 101.209277] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2898machine # [ 101.210604] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2899machine # [ 101.230316] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2900machine # [ 101.231846] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2901machine # [ 101.255073] systemd[1]: Stopped templated-simple-restart-service@instance.service.2902machine # [ 101.268169] systemd[1]: Stopping templated-simple-restart-service@instance.service...2903machine # [ 101.285315] systemd[1]: Starting templated-simple-restart-service@instance.service...2904machine # [ 101.294046] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2905machine # [ 101.296479] systemd[1]: Stopped templated-simple-service@instance.service.2906machine # [ 101.297564] systemd[1]: Stopping templated-simple-service@instance.service...2907machine # [ 101.298554] systemd[1]: Starting templated-simple-service@instance.service...2908machine # [ 101.299653] systemd[1]: Finished simple-service.service.2909machine # [ 101.307779] systemd[1]: Finished simple-restart-service.service.2910machine # [ 101.313993] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2911machine # [ 101.315021] systemd[1]: Finished templated-simple-restart-service@instance.service.2912machine # [ 101.323233] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2913machine # [ 101.328229] systemd[1]: Finished templated-simple-service@instance.service.2914machine # [ 101.329296] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2915machine # [ 101.330665] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2916machine # [ 101.340640] systemd[1]: Reached target Local File Systems.2917machine # [ 101.341544] systemd[1]: Reached target Remote File Systems.2918machine # [ 101.342370] systemd[1]: Starting linger-users.service...2919machine # [ 101.343150] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2920machine # [ 101.345045] systemd[1]: Starting Create SUID/SGID Wrappers...2921machine # [ 101.345920] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2922machine # [ 101.347184] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672923machine # [ 101.355074] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2924machine # [ 101.360873] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2925machine # [ 101.367120] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2926machine # [ 101.412878] systemd[1]: linger-users.service: Deactivated successfully.2927machine # [ 101.417491] systemd[1]: Finished linger-users.service.2928machine # [ 101.550178] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2929machine # [ 101.553387] systemd[1]: Finished Create SUID/SGID Wrappers.2930machine # [ 101.810288] nixos[7033]: finished switching to system configuration /nix/store/66z1hr66r4qr3v7glkkz8y6q5als56mb-nixos-system-machine-test2931machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.23 seconds)2932machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&12933machine # [ 102.088414] nixos[7199]: switching to system configuration /nix/store/z7ywqnghkyfp29q7wwi4fnbngiallrsi-nixos-system-machine-test2934machine # [ 102.091028] systemd[1]: Stopped target Remote File Systems.2935machine # [ 102.093300] systemd[1]: Stopped target Local File Systems.2936machine # [ 102.404411] systemd[1]: Reload requested from client PID 7199 ('.switch-to-conf') (unit backdoor.service)...2937machine # [ 102.406464] systemd[1]: Reloading...2938machine # [ 102.753000] systemd[1]: Reloading finished in 345 ms.2939machine # [ 102.849463] systemd[572]: Reexecution requested from client PID 7269 ('switch-to-confi')...2940machine # [ 102.853949] systemd[572]: Reexecuting.2941machine # [ 102.920945] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2942machine # [ 103.042725] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2943machine # [ 103.049992] systemd[572]: Reload requested from client PID 7269 ('switch-to-confi')...2944machine # [ 103.054332] systemd[572]: Reloading...2945machine # [ 103.164522] systemd[572]: Reloading finished in 111 ms.2946machine # [ 103.180203] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2947machine # [ 103.190233] systemd[572]: Stopped Run user-specific NixOS activation.2948machine # [ 103.193050] systemd[572]: Stopping Run user-specific NixOS activation...2949machine # [ 103.195350] systemd[572]: Starting Run user-specific NixOS activation...2950machine # [ 103.232958] systemd[572]: Finished Run user-specific NixOS activation.2951machine # [ 103.237578] systemd[1]: Stopped target Reactivate sysinit units.2952machine # [ 103.243116] systemd[1]: Stopping Reactivate sysinit units...2953machine # [ 103.244508] systemd[1]: Reached target Reactivate sysinit units.2954machine # [ 103.246534] systemd[1]: Reloading reload-triggers.service...2955machine # [ 103.252678] systemd[1]: Reloading simple-reload-service.service...2956machine # [ 103.263983] systemd[1]: Reloading templated-reload-triggers@instance.service...2957machine # [ 103.276248] systemd[1]: Reloading templated-simple-reload-service@instance.service...2958machine # [ 103.329509] systemd[1]: Reloaded reload-triggers.service.2959machine # [ 103.332245] systemd[1]: Reloaded simple-reload-service.service.2960machine # [ 103.335360] systemd[1]: Reloaded templated-reload-triggers@instance.service.2961machine # [ 103.337182] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2962machine # [ 103.340636] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2963machine # [ 103.341924] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2964machine # [ 103.342910] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2965machine # [ 103.350279] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2966machine # [ 103.351419] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully.2967machine # [ 103.368373] systemd[1]: Stopped reload-triggers-and-restart.service.2968machine # [ 103.369383] systemd[1]: Stopping reload-triggers-and-restart.service...2969machine # [ 103.370348] systemd[1]: Starting reload-triggers-and-restart.service...2970machine # [ 103.371326] systemd[1]: simple-restart-service.service: Deactivated successfully.2971machine # [ 103.402191] systemd[1]: Stopped simple-restart-service.service.2972machine # [ 103.403176] systemd[1]: Stopping simple-restart-service.service...2973machine # [ 103.414120] systemd[1]: Starting simple-restart-service.service...2974machine # [ 103.415177] systemd[1]: simple-service.service: Deactivated successfully.2975machine # [ 103.438291] systemd[1]: Stopped simple-service.service.2976machine # [ 103.453031] systemd[1]: Stopping simple-service.service...2977machine # [ 103.465572] systemd[1]: Starting simple-service.service...2978machine # [ 103.475869] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2979machine # [ 103.498050] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2980machine # [ 103.516571] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2981machine # [ 103.518147] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2982machine # [ 103.519524] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully.2983machine # [ 103.529858] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service.2984machine # [ 103.531106] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service...2985machine # [ 103.533104] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2986machine # [ 103.534293] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2987machine # [ 103.535576] systemd[1]: Stopped templated-simple-restart-service@instance.service.2988machine # [ 103.539892] systemd[1]: Stopping templated-simple-restart-service@instance.service...2989machine # [ 103.541594] systemd[1]: Starting templated-simple-restart-service@instance.service...2990machine # [ 103.543324] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2991machine # [ 103.545388] systemd[1]: Stopped templated-simple-service@instance.service.2992machine # [ 103.546356] systemd[1]: Stopping templated-simple-service@instance.service...2993machine # [ 103.547361] systemd[1]: Starting templated-simple-service@instance.service...2994machine # [ 103.550011] systemd[1]: Finished reload-triggers-and-restart.service.2995machine # [ 103.551037] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2996machine # [ 103.554781] systemd[1]: Finished simple-restart-service.service.2997machine # [ 103.555802] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2998machine # [ 103.564768] systemd[1]: Finished simple-service.service.2999machine # [ 103.565677] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.3000machine # [ 103.566786] systemd[1]: Finished templated-simple-restart-service@instance.service.3001machine # [ 103.567886] systemd[1]: Finished templated-simple-service@instance.service.3002machine # [ 103.581719] systemd[1]: Reached target Local File Systems.3003machine # [ 103.582601] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os3004machine # [ 103.583929] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki3005machine # [ 103.594585] systemd[1]: Reached target Remote File Systems.3006machine # [ 103.595523] systemd[1]: Starting linger-users.service...3007machine # [ 103.599344] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore3008machine # [ 103.604675] systemd[1]: Starting Create SUID/SGID Wrappers...3009machine # [ 103.609729] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.3010machine # [ 103.613561] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc673011machine # [ 103.615835] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore3012machine # [ 103.625470] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3013machine # [ 103.626842] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3014machine # [ 103.663415] systemd[1]: linger-users.service: Deactivated successfully.3015machine # [ 103.667385] systemd[1]: Finished linger-users.service.3016machine # [ 103.797082] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.3017machine # [ 103.800979] systemd[1]: Finished Create SUID/SGID Wrappers.3018machine # [ 104.055518] nixos[7199]: finished switching to system configuration /nix/store/z7ywqnghkyfp29q7wwi4fnbngiallrsi-nixos-system-machine-test3019machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.25 seconds)3020machine: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&13021machine: (finished: must succeed: /nix/store/njjs6j83qrbp95dm8can43b8r9q8sz2p-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.36 seconds)3022(finished: subtest: restart and reload by activation script, in 8.82 seconds)3023(finished: run the VM test script, in 105.19 seconds)3024test script finished in 105.26s3025cleanup3026kill QemuMachine (pid 45)3027machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lq2fsnmg0q3y0vlxn91w8s8wvj1m6fld-python3-3.14.8/bin/python3.14)3028machine # [2026-10-22T03:00:01Z INFO virtiofsd] Client disconnected, shutting down3029machine # [2026-10-22T03:00:01Z INFO virtiofsd] Client disconnected, shutting down3030machine # [2026-10-22T03:00:01Z INFO virtiofsd] Client disconnected, shutting down3031(finished: cleanup, in 0.15 seconds)3032additionally exposed symbols:3033 machine, other,3034 vlan1,3035 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