tribuchet: building on eliza Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script machine: waiting for unit multi-user.target machine: waiting for the VM to finish booting machine: starting vm machine # Disk image does not exist, creating the virtualisation disk image... machine: QEMU running (pid 45) machine # Formatting '/build/vm-state-machine/tmp.1wT39DhMZk', fmt=raw size=1073741824 machine # mke2fs 1.47.4 (6-Mar-2025) machine # Discarding device blocks: 0/262144 done machine # Creating filesystem with 262144 4k blocks and 65536 inodes machine # Filesystem UUID: e00a30b9-bc99-47d2-9494-fb21902f6059 machine # Superblock backups stored on blocks: machine # 32768, 98304, 163840, 229376 machine # machine # Allocating group tables: 0/8 done machine # Writing inode tables: 0/8 done machine # Creating journal (8192 blocks): done machine # Writing superblocks and filesystem accounting information: 0/8 done machine # machine # Virtualisation disk image created. machine # Starting virtiofs daemons... machine # [2026-09-15T03:03:02Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-15T03:03:02Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-15T03:03:02Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-15T03:03:02Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-15T03:03:02Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-15T03:03:02Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-15T03:03:02Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-15T03:03:02Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-15T03:03:02Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-15T03:03:02Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-15T03:03:02Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-15T03:03:02Z INFO virtiofsd] Client connected, servicing requests machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.51 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 11 09:49:46 UTC 2026 machine # [ 0.000000] KASLR enabled machine # [ 0.000000] random: crng init done machine # [ 0.000000] Machine model: linux,dummy-virt machine # [ 0.000000] efi: UEFI not found. machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f] machine # [ 0.000000] Zone ranges: machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] DMA32 empty machine # [ 0.000000] Normal empty machine # [ 0.000000] Device empty machine # [ 0.000000] Movable zone start for each node machine # [ 0.000000] Early memory node ranges machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000 machine # [ 0.000000] psci: probing for conduit method from DT. machine # [ 0.000000] psci: PSCIv1.3 detected in firmware. machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs machine # [ 0.000000] psci: Trusted OS migration not required machine # [ 0.000000] psci: SMC Calling Convention v1.1 machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296 machine # [ 0.000000] Detected PIPT I-cache on CPU0 machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) machine # [ 0.000000] CPU features: detected: GICv3 CPU interface machine # [ 0.000000] CPU features: detected: Spectre-v4 machine # [ 0.000000] CPU features: detected: Spectre-BHB machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 machine # [ 0.000000] alternatives: applying boot alternatives machine # [ 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/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/init regInfo=/nix/store/qn1959r44wlh23p02nqwk6b0ggf9gkm0-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/qn1959r44wlh23p02nqwk6b0ggf9gkm0-closure-info/registration", will be passed to user space. machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB machine # [ 0.000000] software IO TLB: area num 1. machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB) machine # [ 0.000000] Fallback order for Node 0: 0 machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 machine # [ 0.000000] Policy zone: DMA machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.000000] allocated 2097152 bytes of page_ext machine # [ 0.000000] ftrace: allocating 74894 entries in 294 pages machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups machine # [ 0.000000] rcu: Hierarchical RCU implementation. machine # [ 0.000000] rcu: RCU event tracing is enabled. machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. machine # [ 0.000000] Rude variant of Tasks RCU enabled. machine # [ 0.000000] Tracing variant of Tasks RCU enabled. machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 machine # [ 0.000000] GICv3: 256 SPIs implemented machine # [ 0.000000] GICv3: 0 Extended SPIs implemented machine # [ 0.000000] Root IRQ handler: gic_handle_irq machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1) machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1) machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000 machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns machine # [ 0.000029] arm-pv: using stolen time PV machine # [ 0.000384] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000555] Console: colour dummy device 80x25 machine # [ 0.000562] printk: legacy console [tty0] enabled machine # [ 0.000746] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000753] pid_max: default: 32768 minimum: 301 machine # [ 0.000822] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.000958] landlock: Up and running. machine # [ 0.000961] Yama: becoming mindful. machine # [ 0.001384] LSM support for eBPF active machine # [ 0.001488] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.001507] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.002609] cacheinfo: Unable to detect cache hierarchy for CPU 0 machine # [ 0.003294] rcu: Hierarchical SRCU implementation. machine # [ 0.003298] rcu: Max phase no-delay instances is 1000. machine # [ 0.004544] fsl-mc MSI: its@8080000 domain created machine # [ 0.004634] EFI services will not be available. machine # [ 0.004708] smp: Bringing up secondary CPUs ... machine # [ 0.004716] smp: Brought up 1 node, 1 CPU machine # [ 0.004719] SMP: Total of 1 processors activated. machine # [ 0.004722] CPU: All CPU(s) started at EL1 machine # [ 0.004735] CPU features: detected: Branch Target Identification machine # [ 0.004739] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.004742] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.004746] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.004750] CPU features: detected: Common not Private translations machine # [ 0.004753] CPU features: detected: CRC32 instructions machine # [ 0.004755] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.004759] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.004762] CPU features: detected: Data independent timing control (DIT) machine # [ 0.004766] CPU features: detected: E0PD machine # [ 0.004768] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.004771] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.004774] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.004778] CPU features: detected: Fine Grained Traps machine # [ 0.004781] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.004786] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.004789] CPU features: detected: LSE atomic instructions machine # [ 0.004792] CPU features: detected: Privileged Access Never machine # [ 0.004794] CPU features: detected: PMUv3 machine # [ 0.004797] CPU features: detected: RAS Extension Support machine # [ 0.004800] CPU features: detected: RASv1p1 Extension Support machine # [ 0.004802] CPU features: detected: Random Number Generator machine # [ 0.004805] CPU features: detected: Speculation barrier (SB) machine # [ 0.004808] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.004810] CPU features: detected: TLB range maintenance instructions machine # [ 0.004815] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.004850] alternatives: applying system-wide alternatives machine # [ 0.007727] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.007947] Memory: 893952K/1048576K available (24448K kernel code, 7090K rwdata, 26360K rodata, 4736K init, 1107K bss, 113284K reserved, 32768K cma-reserved) machine # [ 0.008345] devtmpfs: initialized machine # [ 0.009968] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.009990] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.010170] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.010175] 0 pages in range for non-PLT usage machine # [ 0.010176] 508288 pages in range for PLT usage machine # [ 0.010270] pinctrl core: initialized pinctrl subsystem machine # [ 0.010991] DMI not present or invalid. machine # [ 0.014021] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.016300] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.016463] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.016618] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.016640] audit: initializing netlink subsys (disabled) machine # [ 0.017150] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.017152] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.017155] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.017158] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.017163] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.017193] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 machine # [ 0.017203] cpuidle: using governor ladder machine # [ 0.017208] cpuidle: using governor menu machine # [ 0.017399] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.017413] ASID allocator initialised with 65536 entries machine # [ 0.018515] Serial: AMBA PL011 UART driver machine # [ 0.023586] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.023708] printk: console [ttyAMA0] enabled machine # [ 0.146715] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.146734] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.146740] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.146744] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.146748] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.146753] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.146758] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.146762] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.154480] fbcon: Taking over console machine # [ 0.154495] ACPI: Interpreter disabled. machine # [ 0.163086] iommu: Default domain type: Translated machine # [ 0.163096] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.163455] SCSI subsystem initialized machine # [ 0.165442] usbcore: registered new interface driver usbfs machine # [ 0.165481] usbcore: registered new interface driver hub machine # [ 0.165499] usbcore: registered new device driver usb machine # [ 0.165766] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.165772] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.165782] PTP clock support registered machine # [ 0.165834] EDAC MC: Ver: 3.0.0 machine # [ 0.170471] scmi_core: SCMI protocol bus registered machine # [ 0.171449] FPGA manager framework machine # [ 0.172431] vgaarb: loaded machine # [ 0.173074] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.177036] VFS: Disk quotas dquot_6.6.0 machine # [ 0.177073] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.180948] netfs: FS-Cache loaded machine # [ 0.181073] pnp: PnP ACPI: disabled machine # [ 0.184983] NET: Registered PF_INET protocol family machine # [ 0.185812] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.215452] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.215505] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.215531] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.215592] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.215667] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.215752] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.215808] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.215865] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.215951] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.215980] NET: Registered PF_XDP protocol family machine # [ 0.216002] PCI: CLS 0 bytes, default 64 machine # [ 0.216264] Trying to unpack rootfs image as initramfs... machine # [ 0.230644] kvm [1]: HYP mode not available machine # [ 0.325633] Initialise system trusted keyrings machine # [ 0.326392] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.327678] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.328483] 9p: Installing v9fs 9p2000 file system support machine # [ 0.357185] Key type asymmetric registered machine # [ 0.357213] Asymmetric key parser 'x509' registered machine # [ 0.357290] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.359448] io scheduler mq-deadline registered machine # [ 0.359460] io scheduler kyber registered machine # [ 0.369228] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.370659] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.371053] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.371071] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.371083] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.371092] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.371114] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.371140] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.371216] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.371225] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.371232] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.371238] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.371243] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.371298] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.371732] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.371916] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.371933] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.371964] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.371980] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.372441] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.372622] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.372638] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.372668] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.392429] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.392612] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.392628] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.392657] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.401185] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.401386] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.401403] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.401432] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.401452] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.401960] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.402148] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.402177] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.402623] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.402807] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.402836] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.403236] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.403414] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.403656] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.403839] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.403868] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.404321] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.404506] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.404537] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.404975] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.422220] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.422254] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.422726] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.423026] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.423043] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.423072] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.423520] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.423698] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.423714] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.423743] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.424337] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.424349] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.424355] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.424400] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.424448] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.424494] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.424540] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.424586] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.424632] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.424677] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.424723] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.424769] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.424851] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.424903] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.424925] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.424946] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.424967] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.424989] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.425010] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.425035] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.425058] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.457159] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.457200] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.457224] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.457248] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.457271] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.457294] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.457316] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned machine # [ 0.457338] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned machine # [ 0.457361] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.457383] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.457413] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.457423] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.457427] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.458249] pci 0000:00:07.0: enabling device (0000 -> 0002) machine # [ 0.495295] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.498463] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.500555] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.502664] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.504857] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002) machine # [ 0.519010] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002) machine # [ 0.520953] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.531108] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.533054] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.544355] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.555288] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.566420] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.569435] msm_serial: driver initialized machine # [ 0.569620] SuperH (H)SCI(F) driver initialized machine # [ 0.569673] STM32 USART driver initialized machine # [ 0.606708] loop: module loaded machine # [ 0.606926] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 0.607844] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.617911] megasas: 07.734.00.00-rc1 machine # [ 0.618715] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.629716] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.629812] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.631976] Using buffer write method machine # [ 0.632089] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.633908] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.633951] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.635761] Using buffer write method machine # [ 0.635804] Concatenating MTD devices: machine # [ 0.635809] (0): "0.flash" machine # [ 0.635813] (1): "0.flash" machine # [ 0.635817] into device "0.flash" machine # [ 0.917575] Freeing initrd memory: 26424K machine # [ 0.923569] tun: Universal TUN/TAP device driver, 1.6 machine # [ 0.927595] thunder_xcv, ver 1.0 machine # [ 0.927696] thunder_bgx, ver 1.0 machine # [ 0.927718] nicpf, ver 1.0 machine # [ 0.928279] e1000: Intel(R) PRO/1000 Network Driver machine # [ 0.928288] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 0.928316] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 0.928325] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 0.928354] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 0.928360] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 0.928381] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 0.928388] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 0.928521] sky2: driver version 1.30 machine # [ 0.937781] ehci-pci 0000:00:07.0: EHCI Host Controller machine # [ 0.937828] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1 machine # [ 0.938033] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000 machine # [ 0.940826] usbcore: registered new interface driver usb-storage machine # [ 0.940917] usbcore: registered new interface driver usbserial_generic machine # [ 0.940930] usbserial: USB Serial support registered for generic machine # [ 0.943864] hv_vmbus: registering driver hyperv_keyboard machine # [ 0.945465] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 0.945492] rtc-pl031 9010000.pl031: setting system clock to 2026-09-15T03:03:04 UTC (1789441384) machine # [ 0.945794] i2c_dev: i2c /dev entries driver machine # [ 0.951390] sdhci: Secure Digital Host Controller Interface driver machine # [ 0.951404] sdhci: Copyright(c) Pierre Ossman machine # [ 0.951672] Synopsys Designware Multimedia Card Interface Driver machine # [ 0.952074] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 0.955954] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00 machine # [ 0.957129] hub 1-0:1.0: USB hub found machine # [ 0.957652] hub 1-0:1.0: 6 ports detected machine # [ 0.959219] hid: raw HID events driver (C) Jiri Kosina machine # [ 0.959480] usbcore: registered new interface driver usbhid machine # [ 0.959487] usbhid: USB HID core driver machine # [ 0.962468] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 0.963999] drop_monitor: Initializing network drop monitor service machine # [ 0.964204] NET: Registered PF_INET6 protocol family machine # [ 0.967338] Segment Routing with IPv6 machine # [ 0.967369] In-situ OAM (IOAM) with IPv6 machine # [ 0.967399] NET: Registered PF_PACKET protocol family machine # [ 0.969107] 9pnet: Installing 9P2000 support machine # [ 0.969161] Key type dns_resolver registered machine # [ 0.975865] registered taskstats version 1 machine # [ 0.976015] Loading compiled-in X.509 certificates machine # [ 0.985063] Demotion targets for Node 0: null machine # [ 0.985951] Key type .fscrypt registered machine # [ 0.985969] Key type fscrypt-provisioning registered machine # [ 0.986078] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.986098] ima: Allocated hash algorithm: sha1 machine # [ 0.986123] ima: No architecture policies found machine # [ 0.989816] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 1.008367] clk: Disabling unused clocks machine # [ 1.008399] PM: genpd: Disabling unused power domains machine # [ 1.012742] Freeing unused kernel memory: 4736K machine # [ 1.012938] Run /init as init process machine # [ 1.027613] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.205181] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.357765] 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/input1 machine # [ 1.364389] systemd[1]: systemd 262-e2c8482 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 1.364461] systemd[1]: Detected virtualization qemu. machine # [ 1.364593] systemd[1]: Detected architecture arm64. machine # [ 1.364626] systemd[1]: Running in initrd. machine # [ 1.383933] systemd[1]: Initializing machine ID from random generator. machine # [ 1.386951] systemd[1]: Hostname set to . machine # [ 1.441412] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0 machine # [ 1.536236] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.565183] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.590929] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.599328] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.600493] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.601812] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.601846] systemd[1]: Reached target Path Units. machine # [ 1.601866] systemd[1]: Reached target Slice Units. machine # [ 1.601885] systemd[1]: Reached target Swaps. machine # [ 1.601904] systemd[1]: Reached target Timer Units. machine # [ 1.602071] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.602255] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.602395] systemd[1]: Listening on Journal Sockets. machine # [ 1.602482] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.602502] systemd[1]: Reached target Socket Units. machine # [ 1.611928] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.612018] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.621276] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.629601] systemd[1]: Starting Journal Service... machine # [ 1.653417] systemd[1]: Starting Load Kernel Modules... machine # [ 1.654327] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.672248] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.675831] systemd-journald[72]: Collecting audit messages is disabled. machine # [ 1.697298] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.698145] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.705655] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.722449] 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/input2 machine # [ 1.722594] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0 machine # [ 1.758697] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.761432] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.767839] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0 machine # [ 1.768100] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.768113] [drm] features: -context_init machine # [ 1.768989] [drm] number of scanouts: 1 machine # [ 1.769011] [drm] number of cap sets: 0 machine # [ 1.785848] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.789504] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.801661] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic machine # [ 1.801688] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0 machine # [ 1.821434] Console: switching to colour frame buffer device 160x50 machine # [ 1.857824] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.862967] systemd[1]: Started Journal Service. machine # [ 1.851690] systemd-modules-load[73]: Inserted module 'dm_mod' machine # [ 1.853286] systemd-modules-load[73]: Module 'virtio_balloon' is built in machine # [ 1.860604] systemd-modules-load[73]: Module 'virtio_console' is built in machine # [ 1.864557] systemd-modules-load[73]: Inserted module 'virtio_gpu' machine # [ 1.865730] systemd-modules-load[73]: Module 'virtio_rng' is built in machine # [ 1.866753] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.867822] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.880567] systemd[1]: Reached target Local File Systems. machine # [ 1.881452] systemd[1]: Starting Create System Files and Directories... machine # [ 1.882375] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.894693] systemd[1]: Finished Load Kernel Modules. machine # [ 1.925886] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.936944] systemd[1]: Finished Create System Files and Directories. machine # [ 1.969714] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.985638] systemd-udevd[80]: Using default interface naming scheme 'v261'. machine # [ 2.017501] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 2.092763] systemd[1]: Starting Virtual Console Setup... machine # [ 2.172885] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.176460] systemd[1]: Finished Virtual Console Setup. machine # [ 2.763917] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.765504] systemd[1]: Reached target System Initialization. machine # [ 2.768148] systemd[1]: Reached target Basic System. machine # [ 2.910973] (udev-worker)[91]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.927643] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.937977] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.993907] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.995935] systemd[1]: Reached target Initrd Root Device. machine # [ 2.999751] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 3.055814] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 3.064582] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 3.069613] systemd[1]: Mounting /sysroot... machine # [ 3.128257] EXT4-fs (vda): mounted filesystem e00a30b9-bc99-47d2-9494-fb21902f6059 r/w with ordered data mode. Quota mode: none. machine # [ 3.122574] systemd[1]: Mounted /sysroot. machine # [ 3.123842] systemd[1]: Reached target Initrd Root File System. machine # [ 3.127755] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 3.156235] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 3.164305] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 3.169133] systemd[1]: Reloading... machine # [ 3.366934] systemd[1]: Reloading finished in 199 ms. machine # [ 3.398601] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace... machine # [ 3.402159] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace... machine # [ 3.409293] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.412153] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.414552] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.669465] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.686438] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.692465] systemd[1]: Mounting /sysroot/run... machine # [ 3.720208] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.733998] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.815535] fuse: init (API version 7.45) machine # [ 3.803016] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.828150] virtiofs virtio6: discovered new tag: nix-store machine # [ 3.828969] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 3.843495] virtiofs virtio7: discovered new tag: shared machine # [ 3.844333] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 3.832710] systemd[1]: Mounted /sysroot/run. machine # [ 3.856353] virtiofs virtio8: discovered new tag: xchg machine # [ 3.864306] virtiofs virtio8: virtio_fs_setup_dax: No cache capability machine # [ 3.866162] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.868188] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.869498] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.874700] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.898624] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.900229] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.307027] (udev-worker)[93]: mtd0ro: Failed to find and pin callout binary "/nix/store/al78c9sxmxk3mqaa310k7pdy8i9i75py-systemd-262-e2c8482/lib/udev/mtd_probe": No such file or directory machine # [ 4.313008] (udev-worker)[93]: mtd0ro: /etc/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory machine # [ 4.344759] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.349579] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.350435] systemd[1]: Stopping Virtual Console Setup... machine # [ 4.351951] systemd[1]: Starting Virtual Console Setup... machine # [ 4.369160] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.370747] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.373195] systemd[1]: Starting Virtual Console Setup... machine # [ 4.396375] systemd-vconsole-setup[153]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 4.399760] systemd[1]: Finished Virtual Console Setup. machine # [ 4.671377] systemd[1]: Mounting /sysroot/nix/store... machine # [ 4.739966] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.744276] systemd[1]: Reached target Initrd File Systems. machine # [ 4.747899] systemd[1]: Starting Find NixOS closure... machine # [ 4.760967] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.802617] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.807995] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 4.823569] systemd[1]: Finished Find NixOS closure. machine # [ 4.827588] systemd[1]: Reached target Initrd Default Target. machine # [ 4.832552] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.867957] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.872196] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.874606] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.878732] systemd[1]: Stopped target Basic System. machine # [ 4.879787] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.884327] systemd[1]: Stopped target Path Units. machine # [ 4.885221] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.886455] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.887796] systemd[1]: Stopped target Slice Units. machine # [ 4.892349] systemd[1]: Stopped target Socket Units. machine # [ 4.896475] systemd[1]: Stopped target System Initialization. machine # [ 4.898458] systemd[1]: Stopped target Swaps. machine # [ 4.900339] systemd[1]: Stopped target Timer Units. machine # [ 4.901965] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.910139] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.911176] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.913675] systemd[1]: Stopped Find NixOS closure. machine # [ 4.915384] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.919096] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.922170] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.924789] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.927209] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.929961] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.931959] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.936561] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.937623] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.940249] systemd[1]: Stopped target Local File Systems. machine # [ 4.941186] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.942159] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.943193] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.943976] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.945173] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.946174] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.946910] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.947911] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.952215] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.953215] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.955453] systemd[1]: systemd-udevd.service: Consumed 1.440s CPU time over 3.057s wall clock time, 21.9M memory peak. machine # [ 4.960347] systemd[1]: Starting Cleanup udev Database... machine # [ 4.961197] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.964177] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.965109] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.968171] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.972180] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.973171] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.999067] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 5.002637] systemd[1]: Finished Cleanup udev Database. machine # [ 5.003514] systemd[1]: Reached target Switch Root. machine # [ 5.005128] systemd[1]: Starting NixOS Activation... machine # [ 5.088218] initrd-nixos-activation-start[176]: booting system configuration /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test machine # [ 5.123230] initrd-nixos-activation-start[176]: running activation script... machine # [ 5.388596] initrd-nixos-activation-start[199]: setting up /etc... machine # [ 5.512489] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 5.515423] systemd[1]: Finished NixOS Activation. machine # [ 5.516682] systemd[1]: Starting Switch Root... machine # [ 5.540320] systemd[1]: Switching root. machine # [ 5.723463] systemd-journald[72]: Received SIGTERM from PID 1 (systemd). machine # [ 6.243165] systemd[1]: systemd 262-e2c8482 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 6.256151] systemd[1]: Detected virtualization qemu. machine # [ 6.259631] systemd[1]: Detected architecture arm64. machine # [ 6.263968] systemd[1]: Detected first boot. machine # [ 6.268700] systemd[1]: Initializing machine ID from random generator. machine # [ 6.430678] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 6.618545] systemd[1]: Applying preset policy. machine # [ 6.840006] systemd[1]: Populated /etc with preset unit settings. machine # [ 7.055223] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 7.056683] systemd[1]: Stopped initrd-switch-root.service. machine # [ 7.060217] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 7.064192] systemd[1]: Created slice Slice /system/getty. machine # [ 7.066410] systemd[1]: Created slice User and Session Slice. machine # [ 7.067739] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 7.069549] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 7.071980] systemd[1]: Expecting device /dev/hvc0... machine # [ 7.073240] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 7.074872] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 7.076548] systemd[1]: Stopped target initrd-fs.target. machine # [ 7.078213] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 7.079845] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 7.081670] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 7.083441] systemd[1]: Reached target Path Units. machine # [ 7.084984] systemd[1]: Reached target Remote File Systems. machine # [ 7.086649] systemd[1]: Reached target Slice Units. machine # [ 7.088253] systemd[1]: Reached target Swaps. machine # [ 7.091389] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 7.094682] systemd[1]: Listening on Process Core Dump Socket. machine # [ 7.097181] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 7.099532] systemd[1]: Listening on Factory Reset Management. machine # [ 7.100935] systemd[1]: Listening on Hostname Service Socket. machine # [ 7.106556] systemd[1]: Starting Journal Log Access Socket... machine # [ 7.109255] systemd[1]: Listening on Journal Audit Socket. machine # [ 7.112311] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 7.114267] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 7.116917] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.119547] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 7.124680] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 7.126374] systemd[1]: Listening on udev Varlink Socket. machine # [ 7.130750] systemd[1]: Mounting Huge Pages File System... machine # [ 7.138403] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 7.149850] systemd[1]: Mounting Kernel Debug File System... machine # [ 7.163207] systemd[1]: Mounting Kernel Trace File System... machine # [ 7.176356] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 7.181384] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 7.197846] systemd[1]: Mounting Kernel Configuration File System... machine # [ 7.201937] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 7.209340] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 7.215159] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 7.234500] systemd[1]: Mounting FUSE Control File System... machine # [ 7.236954] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 7.277961] systemd[1]: Starting Journal Service... machine # [ 7.292412] systemd[1]: Starting Load Kernel Modules... machine # [ 7.313929] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 7.335027] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 7.335476] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.347326] systemd[1]: Starting Coldplug All udev Devices... machine # [ 7.355852] systemd[1]: Listening on Journal Log Access Socket. machine # [ 7.379549] systemd[1]: Mounted Huge Pages File System. machine # [ 7.381481] systemd-journald[270]: Collecting audit messages is enabled. machine # [ 7.385455] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 7.387679] systemd[1]: Mounted Kernel Debug File System. machine # [ 7.398797] systemd[1]: Mounted Kernel Trace File System. machine # [ 7.387607] systemd[1]: Queued start job for default target Multi-User System. machine # [ 7.407730] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 7.392442] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 7.393870] systemd-modules-load[271]: Module 'atkbd' is built in machine # [ 7.394908] systemd-modules-load[271]: Module 'loop' is built in machine # [ 7.413692] systemd[1]: Started Journal Service. machine # [ 7.409742] systemd[1]: Mounted Kernel Configuration File System. machine # [ 7.410900] systemd[1]: Finished Load Kernel Modules. machine # [ 7.426189] systemd[1]: Starting Firewall... machine # [ 7.431055] systemd[1]: Starting Apply Kernel Variables... machine # [ 7.437953] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 7.461571] systemd[1]: Mounted FUSE Control File System. machine # [ 7.510629] systemd-oomd[272]: No swap; memory pressure usage will be degraded machine # [ 7.534372] EXT4-fs (vda): re-mounted e00a30b9-bc99-47d2-9494-fb21902f6059. machine # [ 7.523758] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 7.538977] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 7.540290] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 7.543444] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 7.548459] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 7.555925] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 7.557124] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.643619] systemd-journald[270]: Received client request to flush runtime journal. machine # [ 7.692743] systemd[1]: Finished Apply Kernel Variables. machine # [ 7.693791] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 7.694603] systemd[1]: Reached target First Boot Complete. machine # [ 7.701526] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 7.745742] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 7.753843] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 8.030643] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 8.031911] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 8.039073] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 8.045240] systemd[1]: Mounting /run/wrappers... machine # [ 8.138314] systemd[1]: Mounted /run/wrappers. machine # [ 8.139179] systemd[1]: Reached target Local File Systems. machine # [ 8.144806] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 8.150318] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 8.151289] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 8.159765] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 8.168877] systemd[1]: Starting Create System Files and Directories... machine # [ 8.224449] systemd-udevd[309]: Using default interface naming scheme 'v261'. machine # [ 8.290019] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 8.306460] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 8.391779] systemd[1]: Finished Create System Files and Directories. machine # [ 8.404596] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 8.419750] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 8.457019] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 8.562317] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 8.636258] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 8.650336] systemd[1]: Starting Update is Completed... machine # [ 8.768295] systemd[1]: Finished Update is Completed. machine # [ 8.912297] systemd[1]: Finished Coldplug All udev Devices. machine # [ 9.032695] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 9.116388] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 9.193567] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 9.197840] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 9.202018] systemd[1]: Reached target System Initialization. machine # [ 9.203001] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 9.209753] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 9.210841] systemd[1]: Reached target Timer Units. machine # [ 9.211646] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 9.219412] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 9.224395] systemd[1]: Reached target Socket Units. machine # [ 9.225211] systemd[1]: Reached target Basic System. machine # [ 9.225975] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 9.226998] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 9.240265] systemd[1]: Starting Post-Boot Actions... machine # [ 9.255681] systemd[1]: Started Reset console on configuration changes. machine # [ 9.301238] systemd[1]: Starting resolvconf update... machine # [ 9.376240] systemd[1]: Starting D-Bus System Message Bus... machine # [ 9.470469] systemd[1]: Finished Post-Boot Actions. machine # [ 9.475431] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 9.481270] nsncd[425]: Sep 15 03:03:13.037 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 9.494954] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 9.500336] systemd[1]: Reached target User and Group Name Lookups. machine # [ 9.514508] systemd[1]: Starting User Login Management... machine # [ 9.584521] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 9.605568] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 9.676718] dbus-broker-launch[432]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 9.686271] dbus-broker-launch[432]: NSS returned no entry for 'systemd-timesync' machine # [ 9.687734] dbus-broker-launch[432]: Invalid user-name in /nix/store/c9nrn6v70pra6pzb62dikfw38862ij06-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 9.711579] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 9.720914] systemd[1]: Started backdoor.service. machine # [ 9.780259] systemd[1]: Started D-Bus System Message Bus. machine # [ 9.844315] systemd-logind[451]: New seat seat0. machine # [ 9.856176] systemd[1]: Started User Login Management. machine # [ 9.857453] dbus-broker-launch[432]: Ready machine # [ 9.872379] systemd[1]: Starting linger-users.service... machine # [ 9.920680] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 9.921869] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 9.922873] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 9.923864] systemd[1]: Stopping User and Group Name Lookups... machine # connecting to host... machine # [ 9.947724] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 9.954032] systemd[1]: nscd.service: Deactivated successfully. machine # [ 9.962389] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 10.006458] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 10.31 seconds) machine: (finished: waiting for the VM to finish booting, in 10.85 seconds) machine # [ 10.126673] (udev-worker)[377]: Network interface NamePolicy= disabled on kernel command line. machine # [ 10.186697] systemd[1]: Created slice Slice /user/1001. machine # [ 10.187796] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 10.247137] (udev-worker)[387]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 10.312694] (udev-worker)[387]: Network interface NamePolicy= disabled on kernel command line. machine # [ 10.314443] nsncd[522]: Sep 15 03:03:13.828 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 10.374434] systemd[1]: Finished resolvconf update. machine # [ 10.375340] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 10.412923] systemd[1]: Finished linger-users.service. machine # [ 10.413773] systemd[1]: Starting DHCP Client... machine # [ 10.414472] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 10.415373] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 10.479132] systemd[1]: Reached target User and Group Name Lookups. machine # [ 10.546188] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 10.608726] systemd-logind[451]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # [ 10.737341] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 10.738484] systemd[1]: Starting User Manager for UID 1001... machine # [ 10.802664] mousedev: PS/2 mouse device common for all mice machine # [ 10.829010] (systemd)[573]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 10.855218] systemd-logind[451]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 10.917342] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 11.210905] systemd-logind[451]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 11.269059] systemd[573]: Queued start job for default target Main User Target. machine # [ 11.281489] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 11.283173] systemd[573]: Created slice User Application Slice. machine # [ 11.296668] systemd[573]: Started Daily Cleanup of User's Temporary Directories. machine # [ 11.298235] dhcpcd[579]: dhcpcd-10.3.2 starting machine # [ 11.299028] systemd[573]: Reached target Paths. machine # [ 11.299720] systemd[573]: Reached target Timers. machine # [ 11.326775] systemd[573]: Starting D-Bus User Message Bus Socket... machine # [ 11.330728] dhcpcd[598]: dev: loaded udev machine # [ 11.331550] systemd[573]: Starting Create User Files and Directories... machine # [ 11.363260] systemd[573]: Finished Create User Files and Directories. machine # [ 11.389437] 8021q: 802.1Q VLAN Support v1.8 machine # [ 11.410352] systemd[573]: Listening on D-Bus User Message Bus Socket. machine # [ 11.411407] systemd[573]: Reached target Sockets. machine # [ 11.420981] systemd[573]: Reached target Basic System. machine # [ 11.421829] systemd[1]: Started User Manager for UID 1001. machine # [ 11.422664] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 11.519141] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 11.554016] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 11.555136] systemd[573]: Reached target Main User Target. machine # [ 11.589584] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 11.590155] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 11.594997] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 11.595337] cfg80211: failed to load regulatory.db machine # [ 11.587865] systemd[573]: Startup finished in 668ms. machine # [ 11.652690] systemd[1]: Finished Firewall. machine # [ 11.653472] systemd[1]: Reached target Preparation for Network. machine # [ 11.689611] systemd[1]: Starting Address configuration of eth1... machine # [ 11.690648] systemd[1]: Starting Extra networking commands.... machine # [ 12.155915] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 12.163854] dhcpcd[598]: eth0: waiting for carrier machine # [ 12.175227] dhcpcd[598]: eth0: carrier acquired machine # [ 12.216089] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 12.263438] dhcpcd[598]: DUID 00:01:00:01:32:3b:71:f3:52:54:00:12:34:56 machine # [ 12.280281] dhcpcd[598]: eth0: IAID 00:12:34:56 machine # [ 12.281093] dhcpcd[598]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 12.328516] network-addresses-eth1-start[630]: adding address 192.168.1.1/24... done machine # [ 12.417509] network-addresses-eth1-start[630]: adding address 2001:db8:1::1/64... done machine # [ 12.544157] systemd[1]: Finished Address configuration of eth1. machine # [ 12.621565] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3 machine # [ 13.025043] systemd[1]: Starting Virtual Console Setup... machine # [ 13.046579] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 13.099937] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 13.105363] systemd[1]: Stopped Virtual Console Setup. machine # [ 13.106216] systemd[1]: Starting Virtual Console Setup... machine # [ 13.117609] systemd-logind[451]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 13.132501] systemd[1]: Finished Extra networking commands.. machine # [ 13.138386] systemd[1]: Reached target Network. machine # [ 13.141411] systemd[1]: Starting Permit User Sessions... machine # [ 13.186681] systemd[1]: Finished Permit User Sessions. machine # [ 13.197672] systemd[1]: Started Getty on tty1. machine # [ 13.198478] systemd[1]: Reached target Login Prompts. machine # [ 13.286128] systemd-vconsole-setup[707]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 13.291947] systemd[1]: Finished Virtual Console Setup. machine # [ 13.743316] dhcpcd[598]: eth0: soliciting a DHCP lease machine # [ 13.745161] dhcpcd[598]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 13.752267] dhcpcd[598]: eth0: probing address 10.0.2.15/24 machine # [ 14.910797] dhcpcd[598]: eth0: soliciting an IPv6 router machine # [ 14.912073] dhcpcd[598]: eth0: Router Advertisement from fe80::2 machine # [ 14.913188] dhcpcd[598]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 14.914385] dhcpcd[598]: eth0: adding route to fec0::/64 machine # [ 14.915428] dhcpcd[598]: eth0: adding default route via fe80::2 machine # [ 19.071799] dhcpcd[598]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 19.076621] dhcpcd[598]: eth0: adding route to 10.0.2.0/24 machine # [ 19.079125] dhcpcd[598]: eth0: adding default route via 10.0.2.2 machine # [ 19.310674] systemd[1]: Started DHCP Client. machine # [ 19.313092] systemd[1]: Reached target Multi-User System. machine # [ 19.314011] systemd[1]: Startup finished in 1.000s (kernel) + 4.805s (initrd) + 13.506s (userspace) = 19.312s. machine: (finished: waiting for unit multi-user.target, in 21.22 seconds) machine: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 20.674854] nixos[838]: switching to system configuration /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test machine # [ 20.677908] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # [ 20.680881] systemd[1]: Stopped target Local File Systems. machine # setting up /etc... machine # [ 21.002426] systemd[1]: Reload requested from client PID 838 ('.switch-to-conf') (unit backdoor.service)... machine # [ 21.004665] systemd[1]: Reloading... machine # [ 21.335962] systemd[1]: Reloading finished in 329 ms. machine # reloading user units for usertest... machine # [ 21.387355] systemd[573]: Created slice User Core Session Slice. machine # [ 21.390714] systemd[573]: Starting D-Bus User Message Bus... machine # [ 21.425294] dbus-broker-launch[908]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/c9nrn6v70pra6pzb62dikfw38862ij06-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 21.428365] dbus-broker-launch[908]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/c9nrn6v70pra6pzb62dikfw38862ij06-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 21.431181] dbus-broker-launch[908]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/c9nrn6v70pra6pzb62dikfw38862ij06-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 21.434126] dbus-broker-launch[908]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/c9nrn6v70pra6pzb62dikfw38862ij06-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 21.438515] dbus-broker-launch[908]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 21.440664] dbus-broker-launch[908]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 21.443417] systemd[573]: Started D-Bus User Message Bus. machine # [ 21.446124] dbus-broker-launch[908]: Ready machine # [ 21.517948] systemd[573]: Reexecution requested from client PID 907 ('switch-to-confi')... machine # [ 21.524262] systemd[573]: Reexecuting. machine # [ 21.575386] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.693690] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.700359] systemd[573]: Reload requested from client PID 907 ('switch-to-confi')... machine # [ 21.702955] systemd[573]: Reloading... machine # [ 21.816002] systemd[573]: Reloading finished in 112 ms. machine # [ 21.832211] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 21.842500] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 21.845045] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 21.847439] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 21.881404] systemd[573]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 21.894484] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 21.986066] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 21.990680] systemd[1]: Reached target Reactivate sysinit units. machine # [ 21.992839] systemd[1]: Reached target Local File Systems. machine # [ 22.001167] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.008928] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 22.010362] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 22.011872] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 22.023410] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 22.024934] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 22.027091] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 22.028880] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.030167] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.031375] systemd[1]: Reached target Remote File Systems. machine # [ 22.207732] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 22.211086] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 22.215495] systemd[1]: Starting linger-users.service... machine # [ 22.262958] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 22.265885] systemd[1]: Finished linger-users.service. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 22.531107] nixos[838]: finished switching to system configuration /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/bin/switch-to-configuration test, in 2.16 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.05 seconds) machine: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/ql90zw72pba4wgvpnbr96qpnf14lw7hy-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/ql90zw72pba4wgvpnbr96qpnf14lw7hy-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 22.854986] nixos[986]: switching to system configuration /nix/store/ql90zw72pba4wgvpnbr96qpnf14lw7hy-nixos-system-other-test machine # activating the configuration... machine # [ 22.859553] systemd[1]: Stopped target Remote File Systems. machine # [ 22.861281] systemd[1]: Stopped target Local File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 23.150052] systemd[1]: Reload requested from client PID 986 ('.switch-to-conf') (unit backdoor.service)... machine # [ 23.152247] systemd[1]: Reloading... machine # [ 23.479126] systemd[1]: Reloading finished in 325 ms. machine # reloading user units for usertest... machine # [ 23.572267] systemd[573]: Reexecution requested from client PID 1057 ('switch-to-confi')... machine # [ 23.576716] systemd[573]: Reexecuting. machine # [ 23.635477] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.760834] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.767944] systemd[573]: Reload requested from client PID 1057 ('switch-to-confi')... machine # [ 23.771172] systemd[573]: Reloading... machine # [ 23.881655] systemd[573]: Reloading finished in 111 ms. machine # [ 23.896161] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 23.905946] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 23.908074] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 23.910194] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 23.939959] systemd[573]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 23.944305] systemd[1]: Stopped target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service machine # [ 23.946943] systemd[1]: Stopping Reactivate sysinit units... machine # [ 23.947779] systemd[1]: Reached target Reactivate sysinit units. machine # [ 23.951505] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 23.952863] dbus-broker-launch[432]: Caught SIGHUP, trigger reload. machine # [ 23.958832] dbus-broker-launch[432]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 23.960956] dbus-broker-launch[432]: NSS returned no entry for 'systemd-timesync' machine # [ 23.962102] dbus-broker-launch[432]: Invalid user-name in /nix/store/7skfqgsjdnc3c5kzrxdj6kb220hl5qz2-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 23.991259] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 23.997745] systemd[1]: Stopping Address configuration of eth1... machine # [ 24.026725] network-addresses-eth1-pre-stop[1069]: deleting address 192.168.1.1/24... done machine # [ 24.033098] network-addresses-eth1-pre-stop[1069]: deleting address 2001:db8:1::1/64... done machine # [ 24.039629] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 24.041872] systemd[1]: Stopped Address configuration of eth1. machine # [ 24.046401] systemd[1]: Starting Address configuration of eth1... machine # [ 24.084737] network-addresses-eth1-start[1074]: adding address 192.168.1.2/24... done machine # [ 24.091509] network-addresses-eth1-start[1074]: adding address 2001:db8:1::2/64... done machine # [ 24.100502] systemd[1]: Finished Address configuration of eth1. machine # [ 24.104952] systemd[1]: Reached target Local File Systems. machine # [ 24.108382] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 24.110921] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 24.111777] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 24.120272] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 24.122459] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 24.123994] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.130429] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.131625] systemd[1]: Reached target Remote File Systems. machine # [ 24.136001] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.138245] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 24.317219] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 24.319657] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 24.323764] systemd[1]: Starting linger-users.service... machine # [ 24.354603] linger-users-start[1146]: id: ‘usertest’: no such user machine # [ 24.356665] linger-users-start[1144]: Removing linger for missing user usertest machine # [ 24.362940] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 24.366153] systemd[1]: Finished linger-users.service. machine # [ 24.623185] nixos[986]: finished switching to system configuration /nix/store/ql90zw72pba4wgvpnbr96qpnf14lw7hy-nixos-system-other-test machine: (finished: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/ql90zw72pba4wgvpnbr96qpnf14lw7hy-nixos-system-other-test/bin/switch-to-configuration test, in 2.05 seconds) subtest: services machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 24.933302] nixos[1152]: switching to system configuration /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test machine # [ 24.935665] systemd[1]: Stopped target Remote File Systems. machine # [ 24.938477] systemd[1]: Stopped target Local File Systems. machine # [ 25.204191] systemd[1]: Reload requested from client PID 1152 ('.switch-to-conf') (unit backdoor.service)... machine # [ 25.206209] systemd[1]: Reloading... machine # [ 25.529147] systemd[1]: Reloading finished in 320 ms. machine # [ 25.616976] systemd[573]: Reexecution requested from client PID 1222 ('switch-to-confi')... machine # [ 25.621499] systemd[573]: Reexecuting. machine # [ 25.675854] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.795075] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.801905] systemd[573]: Reload requested from client PID 1222 ('switch-to-confi')... machine # [ 25.805957] systemd[573]: Reloading... machine # [ 25.920343] systemd[573]: Reloading finished in 115 ms. machine # [ 25.936191] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.947685] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 25.948915] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 25.951275] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 25.985535] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 25.989631] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 25.991595] systemd[1]: Stopping Reactivate sysinit units... machine # [ 25.997184] systemd[1]: Reached target Reactivate sysinit units. machine # [ 25.998080] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 25.999254] dbus-broker-launch[432]: Caught SIGHUP, trigger reload. machine # [ 26.002604] dbus-broker-launch[432]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 26.005068] dbus-broker-launch[432]: NSS returned no entry for 'systemd-timesync' machine # [ 26.006128] dbus-broker-launch[432]: Invalid user-name in /nix/store/c9nrn6v70pra6pzb62dikfw38862ij06-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 26.020209] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 26.026776] systemd[1]: Stopping Address configuration of eth1... machine # [ 26.062035] network-addresses-eth1-pre-stop[1234]: deleting address 192.168.1.2/24... done machine # [ 26.069004] network-addresses-eth1-pre-stop[1234]: deleting address 2001:db8:1::2/64... done machine # [ 26.075975] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 26.078344] systemd[1]: Stopped Address configuration of eth1. machine # [ 26.082845] systemd[1]: Starting Address configuration of eth1... machine # [ 26.129474] network-addresses-eth1-start[1239]: adding address 192.168.1.1/24... done machine # [ 26.137016] network-addresses-eth1-start[1239]: adding address 2001:db8:1::1/64... done machine # [ 26.147424] systemd[1]: Finished Address configuration of eth1. machine # [ 26.151473] systemd[1]: Reached target Remote File Systems. machine # [ 26.156473] systemd[1]: Starting linger-users.service... machine # [ 26.166517] systemd[1]: Reached target Local File Systems. machine # [ 26.167529] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 26.176699] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 26.177678] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 26.178921] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 26.195717] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 26.201168] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.203063] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.209961] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.211396] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 26.237922] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 26.241609] systemd[1]: Finished linger-users.service. machine # [ 26.413222] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 26.415124] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 26.675284] nixos[1152]: finished switching to system configuration /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.05 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 26.949288] nixos[1308]: switching to system configuration /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test machine # [ 26.952464] systemd[1]: Stopped target Local File Systems. machine # [ 26.954950] systemd[1]: Stopped target Remote File Systems. machine # [ 27.231066] systemd[1]: Reload requested from client PID 1308 ('.switch-to-conf') (unit backdoor.service)... machine # [ 27.233111] systemd[1]: Reloading... machine # [ 27.555109] systemd[1]: Reloading finished in 320 ms. machine # [ 27.646323] systemd[573]: Reexecution requested from client PID 1377 ('switch-to-confi')... machine # [ 27.647748] systemd[573]: Reexecuting. machine # [ 27.708196] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.825479] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.832098] systemd[573]: Reload requested from client PID 1377 ('switch-to-confi')... machine # [ 27.834146] systemd[573]: Reloading... machine # [ 27.946466] systemd[573]: Reloading finished in 111 ms. machine # [ 27.964204] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.973550] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 27.975975] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 27.978137] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 28.011972] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 28.016899] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 28.017912] systemd[1]: Stopping Reactivate sysinit units... machine # [ 28.018735] systemd[1]: Reached target Reactivate sysinit units. machine # [ 28.023536] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.028224] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 28.029573] systemd[1]: Reached target Remote File Systems. machine # [ 28.031270] systemd[1]: Starting linger-users.service... machine # [ 28.035283] systemd[1]: Reached target Local File Systems. machine # [ 28.039873] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 28.044139] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 28.044995] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 28.046198] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 28.060624] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 28.062292] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.063568] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.137833] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 28.144243] systemd[1]: Finished linger-users.service. machine # [ 28.304277] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 28.307758] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 28.567056] nixos[1308]: finished switching to system configuration /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.89 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 28.863707] nixos[1449]: switching to system configuration /nix/store/bam51p0g3qwm6j6ydgyyfvnh0jzh68d2-nixos-system-machine-test machine # [ 28.866310] systemd[1]: Stopped target Local File Systems. machine # [ 28.868766] systemd[1]: Stopped target Remote File Systems. machine # [ 29.159492] systemd[1]: Reload requested from client PID 1449 ('.switch-to-conf') (unit backdoor.service)... machine # [ 29.161703] systemd[1]: Reloading... machine # [ 29.506373] systemd[1]: Reloading finished in 343 ms. machine # [ 29.598654] systemd[573]: Reexecution requested from client PID 1518 ('switch-to-confi')... machine # [ 29.600891] systemd[573]: Reexecuting. machine # [ 29.659885] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.782583] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.789266] systemd[573]: Reload requested from client PID 1518 ('switch-to-confi')... machine # [ 29.793218] systemd[573]: Reloading... machine # [ 29.911655] systemd[573]: Reloading finished in 119 ms. machine # [ 29.929921] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.938506] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 29.941411] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 29.943830] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 29.979637] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 29.984177] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 29.986712] systemd[1]: Stopping Reactivate sysinit units... machine # [ 29.989889] systemd[1]: Reached target Reactivate sysinit units. machine # [ 29.990828] systemd[1]: Reached target Remote File Systems. machine # [ 29.996136] systemd[1]: Starting linger-users.service... machine # [ 30.001090] systemd[1]: Starting test.service... machine # [ 30.008943] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.010530] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 30.023588] systemd[1]: Reached target Local File Systems. machine # [ 30.029206] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 30.042138] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 30.043268] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 30.055522] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 30.065058] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 30.066972] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.077624] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.090274] systemd[1]: Finished test.service. machine # [ 30.129411] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 30.133483] systemd[1]: Finished linger-users.service. machine # [ 30.306130] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 30.310249] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 30.569359] nixos[1449]: finished switching to system configuration /nix/store/bam51p0g3qwm6j6ydgyyfvnh0jzh68d2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 2.00 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 30.831170] nixos[1591]: switching to system configuration /nix/store/bam51p0g3qwm6j6ydgyyfvnh0jzh68d2-nixos-system-machine-test machine # [ 30.836200] systemd[1]: Stopped target Local File Systems. machine # [ 30.837114] systemd[1]: Stopped target Remote File Systems. machine # [ 31.108146] systemd[1]: Reload requested from client PID 1591 ('.switch-to-conf') (unit backdoor.service)... machine # [ 31.110140] systemd[1]: Reloading... machine # [ 31.434176] systemd[1]: Reloading finished in 322 ms. machine # [ 31.570920] systemd[573]: Reexecution requested from client PID 1660 ('switch-to-confi')... machine # [ 31.573858] systemd[573]: Reexecuting. machine # [ 31.631553] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.754036] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.761014] systemd[573]: Reload requested from client PID 1660 ('switch-to-confi')... machine # [ 31.763302] systemd[573]: Reloading... machine # [ 31.876893] systemd[573]: Reloading finished in 113 ms. machine # [ 31.892194] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.900956] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 31.903345] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 31.905471] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 31.936625] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 31.939972] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 31.941539] systemd[1]: Stopping Reactivate sysinit units... machine # [ 31.942353] systemd[1]: Reached target Reactivate sysinit units. machine # [ 31.945148] systemd[1]: Reached target Local File Systems. machine # [ 31.950528] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 31.958174] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 31.964616] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 31.965912] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 31.973971] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 31.975608] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.977140] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.978361] systemd[1]: Reached target Remote File Systems. machine # [ 31.979172] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.980470] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 32.141716] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 32.144549] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 32.148727] systemd[1]: Starting linger-users.service... machine # [ 32.189282] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 32.192637] systemd[1]: Finished linger-users.service. machine # [ 32.450992] nixos[1591]: finished switching to system configuration /nix/store/bam51p0g3qwm6j6ydgyyfvnh0jzh68d2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.88 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 32.750148] nixos[1732]: switching to system configuration /nix/store/yk1n0ws1jwdw9sfv6b1bc03y23ygls39-nixos-system-machine-test machine # [ 32.753143] systemd[1]: Stopped target Local File Systems. machine # [ 32.755517] systemd[1]: Stopped target Remote File Systems. machine # [ 33.036154] systemd[1]: Reload requested from client PID 1732 ('.switch-to-conf') (unit backdoor.service)... machine # [ 33.038094] systemd[1]: Reloading... machine # [ 33.463189] systemd[1]: Reloading finished in 423 ms. machine # [ 33.552435] systemd[573]: Reexecution requested from client PID 1801 ('switch-to-confi')... machine # [ 33.555784] systemd[573]: Reexecuting. machine # [ 33.615207] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.730341] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.737887] systemd[573]: Reload requested from client PID 1801 ('switch-to-confi')... machine # [ 33.739244] systemd[573]: Reloading... machine # [ 33.852704] systemd[573]: Reloading finished in 112 ms. machine # [ 33.868350] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.879467] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 33.881958] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 33.884001] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 33.917490] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 33.922072] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 33.924842] systemd[1]: Stopping Reactivate sysinit units... machine # [ 33.925802] systemd[1]: Reached target Reactivate sysinit units. machine # [ 33.927588] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.930247] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 33.933767] systemd[1]: Reached target Remote File Systems. machine # [ 33.939869] systemd[1]: Starting linger-users.service... machine # [ 33.944866] systemd[1]: Reached target Local File Systems. machine # [ 33.945809] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 33.961129] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 33.962265] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 33.963566] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 33.972478] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 33.974181] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.975507] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.039161] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 34.043919] systemd[1]: Finished linger-users.service. machine # [ 34.180576] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 34.183945] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 34.440985] nixos[1732]: finished switching to system configuration /nix/store/yk1n0ws1jwdw9sfv6b1bc03y23ygls39-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 1.99 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 34.729039] nixos[1872]: switching to system configuration /nix/store/y00ivfkhh5vs1r0x9cm49akfp279iz94-nixos-system-machine-test machine # [ 34.731587] systemd[1]: Stopped target Remote File Systems. machine # [ 34.734134] systemd[1]: test.service: Deactivated successfully. machine # [ 34.735061] systemd[1]: Stopped Test unit. machine # [ 34.736318] systemd[1]: Stopped target Local File Systems. machine # [ 35.075393] systemd[1]: Reload requested from client PID 1872 ('.switch-to-conf') (unit backdoor.service)... machine # [ 35.077620] systemd[1]: Reloading... machine # [ 35.412612] systemd[1]: Reloading finished in 333 ms. machine # [ 35.504505] systemd[573]: Reexecution requested from client PID 1942 ('switch-to-confi')... machine # [ 35.505942] systemd[573]: Reexecuting. machine # [ 35.564743] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.677679] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.684946] systemd[573]: Reload requested from client PID 1942 ('switch-to-confi')... machine # [ 35.688888] systemd[573]: Reloading... machine # [ 35.800042] systemd[573]: Reloading finished in 112 ms. machine # [ 35.812197] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.821582] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 35.824148] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 35.826331] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 35.857401] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 35.861674] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 35.863095] systemd[1]: Stopping Reactivate sysinit units... machine # [ 35.864908] systemd[1]: Reached target Reactivate sysinit units. machine # [ 35.867228] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.869575] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 35.876907] systemd[1]: Starting test.service... machine # [ 35.888853] systemd[1]: Reached target Local File Systems. machine # [ 35.889872] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 35.901149] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 35.902174] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 35.903466] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 35.915078] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 35.920275] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.926167] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.931418] systemd[1]: Reached target Remote File Systems. machine # [ 35.941267] systemd[1]: Finished test.service. machine # [ 36.087495] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 36.092246] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 36.094687] systemd[1]: Starting linger-users.service... machine # [ 36.143346] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 36.146677] systemd[1]: Finished linger-users.service. machine # [ 36.407531] nixos[1872]: finished switching to system configuration /nix/store/y00ivfkhh5vs1r0x9cm49akfp279iz94-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.97 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 36.716600] nixos[2015]: switching to system configuration /nix/store/1842c6kmxp4hb05v0bp8bzz5gci8a46c-nixos-system-machine-test machine # [ 36.720487] systemd[1]: Stopped target Remote File Systems. machine # [ 36.722852] systemd[1]: Stopped target Local File Systems. machine # [ 37.016550] systemd[1]: Reload requested from client PID 2015 ('.switch-to-conf') (unit backdoor.service)... machine # [ 37.018619] systemd[1]: Reloading... machine # [ 37.358264] systemd[1]: Reloading finished in 337 ms. machine # [ 37.447135] systemd[573]: Reexecution requested from client PID 2084 ('switch-to-confi')... machine # [ 37.449745] systemd[573]: Reexecuting. machine # [ 37.507777] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.629299] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.636078] systemd[573]: Reload requested from client PID 2084 ('switch-to-confi')... machine # [ 37.638895] systemd[573]: Reloading... machine # [ 37.755593] systemd[573]: Reloading finished in 115 ms. machine # [ 37.773843] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.783111] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 37.785869] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 37.788312] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 37.823429] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 37.828619] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 37.829744] systemd[1]: Stopping Reactivate sysinit units... machine # [ 37.830630] systemd[1]: Reached target Reactivate sysinit units. machine # [ 37.833696] systemd[1]: test.service: Deactivated successfully. machine # [ 37.836401] systemd[1]: Stopped test.service. machine # [ 37.837221] systemd[1]: Stopping test.service... machine # [ 37.840592] systemd[1]: Starting test.service... machine # [ 37.867938] systemd[1]: Finished test.service. machine # [ 37.873542] systemd[1]: Reached target Remote File Systems. machine # [ 37.882330] systemd[1]: Reached target Local File Systems. machine # [ 37.886154] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 37.890123] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 37.891118] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 37.900419] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 37.902805] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 37.906513] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.907950] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.909447] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.910757] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 38.093533] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 38.095512] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.101905] systemd[1]: Starting linger-users.service... machine # [ 38.174393] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 38.177344] systemd[1]: Finished linger-users.service. machine # [ 38.436347] nixos[2015]: finished switching to system configuration /nix/store/1842c6kmxp4hb05v0bp8bzz5gci8a46c-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.03 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 38.739338] nixos[2158]: switching to system configuration /nix/store/gc15vv6b5l1il9h0p5v3vfijiz14zq2y-nixos-system-machine-test machine # [ 38.742914] systemd[1]: Stopped target Remote File Systems. machine # [ 38.745661] systemd[1]: Stopped target Local File Systems. machine # [ 39.040681] systemd[1]: Reload requested from client PID 2158 ('.switch-to-conf') (unit backdoor.service)... machine # [ 39.042928] systemd[1]: Reloading... machine # [ 39.391139] systemd[1]: Reloading finished in 346 ms. machine # [ 39.484431] systemd[573]: Reexecution requested from client PID 2227 ('switch-to-confi')... machine # [ 39.488346] systemd[573]: Reexecuting. machine # [ 39.547466] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.667370] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.673812] systemd[573]: Reload requested from client PID 2227 ('switch-to-confi')... machine # [ 39.676289] systemd[573]: Reloading... machine # [ 39.788368] systemd[573]: Reloading finished in 111 ms. machine # [ 39.805728] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.813635] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 39.816060] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 39.818202] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 39.852110] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 39.856680] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 39.857709] systemd[1]: Stopping Reactivate sysinit units... machine # [ 39.858537] systemd[1]: Reached target Reactivate sysinit units. machine # [ 39.863431] systemd[1]: Reloading test.service... machine # [ 39.890362] systemd[1]: Reloaded test.service. machine # [ 39.896180] systemd[1]: Reached target Remote File Systems. machine # [ 39.899392] systemd[1]: Starting linger-users.service... machine # [ 39.902332] systemd[1]: Reached target Local File Systems. machine # [ 39.912363] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 39.913941] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 39.914805] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 39.926421] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 39.929549] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 39.931149] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.932500] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.933683] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.934933] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 39.987849] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 39.991900] systemd[1]: Finished linger-users.service. machine # [ 40.123754] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 40.126992] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 40.387241] nixos[2158]: finished switching to system configuration /nix/store/gc15vv6b5l1il9h0p5v3vfijiz14zq2y-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 1.95 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 40.686958] nixos[2300]: switching to system configuration /nix/store/a8j4c2ynk6h4xcahvnhr77mr8g8kghsg-nixos-system-machine-test machine # [ 40.691296] systemd[1]: Stopped target Remote File Systems. machine # [ 40.692979] systemd[1]: Stopped target Local File Systems. machine # [ 40.974197] systemd[1]: Reload requested from client PID 2300 ('.switch-to-conf') (unit backdoor.service)... machine # [ 40.976528] systemd[1]: Reloading... machine # [ 41.306290] systemd[1]: Reloading finished in 327 ms. machine # [ 41.395675] systemd[573]: Reexecution requested from client PID 2369 ('switch-to-confi')... machine # [ 41.398080] systemd[573]: Reexecuting. machine # [ 41.454135] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.604112] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.611447] systemd[573]: Reload requested from client PID 2369 ('switch-to-confi')... machine # [ 41.614485] systemd[573]: Reloading... machine # [ 41.725035] systemd[573]: Reloading finished in 111 ms. machine # [ 41.740171] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.749389] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 41.751768] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 41.753905] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 41.784097] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 41.787640] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 41.789370] systemd[1]: Stopping Reactivate sysinit units... machine # [ 41.790216] systemd[1]: Reached target Reactivate sysinit units. machine # [ 41.794867] systemd[1]: Reached target Remote File Systems. machine # [ 41.798167] systemd[1]: Reached target Local File Systems. machine # [ 41.801603] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 41.805530] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 41.806470] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 41.807741] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 41.821643] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 41.823328] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.825182] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.826392] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.827695] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 41.989702] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 41.992504] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 41.997066] systemd[1]: Starting linger-users.service... machine # [ 42.037584] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 42.040895] systemd[1]: Finished linger-users.service. machine # [ 42.299014] nixos[2300]: finished switching to system configuration /nix/store/a8j4c2ynk6h4xcahvnhr77mr8g8kghsg-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.91 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.36 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 42.873209] nixos[2451]: switching to system configuration /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test machine # [ 42.875856] systemd[1]: test.service: Deactivated successfully. machine # [ 42.878696] systemd[1]: Stopped test.service. machine # [ 42.879446] systemd[1]: Stopped target Remote File Systems. machine # [ 42.881972] systemd[1]: Stopped target Local File Systems. machine # [ 43.146418] systemd[1]: Reload requested from client PID 2451 ('.switch-to-conf') (unit backdoor.service)... machine # [ 43.148535] systemd[1]: Reloading... machine # [ 43.469910] systemd[1]: Reloading finished in 319 ms. machine # [ 43.554796] systemd[573]: Reexecution requested from client PID 2519 ('switch-to-confi')... machine # [ 43.559125] systemd[573]: Reexecuting. machine # [ 43.616182] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.738844] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.746260] systemd[573]: Reload requested from client PID 2519 ('switch-to-confi')... machine # [ 43.750652] systemd[573]: Reloading... machine # [ 43.862775] systemd[573]: Reloading finished in 113 ms. machine # [ 43.880339] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.890111] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 43.892883] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 43.895314] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 43.931754] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 43.936751] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 43.939185] systemd[1]: Stopping Reactivate sysinit units... machine # [ 43.941666] systemd[1]: Reached target Reactivate sysinit units. machine # [ 43.944941] systemd[1]: Reached target Remote File Systems. machine # [ 43.950164] systemd[1]: Starting linger-users.service... machine # [ 43.959924] systemd[1]: Reached target Local File Systems. machine # [ 43.967180] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 43.973267] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 43.974293] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 43.975628] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 43.990619] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 43.996093] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.003328] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.009572] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.011032] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 44.049154] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 44.052225] systemd[1]: Finished linger-users.service. machine # [ 44.187863] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 44.191270] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 44.450228] nixos[2451]: finished switching to system configuration /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.79 seconds) machine: must succeed: /nix/store/8hphd6rpfr9v01wsfvjsfy4mb861lis5-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 44.721311] nixos[2591]: switching to system configuration /nix/store/hwkdchhx8l1m789bn7sq8zii9n9dh1yp-nixos-system-machine-test machine # [ 44.723925] systemd[1]: Stopped target Remote File Systems. machine # [ 44.726982] systemd[1]: Stopped target Local File Systems. machine # [ 45.066697] systemd[1]: Reload requested from client PID 2591 ('.switch-to-conf') (unit backdoor.service)... machine # [ 45.068911] systemd[1]: Reloading... machine # [ 45.390609] systemd[1]: Reloading finished in 319 ms. machine # [ 45.479278] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 45.482809] systemd[573]: Reexecution requested from client PID 2661 ('switch-to-confi')... machine # [ 45.485195] systemd[573]: Reexecuting. machine # [ 45.544105] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.670677] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.677789] systemd[573]: Reload requested from client PID 2661 ('switch-to-confi')... machine # [ 45.681986] systemd[573]: Reloading... machine # [ 45.793779] systemd[573]: Reloading finished in 112 ms. machine # [ 45.808225] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.820321] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 45.821374] systemd[1]: Stopping Reactivate sysinit units... machine # [ 45.826494] systemd[1]: Reached target Reactivate sysinit units. machine # [ 45.827541] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.833918] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 45.835391] systemd[1]: Reached target Local File Systems. machine # [ 45.836409] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 45.840515] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 45.841517] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 45.842855] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 45.855407] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 45.859139] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.860534] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.861719] systemd[1]: Reached target Remote File Systems. machine # [ 46.022543] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 46.027426] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 46.030892] systemd[1]: Starting linger-users.service... machine # [ 46.034181] systemd[1]: Starting test.service... machine # [ 46.072164] systemd[1]: Finished test.service. machine # [ 46.091116] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 46.093138] systemd[1]: Finished linger-users.service. machine # [ 46.353878] nixos[2591]: finished switching to system configuration /nix/store/hwkdchhx8l1m789bn7sq8zii9n9dh1yp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/8hphd6rpfr9v01wsfvjsfy4mb861lis5-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.90 seconds) machine: must succeed: ! test -e /run/current-system/activate machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.03 seconds) machine: must succeed: ! test -e /run/current-system/dry-activate machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.03 seconds) machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.03 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 46.703799] nixos[2740]: switching to system configuration /nix/store/jjx9sfax7rbdcd48gqhqy1cnvw7rx58r-nixos-system-machine-test machine # [ 46.706822] systemd[1]: Stopped target Remote File Systems. machine # [ 46.710392] systemd[1]: test.service: Deactivated successfully. machine # [ 46.712095] systemd[1]: Stopped test.service. machine # [ 46.712997] systemd[1]: Stopped target Local File Systems. machine # [ 46.997487] systemd[1]: Reload requested from client PID 2740 ('.switch-to-conf') (unit backdoor.service)... machine # [ 46.999517] systemd[1]: Reloading... machine # [ 47.349031] systemd[1]: Reloading finished in 347 ms. machine # [ 47.437616] systemd[573]: Reexecution requested from client PID 2809 ('switch-to-confi')... machine # [ 47.442127] systemd[573]: Reexecuting. machine # [ 47.487775] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.609380] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.616647] systemd[573]: Reload requested from client PID 2809 ('switch-to-confi')... machine # [ 47.618062] systemd[573]: Reloading... machine # [ 47.734904] systemd[573]: Reloading finished in 114 ms. machine # [ 47.752237] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.763039] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 47.797948] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 47.803336] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 47.805242] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 47.812345] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 47.815238] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 47.818112] systemd[1]: Stopping Reactivate sysinit units... machine # [ 47.819052] systemd[1]: Reached target Reactivate sysinit units. machine # [ 47.821443] systemd[1]: Reached target Remote File Systems. machine # [ 47.828886] systemd[1]: Starting linger-users.service... machine # [ 47.849651] systemd[1]: Reached target Local File Systems. machine # [ 47.856295] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 47.866637] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 47.867760] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 47.885794] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 47.894610] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 47.899543] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.905151] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.906572] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.907914] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 47.918029] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 47.957723] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 47.962406] systemd[1]: Finished linger-users.service. machine # [ 48.123199] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 48.126471] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 48.131701] systemd[1]: Started test.service. machine # [ 48.160524] systemd[1]: test.service: Deactivated successfully. machine # [ 48.396112] nixos[2740]: finished switching to system configuration /nix/store/jjx9sfax7rbdcd48gqhqy1cnvw7rx58r-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.95 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 48.704748] nixos[2885]: switching to system configuration /nix/store/s6vv7csp1jx9xngkzw39v7s2rnqingl5-nixos-system-machine-test machine # [ 48.707557] systemd[1]: Stopped target Local File Systems. machine # [ 48.710105] systemd[1]: Stopped target Remote File Systems. machine # [ 49.022476] systemd[1]: Reload requested from client PID 2885 ('.switch-to-conf') (unit backdoor.service)... machine # [ 49.024757] systemd[1]: Reloading... machine # [ 49.458994] systemd[1]: Reloading finished in 432 ms. machine # [ 49.547631] systemd[573]: Reexecution requested from client PID 2954 ('switch-to-confi')... machine # [ 49.552261] systemd[573]: Reexecuting. machine # [ 49.607801] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.730557] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.737790] systemd[573]: Reload requested from client PID 2954 ('switch-to-confi')... machine # [ 49.741731] systemd[573]: Reloading... machine # [ 49.858919] systemd[573]: Reloading finished in 118 ms. machine # [ 49.872202] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.881734] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 49.884087] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 49.886502] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 49.921220] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 49.925613] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 49.926656] systemd[1]: Stopping Reactivate sysinit units... machine # [ 49.927507] systemd[1]: Reached target Reactivate sysinit units. machine # [ 49.931543] systemd[1]: Reached target Local File Systems. machine # [ 49.938188] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 49.939776] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 49.951983] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 49.957720] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 49.959997] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 49.961687] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.963030] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.964319] systemd[1]: Reached target Remote File Systems. machine # [ 49.965121] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.966437] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 50.131874] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 50.136535] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 50.139987] systemd[1]: Starting escaped\x2ddash.service... machine # [ 50.142828] systemd[1]: Starting linger-users.service... machine # [ 50.184482] systemd[1]: Finished escaped\x2ddash.service. machine # [ 50.203319] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 50.206187] systemd[1]: Finished linger-users.service. machine # [ 50.467003] nixos[2885]: finished switching to system configuration /nix/store/s6vv7csp1jx9xngkzw39v7s2rnqingl5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 2.07 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 50.775141] nixos[3027]: switching to system configuration /nix/store/dk7ycvl8qwdmljih39382qdpjwhbg2js-nixos-system-machine-test machine # [ 50.777724] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 50.781357] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 50.782869] systemd[1]: Stopped target Remote File Systems. machine # [ 50.783707] systemd[1]: Stopped target Local File Systems. machine # [ 51.070867] systemd[1]: Reload requested from client PID 3027 ('.switch-to-conf') (unit backdoor.service)... machine # [ 51.073057] systemd[1]: Reloading... machine # [ 51.411160] systemd[1]: Reloading finished in 336 ms. machine # [ 51.503089] systemd[573]: Reexecution requested from client PID 3096 ('switch-to-confi')... machine # [ 51.506846] systemd[573]: Reexecuting. machine # [ 51.567950] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.686588] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.693085] systemd[573]: Reload requested from client PID 3096 ('switch-to-confi')... machine # [ 51.695670] systemd[573]: Reloading... machine # [ 51.807951] systemd[573]: Reloading finished in 111 ms. machine # [ 51.825672] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.834740] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 51.835809] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 51.838323] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 51.872498] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 51.875867] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 51.878054] systemd[1]: Stopping Reactivate sysinit units... machine # [ 51.878908] systemd[1]: Reached target Reactivate sysinit units. machine # [ 51.881186] systemd[1]: Reached target Remote File Systems. machine # [ 51.886628] systemd[1]: Starting escaped\x2ddash.service... machine # [ 51.891004] systemd[1]: Starting linger-users.service... machine # [ 51.901354] systemd[1]: Reached target Local File Systems. machine # [ 51.908066] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 51.917283] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 51.918278] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 51.933670] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 51.940959] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 51.942888] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.944740] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.946001] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.947577] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 51.991937] systemd[1]: Finished escaped\x2ddash.service. machine # [ 52.035186] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 52.038771] systemd[1]: Finished linger-users.service. machine # [ 52.169662] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 52.173308] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 52.430048] nixos[3027]: finished switching to system configuration /nix/store/dk7ycvl8qwdmljih39382qdpjwhbg2js-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 1.96 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 52.719538] nixos[3169]: switching to system configuration /nix/store/aynbd1l1hb6h3fnb2snfvdryrsjiyqf2-nixos-system-machine-test machine # [ 52.722685] systemd[1]: Stopped target Local File Systems. machine # [ 52.724629] systemd[1]: Stopped target Remote File Systems. machine # [ 52.726318] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 52.727337] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 53.007257] systemd[1]: Reload requested from client PID 3169 ('.switch-to-conf') (unit backdoor.service)... machine # [ 53.009403] systemd[1]: Reloading... machine # [ 53.338058] systemd[1]: Reloading finished in 327 ms. machine # [ 53.425928] systemd[573]: Reexecution requested from client PID 3238 ('switch-to-confi')... machine # [ 53.430249] systemd[573]: Reexecuting. machine # [ 53.483612] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.599664] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.605940] systemd[573]: Reload requested from client PID 3238 ('switch-to-confi')... machine # [ 53.608481] systemd[573]: Reloading... machine # [ 53.717888] systemd[573]: Reloading finished in 108 ms. machine # [ 53.732177] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.742424] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 53.744849] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 53.746982] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 53.780418] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 53.784736] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 53.786715] systemd[1]: Stopping Reactivate sysinit units... machine # [ 53.787583] systemd[1]: Reached target Reactivate sysinit units. machine # [ 53.793350] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.794745] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 53.799346] systemd[1]: Reached target Remote File Systems. machine # [ 53.804303] systemd[1]: Starting -.service... machine # [ 53.808343] systemd[1]: Starting linger-users.service... machine # [ 53.817006] systemd[1]: Reached target Local File Systems. machine # [ 53.821044] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 53.833575] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 53.834541] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 53.835868] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 53.839726] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 53.841499] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.842801] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.874941] systemd[1]: Finished -.service. machine # [ 53.913881] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 53.916602] systemd[1]: Finished linger-users.service. machine # [ 54.051641] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 54.054706] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 54.315447] nixos[3169]: finished switching to system configuration /nix/store/aynbd1l1hb6h3fnb2snfvdryrsjiyqf2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.89 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 54.634897] nixos[3311]: switching to system configuration /nix/store/a23m1sh6mnbzrynfldjfn1xpnvp1w0nl-nixos-system-machine-test machine # [ 54.640684] systemd[1]: Stopped target Remote File Systems. machine # [ 54.641642] systemd[1]: Stopped target Local File Systems. machine # [ 54.945657] systemd[1]: Reload requested from client PID 3311 ('.switch-to-conf') (unit backdoor.service)... machine # [ 54.947678] systemd[1]: Reloading... machine # [ 55.291294] systemd[1]: Reloading finished in 342 ms. machine # [ 55.379757] systemd[573]: Reexecution requested from client PID 3380 ('switch-to-confi')... machine # [ 55.383503] systemd[573]: Reexecuting. machine # [ 55.436049] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.558384] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.565685] systemd[573]: Reload requested from client PID 3380 ('switch-to-confi')... machine # [ 55.568697] systemd[573]: Reloading... machine # [ 55.687871] systemd[573]: Reloading finished in 118 ms. machine # [ 55.708217] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.718378] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 55.721304] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 55.723656] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 55.759503] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 55.764146] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 55.765263] systemd[1]: Stopping Reactivate sysinit units... machine # [ 55.769861] systemd[1]: Reached target Reactivate sysinit units. machine # [ 55.773816] systemd[1]: Reloading -.service... machine # [ 55.803046] systemd[1]: Reloaded -.service. machine # [ 55.807999] systemd[1]: Reached target Local File Systems. machine # [ 55.811026] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 55.820831] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 55.821825] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 55.823154] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 55.832846] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 55.834607] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.835970] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.842689] systemd[1]: Reached target Remote File Systems. machine # [ 55.843669] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.847351] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 56.015014] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 56.020518] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 56.022766] systemd[1]: Starting linger-users.service... machine # [ 56.068638] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 56.070415] systemd[1]: Finished linger-users.service. machine # [ 56.331851] nixos[3311]: finished switching to system configuration /nix/store/a23m1sh6mnbzrynfldjfn1xpnvp1w0nl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 2.02 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 56.665850] nixos[3453]: switching to system configuration /nix/store/sg5flsj7bhdnqlyigmg0kcyinrgsrygi-nixos-system-machine-test machine # [ 56.669275] systemd[1]: Stopped target Remote File Systems. machine # [ 56.671127] systemd[1]: -.service: Deactivated successfully. machine # [ 56.674944] systemd[1]: Stopped -.service. machine # [ 56.675802] systemd[1]: Stopped target Local File Systems. machine # [ 57.003455] systemd[1]: Reload requested from client PID 3453 ('.switch-to-conf') (unit backdoor.service)... machine # [ 57.005912] systemd[1]: Reloading... machine # [ 57.368865] systemd[1]: Reloading finished in 361 ms. machine # [ 57.459309] systemd[573]: Reexecution requested from client PID 3522 ('switch-to-confi')... machine # [ 57.463207] systemd[573]: Reexecuting. machine # [ 57.515724] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.636473] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.643966] systemd[573]: Reload requested from client PID 3522 ('switch-to-confi')... machine # [ 57.645445] systemd[573]: Reloading... machine # [ 57.764501] systemd[573]: Reloading finished in 117 ms. machine # [ 57.780260] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.791219] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 57.792472] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 57.794852] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 57.833442] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 57.838109] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 57.842037] systemd[1]: Stopping Reactivate sysinit units... machine # [ 57.843110] systemd[1]: Reached target Reactivate sysinit units. machine # [ 57.846534] systemd[1]: Reached target Remote File Systems. machine # [ 57.847583] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.851053] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 57.862197] systemd[1]: Reached target Local File Systems. machine # [ 57.863315] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 57.874693] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 57.875721] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 57.878262] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 57.880709] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 57.882361] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.883678] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.068870] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 58.074176] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 58.078463] systemd[1]: Starting linger-users.service... machine # [ 58.083017] systemd[1]: Starting required-service.service... machine # [ 58.087386] systemd[1]: Starting test-service.service... machine # [ 58.150266] systemd[1]: Finished required-service.service. machine # [ 58.153668] systemd[1]: Finished test-service.service. machine # [ 58.176897] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 58.178793] systemd[1]: Finished linger-users.service. machine # [ 58.441048] nixos[3453]: finished switching to system configuration /nix/store/sg5flsj7bhdnqlyigmg0kcyinrgsrygi-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 2.11 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 58.759045] nixos[3597]: switching to system configuration /nix/store/mvczbsj5akn5r2zlj4z3fbbnjmy349ar-nixos-system-machine-test machine # [ 58.762021] systemd[1]: Stopped target Local File Systems. machine # [ 58.766275] systemd[1]: Stopped target Remote File Systems. machine # [ 58.768167] systemd[1]: required-service.service: Deactivated successfully. machine # [ 58.769232] systemd[1]: Stopped required-service.service. machine # [ 58.770029] systemd[1]: test-service.service: Deactivated successfully. machine # [ 58.770994] systemd[1]: Stopped test-service.service. machine # [ 59.075682] systemd[1]: Reload requested from client PID 3597 ('.switch-to-conf') (unit backdoor.service)... machine # [ 59.077955] systemd[1]: Reloading... machine # [ 59.429610] systemd[1]: Reloading finished in 350 ms. machine # [ 59.517830] systemd[573]: Reexecution requested from client PID 3666 ('switch-to-confi')... machine # [ 59.519413] systemd[573]: Reexecuting. machine # [ 59.579647] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.704523] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.711540] systemd[573]: Reload requested from client PID 3666 ('switch-to-confi')... machine # [ 59.715025] systemd[573]: Reloading... machine # [ 59.830039] systemd[573]: Reloading finished in 114 ms. machine # [ 59.841729] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.850678] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 59.853291] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 59.855670] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 59.888608] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 59.893270] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 59.896678] systemd[1]: Stopping Reactivate sysinit units... machine # [ 59.897670] systemd[1]: Reached target Reactivate sysinit units. machine # [ 59.907028] systemd[1]: Starting required-service.service... machine # [ 59.916455] systemd[1]: Reached target Local File Systems. machine # [ 59.917500] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 59.926431] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 59.927549] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 59.933052] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 59.935442] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 59.951741] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.958436] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.966184] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.973291] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 59.977716] systemd[1]: Reached target Remote File Systems. machine # [ 59.978954] systemd[1]: Finished required-service.service. machine # [ 60.135992] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 60.140471] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 60.144460] systemd[1]: Starting linger-users.service... machine # [ 60.148454] systemd[1]: Starting test-service.service... machine # [ 60.188109] systemd[1]: Finished test-service.service. machine # [ 60.209164] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 60.212171] systemd[1]: Finished linger-users.service. machine # [ 60.471477] nixos[3597]: finished switching to system configuration /nix/store/mvczbsj5akn5r2zlj4z3fbbnjmy349ar-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 2.03 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 60.795301] nixos[3741]: switching to system configuration /nix/store/vawcsya82cl0n94vsgpkvv6h0sflxb1p-nixos-system-machine-test machine # [ 60.799049] systemd[1]: required-service.service: Deactivated successfully. machine # [ 60.802955] systemd[1]: Stopped required-service.service. machine # [ 60.803852] systemd[1]: test-service.service: Deactivated successfully. machine # [ 60.806000] systemd[1]: Stopped test-service.service. machine # [ 60.807337] systemd[1]: Stopped target Remote File Systems. machine # [ 60.808915] systemd[1]: Stopped target Local File Systems. machine # [ 61.119573] systemd[1]: Reload requested from client PID 3741 ('.switch-to-conf') (unit backdoor.service)... machine # [ 61.121812] systemd[1]: Reloading... machine # [ 61.485682] systemd[1]: Reloading finished in 362 ms. machine # [ 61.583742] systemd[573]: Reexecution requested from client PID 3810 ('switch-to-confi')... machine # [ 61.587765] systemd[573]: Reexecuting. machine # [ 61.627568] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.749533] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.757782] systemd[573]: Reload requested from client PID 3810 ('switch-to-confi')... machine # [ 61.759365] systemd[573]: Reloading... machine # [ 61.881160] systemd[573]: Reloading finished in 119 ms. machine # [ 61.896237] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.907688] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 61.909039] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 61.911850] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 61.949267] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 61.954063] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 61.957050] systemd[1]: Stopping Reactivate sysinit units... machine # [ 61.958129] systemd[1]: Reached target Reactivate sysinit units. machine # [ 61.962441] systemd[1]: Reached target Local File Systems. machine # [ 61.963601] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 61.974486] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 61.975598] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 61.985221] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 61.987795] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 61.994801] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.997772] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.001349] systemd[1]: Reached target Remote File Systems. machine # [ 62.003577] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.005467] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 62.178028] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 62.183297] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 62.187174] systemd[1]: Starting linger-users.service... machine # [ 62.191184] systemd[1]: Starting required-service.service... machine # [ 62.194628] systemd[1]: Starting test-service.service... machine # [ 62.254175] systemd[1]: Finished required-service.service. machine # [ 62.258149] systemd[1]: Finished test-service.service. machine # [ 62.280870] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 62.282925] systemd[1]: Finished linger-users.service. machine # [ 62.543624] nixos[3741]: finished switching to system configuration /nix/store/vawcsya82cl0n94vsgpkvv6h0sflxb1p-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 2.07 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 62.868677] nixos[3885]: switching to system configuration /nix/store/xqwkzwaiv6vjvcxn171ry354jr6zlr8b-nixos-system-machine-test machine # [ 62.871725] systemd[1]: test-service.service: Deactivated successfully. machine # [ 62.876171] systemd[1]: Stopped test-service.service. machine # [ 62.877044] systemd[1]: Stopped target Remote File Systems. machine # [ 62.877895] systemd[1]: Stopped target Local File Systems. machine # [ 62.878763] systemd[1]: required-service.service: Deactivated successfully. machine # [ 62.879800] systemd[1]: Stopped required-service.service. machine # [ 63.189160] systemd[1]: Reload requested from client PID 3885 ('.switch-to-conf') (unit backdoor.service)... machine # [ 63.191263] systemd[1]: Reloading... machine # [ 63.544123] systemd[1]: Reloading finished in 351 ms. machine # [ 63.633446] systemd[573]: Reexecution requested from client PID 3954 ('switch-to-confi')... machine # [ 63.637413] systemd[573]: Reexecuting. machine # [ 63.691389] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.811629] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.818466] systemd[573]: Reload requested from client PID 3954 ('switch-to-confi')... machine # [ 63.822147] systemd[573]: Reloading... machine # [ 63.934783] systemd[573]: Reloading finished in 113 ms. machine # [ 63.952196] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.961062] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 63.963539] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 63.965732] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 63.998269] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 64.003319] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 64.006423] systemd[1]: Stopping Reactivate sysinit units... machine # [ 64.007408] systemd[1]: Reached target Reactivate sysinit units. machine # [ 64.016654] systemd[1]: Created slice Slice /system/instantiated. machine # [ 64.020116] systemd[1]: Reached target Remote File Systems. machine # [ 64.024631] systemd[1]: Starting instantiated@one.service... machine # [ 64.028701] systemd[1]: Starting instantiated@two.service... machine # [ 64.044719] systemd[1]: Starting linger-users.service... machine # [ 64.052201] systemd[1]: Reached target Local File Systems. machine # [ 64.053346] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 64.073331] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 64.074444] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 64.075860] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 64.092351] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 64.104987] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.114323] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.125725] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.127617] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 64.147952] systemd[1]: Finished instantiated@two.service. machine # [ 64.151845] systemd[1]: Finished instantiated@one.service. machine # [ 64.185313] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 64.191257] systemd[1]: Finished linger-users.service. machine # [ 64.339672] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 64.343211] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 64.602844] nixos[3885]: finished switching to system configuration /nix/store/xqwkzwaiv6vjvcxn171ry354jr6zlr8b-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 2.05 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 64.918181] nixos[4029]: switching to system configuration /nix/store/5y1lyhyiibdmmxpn4ih1a3b5sjsz6kdw-nixos-system-machine-test machine # [ 64.921441] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 64.922527] systemd[1]: Stopped instantiated@two.service. machine # [ 64.924458] systemd[1]: Stopped target Local File Systems. machine # [ 64.926195] systemd[1]: Stopped target Remote File Systems. machine # [ 64.929145] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 64.931002] systemd[1]: Stopped instantiated@one.service. machine # [ 65.223691] systemd[1]: Reload requested from client PID 4029 ('.switch-to-conf') (unit backdoor.service)... machine # [ 65.225850] systemd[1]: Reloading... machine # [ 65.570770] systemd[1]: Reloading finished in 343 ms. machine # [ 65.660456] systemd[573]: Reexecution requested from client PID 4098 ('switch-to-confi')... machine # [ 65.663883] systemd[573]: Reexecuting. machine # [ 65.715184] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.834507] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.841804] systemd[573]: Reload requested from client PID 4098 ('switch-to-confi')... machine # [ 65.846048] systemd[573]: Reloading... machine # [ 65.971746] systemd[573]: Reloading finished in 126 ms. machine # [ 65.988609] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.998691] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 66.001565] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 66.004452] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 66.040585] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 66.045351] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 66.048663] systemd[1]: Stopping Reactivate sysinit units... machine # [ 66.049694] systemd[1]: Reached target Reactivate sysinit units. machine # [ 66.057603] systemd[1]: Starting instantiated@two.service... machine # [ 66.064600] systemd[1]: Reached target Local File Systems. machine # [ 66.065623] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 66.077690] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 66.078807] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 66.093131] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 66.095552] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 66.102575] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.107692] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.114990] systemd[1]: Reached target Remote File Systems. machine # [ 66.119440] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.124358] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 66.135205] systemd[1]: Finished instantiated@two.service. machine # [ 66.324781] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 66.330305] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 66.334604] systemd[1]: Starting instantiated@one.service... machine # [ 66.338912] systemd[1]: Starting linger-users.service... machine # [ 66.383232] systemd[1]: Finished instantiated@one.service. machine # [ 66.402241] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 66.405056] systemd[1]: Finished linger-users.service. machine # [ 66.663966] nixos[4029]: finished switching to system configuration /nix/store/5y1lyhyiibdmmxpn4ih1a3b5sjsz6kdw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 2.06 seconds) (finished: subtest: services, in 42.04 seconds) subtest: failing units machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 66.963024] nixos[4173]: switching to system configuration /nix/store/y00ivfkhh5vs1r0x9cm49akfp279iz94-nixos-system-machine-test machine # [ 66.965732] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 66.968883] systemd[1]: Stopped instantiated@one.service. machine # [ 66.969787] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 66.970832] systemd[1]: Stopped instantiated@two.service. machine # [ 66.972292] systemd[1]: Stopped target Remote File Systems. machine # [ 66.974767] systemd[1]: Stopped target Local File Systems. machine # [ 67.263114] systemd[1]: Reload requested from client PID 4173 ('.switch-to-conf') (unit backdoor.service)... machine # [ 67.265546] systemd[1]: Reloading... machine # [ 67.627687] systemd[1]: Reloading finished in 360 ms. machine # [ 67.719188] systemd[573]: Reexecution requested from client PID 4242 ('switch-to-confi')... machine # [ 67.722964] systemd[573]: Reexecuting. machine # [ 67.771725] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.889096] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.896127] systemd[573]: Reload requested from client PID 4242 ('switch-to-confi')... machine # [ 67.897566] systemd[573]: Reloading... machine # [ 68.010631] systemd[573]: Reloading finished in 111 ms. machine # [ 68.024193] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.034260] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 68.036706] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 68.038917] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 68.072620] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 68.076637] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 68.078683] systemd[1]: Stopping Reactivate sysinit units... machine # [ 68.079584] systemd[1]: Reached target Reactivate sysinit units. machine # [ 68.084975] systemd[1]: Reached target Local File Systems. machine # [ 68.085864] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 68.089552] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 68.090459] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 68.091714] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 68.108528] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 68.114405] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.115817] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.118038] systemd[1]: Reached target Remote File Systems. machine # [ 68.119614] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.122512] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 68.291230] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 68.295883] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 68.299553] systemd[1]: Starting linger-users.service... machine # [ 68.303104] systemd[1]: Starting test.service... machine # [ 68.345019] systemd[1]: Finished test.service. machine # [ 68.363063] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 68.365644] systemd[1]: Finished linger-users.service. machine # [ 68.624488] nixos[4173]: finished switching to system configuration /nix/store/y00ivfkhh5vs1r0x9cm49akfp279iz94-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.96 seconds) machine: must fail: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 68.889901] nixos[4315]: switching to system configuration /nix/store/ybwyqdg3nd160w4cl6xrqp7cw91444m0-nixos-system-machine-test machine # [ 68.892716] systemd[1]: Stopped target Remote File Systems. machine # [ 68.896245] systemd[1]: Stopped target Local File Systems. machine # [ 68.897688] systemd[1]: test.service: Deactivated successfully. machine # [ 68.898602] systemd[1]: Stopped test.service. machine # [ 69.185830] systemd[1]: Reload requested from client PID 4315 ('.switch-to-conf') (unit backdoor.service)... machine # [ 69.187896] systemd[1]: Reloading... machine # [ 69.513890] systemd[1]: Reloading finished in 324 ms. machine # [ 69.603336] systemd[573]: Reexecution requested from client PID 4384 ('switch-to-confi')... machine # [ 69.605440] systemd[573]: Reexecuting. machine # [ 69.667871] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.788502] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.795245] systemd[573]: Reload requested from client PID 4384 ('switch-to-confi')... machine # [ 69.798576] systemd[573]: Reloading... machine # [ 69.912103] systemd[573]: Reloading finished in 114 ms. machine # [ 69.928199] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.936816] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 69.939173] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 69.941348] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 69.972121] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 69.976432] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 69.978540] systemd[1]: Stopping Reactivate sysinit units... machine # [ 69.979456] systemd[1]: Reached target Reactivate sysinit units. machine # [ 69.984409] systemd[1]: Reached target Local File Systems. machine # [ 69.988092] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.989472] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 69.997054] systemd[1]: Starting test.service... machine # [ 70.011148] systemd[1]: Reached target Remote File Systems. machine # [ 70.015354] systemd[1]: Starting linger-users.service... machine # [ 70.017469] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 70.024581] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 70.025477] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 70.026750] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 70.035626] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 70.040764] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.049078] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.068928] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 70.070396] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 70.077052] systemd[1]: Failed to start test.service. machine # [ 70.105005] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 70.109247] systemd[1]: Finished linger-users.service. machine # [ 70.244302] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 70.247705] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.549224] nixos[4315]: switching to system configuration /nix/store/ybwyqdg3nd160w4cl6xrqp7cw91444m0-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.93 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 70.819399] nixos[4458]: switching to system configuration /nix/store/hv8y43q616npsk839fwgjzjgvk4zqc6l-nixos-system-machine-test machine # [ 70.822037] systemd[1]: Stopped target Remote File Systems. machine # [ 70.824297] systemd[1]: Stopped target Local File Systems. machine # [ 71.111857] systemd[1]: Reload requested from client PID 4458 ('.switch-to-conf') (unit backdoor.service)... machine # [ 71.114059] systemd[1]: Reloading... machine # [ 71.453811] systemd[1]: Reloading finished in 338 ms. machine # [ 71.539646] systemd[573]: Reexecution requested from client PID 4527 ('switch-to-confi')... machine # [ 71.541812] systemd[573]: Reexecuting. machine # [ 71.604224] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.726570] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.732965] systemd[573]: Reload requested from client PID 4527 ('switch-to-confi')... machine # [ 71.735272] systemd[573]: Reloading... machine # [ 71.850292] systemd[573]: Reloading finished in 113 ms. machine # [ 71.864183] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.874400] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 71.875452] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 71.877852] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 71.908376] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 71.912423] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 71.914865] systemd[1]: Stopping Reactivate sysinit units... machine # [ 71.915789] systemd[1]: Reached target Reactivate sysinit units. machine # [ 71.920882] systemd[1]: Reached target Remote File Systems. machine # [ 71.926574] systemd[1]: Started autorestart.service. machine # [ 71.930830] systemd[1]: Starting linger-users.service... machine # [ 71.943085] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.950471] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 71.951894] systemd[1]: Reached target Local File Systems. machine # [ 71.961556] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 71.963231] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 71.971358] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 71.978581] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 71.989699] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 71.991391] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.002340] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.003757] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 72.035917] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 72.039695] systemd[1]: Finished linger-users.service. machine # [ 72.180140] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 72.183512] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 72.443021] nixos[4458]: finished switching to system configuration /nix/store/hv8y43q616npsk839fwgjzjgvk4zqc6l-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.89 seconds) machine # [ 72.518322] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 72.752927] nixos[4605]: switching to system configuration /nix/store/hv8y43q616npsk839fwgjzjgvk4zqc6l-nixos-system-machine-test machine # [ 72.755516] systemd[1]: Stopped target Local File Systems. machine # [ 72.757930] systemd[1]: Stopped target Remote File Systems. machine # [ 73.037963] systemd[1]: Reload requested from client PID 4605 ('.switch-to-conf') (unit backdoor.service)... machine # [ 73.040208] systemd[1]: Reloading... machine # [ 73.362589] systemd[1]: Reloading finished in 320 ms. machine # [ 73.452469] systemd[573]: Reexecution requested from client PID 4674 ('switch-to-confi')... machine # [ 73.456187] systemd[573]: Reexecuting. machine # [ 73.511710] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.631580] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.638660] systemd[573]: Reload requested from client PID 4674 ('switch-to-confi')... machine # [ 73.641413] systemd[573]: Reloading... machine # [ 73.759161] systemd[573]: Reloading finished in 116 ms. machine # [ 73.776298] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.787243] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 73.790168] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 73.792972] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 73.832536] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 73.837051] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 73.839852] systemd[1]: Stopping Reactivate sysinit units... machine # [ 73.842288] systemd[1]: Reached target Reactivate sysinit units. machine # [ 73.845191] systemd[1]: Reached target Remote File Systems. machine # [ 73.851909] systemd[1]: Started autorestart.service. machine # [ 73.860655] systemd[1]: Starting linger-users.service... machine # [ 73.872268] systemd[1]: Reached target Local File Systems. machine # [ 73.876896] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 73.887457] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 73.891980] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 73.897603] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 73.899895] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 73.915956] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.917549] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.918843] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.934375] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 73.935994] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 73.977451] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 73.981575] systemd[1]: Finished linger-users.service. machine # [ 74.137333] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 74.141742] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 74.401228] nixos[4605]: finished switching to system configuration /nix/store/hv8y43q616npsk839fwgjzjgvk4zqc6l-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.88 seconds) machine # [ 74.473300] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 74.739298] nixos[4752]: switching to system configuration /nix/store/jaiir9vcl0ipxqjd9cin7ssljipj6bnp-nixos-system-machine-test machine # [ 74.742262] systemd[1]: Stopped target Remote File Systems. machine # [ 74.744982] systemd[1]: Stopped target Local File Systems. machine # [ 75.039946] systemd[1]: Reload requested from client PID 4752 ('.switch-to-conf') (unit backdoor.service)... machine # [ 75.042104] systemd[1]: Reloading... machine # [ 75.390813] systemd[1]: Reloading finished in 347 ms. machine # [ 75.484259] systemd[573]: Reexecution requested from client PID 4821 ('switch-to-confi')... machine # [ 75.489114] systemd[573]: Reexecuting. machine # [ 75.527164] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.642208] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.650097] systemd[573]: Reload requested from client PID 4821 ('switch-to-confi')... machine # [ 75.651576] systemd[573]: Reloading... machine # [ 75.764996] systemd[573]: Reloading finished in 111 ms. machine # [ 75.780180] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.789474] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 75.792090] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 75.794438] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 75.829293] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 75.833236] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 75.835164] systemd[1]: Stopping Reactivate sysinit units... machine # [ 75.839585] systemd[1]: Reached target Reactivate sysinit units. machine # [ 75.840900] systemd[1]: Reached target Remote File Systems. machine # [ 75.844269] systemd[1]: Started autorestart.service. machine # [ 75.847305] systemd[1]: Starting linger-users.service... machine # [ 75.858319] systemd[1]: Reached target Local File Systems. machine # [ 75.859233] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 75.874364] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 75.875352] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 75.884778] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 75.887084] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 75.888772] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.890040] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.891273] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.894845] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 75.927435] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 75.933642] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 75.959300] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 75.963518] systemd[1]: Finished linger-users.service. machine # [ 76.104335] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 76.107865] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 76.401585] nixos[4752]: switching to system configuration /nix/store/jaiir9vcl0ipxqjd9cin7ssljipj6bnp-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.93 seconds) (finished: subtest: failing units, in 9.74 seconds) subtest: unit file parser machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 76.666112] nixos[4895]: switching to system configuration /nix/store/1842c6kmxp4hb05v0bp8bzz5gci8a46c-nixos-system-machine-test machine # [ 76.668818] systemd[1]: Stopped target Local File Systems. machine # [ 76.672500] systemd[1]: Stopped autorestart.service. machine # [ 76.673357] systemd[1]: Stopped target Remote File Systems. machine # [ 76.950290] systemd[1]: Reload requested from client PID 4895 ('.switch-to-conf') (unit backdoor.service)... machine # [ 76.952466] systemd[1]: Reloading... machine # [ 77.281895] systemd[1]: Reloading finished in 328 ms. machine # [ 77.372829] systemd[573]: Reexecution requested from client PID 4964 ('switch-to-confi')... machine # [ 77.377266] systemd[573]: Reexecuting. machine # [ 77.423595] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.542819] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.550097] systemd[573]: Reload requested from client PID 4964 ('switch-to-confi')... machine # [ 77.553017] systemd[573]: Reloading... machine # [ 77.672044] systemd[573]: Reloading finished in 117 ms. machine # [ 77.688212] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.699080] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 77.700223] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 77.702743] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 77.737718] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 77.741920] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 77.744708] systemd[1]: Stopping Reactivate sysinit units... machine # [ 77.745637] systemd[1]: Reached target Reactivate sysinit units. machine # [ 77.747508] systemd[1]: Reached target Remote File Systems. machine # [ 77.753286] systemd[1]: Reached target Local File Systems. machine # [ 77.754141] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 77.758002] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 77.758952] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 77.767992] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 77.770378] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 77.771981] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.783701] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.785654] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.787608] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 77.948730] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 77.952956] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 77.958109] systemd[1]: Starting linger-users.service... machine # [ 77.961432] systemd[1]: Starting test.service... machine # [ 78.001455] systemd[1]: Finished test.service. machine # [ 78.021803] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 78.024865] systemd[1]: Finished linger-users.service. machine # [ 78.284625] nixos[4895]: finished switching to system configuration /nix/store/1842c6kmxp4hb05v0bp8bzz5gci8a46c-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.88 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 78.590765] nixos[5037]: switching to system configuration /nix/store/rf9yk66n2ml4cb9dv878k8mr07lkpzfv-nixos-system-machine-test machine # [ 78.593583] systemd[1]: Stopped target Remote File Systems. machine # [ 78.596328] systemd[1]: Stopped target Local File Systems. machine # [ 78.895603] systemd[1]: Reload requested from client PID 5037 ('.switch-to-conf') (unit backdoor.service)... machine # [ 78.897785] systemd[1]: Reloading... machine # [ 79.239222] systemd[1]: Reloading finished in 339 ms. machine # [ 79.339650] systemd[573]: Reexecution requested from client PID 5106 ('switch-to-confi')... machine # [ 79.341780] systemd[573]: Reexecuting. machine # [ 79.399852] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.525845] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.532913] systemd[573]: Reload requested from client PID 5106 ('switch-to-confi')... machine # [ 79.537678] systemd[573]: Reloading... machine # [ 79.648980] systemd[573]: Reloading finished in 113 ms. machine # [ 79.664179] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.672870] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 79.675397] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 79.677549] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 79.708568] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 79.712967] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 79.713948] systemd[1]: Stopping Reactivate sysinit units... machine # [ 79.714793] systemd[1]: Reached target Reactivate sysinit units. machine # [ 79.717267] systemd[1]: test.service: Deactivated successfully. machine # [ 79.720407] systemd[1]: Stopped test.service. machine # [ 79.721191] systemd[1]: Stopping test.service... machine # [ 79.724188] systemd[1]: Starting test.service... machine # [ 79.750205] systemd[1]: Finished test.service. machine # [ 79.754757] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.757655] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 79.761529] systemd[1]: Reached target Local File Systems. machine # [ 79.766461] systemd[1]: Reached target Remote File Systems. machine # [ 79.767381] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 79.777038] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 79.778037] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 79.779291] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 79.787116] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 79.788914] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.790167] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.970093] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 79.972186] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 79.977937] systemd[1]: Starting linger-users.service... machine # [ 80.029166] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 80.032400] systemd[1]: Finished linger-users.service. machine # [ 80.291269] nixos[5037]: finished switching to system configuration /nix/store/rf9yk66n2ml4cb9dv878k8mr07lkpzfv-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 2.01 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 80.604697] nixos[5179]: switching to system configuration /nix/store/i1697qfa3kl28vp6l5qki6gk4srvli08-nixos-system-machine-test machine # [ 80.607672] systemd[1]: Stopped target Local File Systems. machine # [ 80.610395] systemd[1]: Stopped target Remote File Systems. machine # [ 80.912435] systemd[1]: Reload requested from client PID 5179 ('.switch-to-conf') (unit backdoor.service)... machine # [ 80.914579] systemd[1]: Reloading... machine # [ 81.261571] systemd[1]: Reloading finished in 345 ms. machine # [ 81.360349] systemd[573]: Reexecution requested from client PID 5248 ('switch-to-confi')... machine # [ 81.361974] systemd[573]: Reexecuting. machine # [ 81.419628] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.545775] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.552332] systemd[573]: Reload requested from client PID 5248 ('switch-to-confi')... machine # [ 81.555038] systemd[573]: Reloading... machine # [ 81.670216] systemd[573]: Reloading finished in 114 ms. machine # [ 81.684197] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.695005] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 81.696239] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 81.698724] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 81.734612] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 81.741260] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 81.742273] systemd[1]: Stopping Reactivate sysinit units... machine # [ 81.743160] systemd[1]: Reached target Reactivate sysinit units. machine # [ 81.747027] systemd[1]: test.service: Deactivated successfully. machine # [ 81.750333] systemd[1]: Stopped test.service. machine # [ 81.751272] systemd[1]: Stopping test.service... machine # [ 81.756308] systemd[1]: Starting test.service... machine # [ 81.779047] systemd[1]: Finished test.service. machine # [ 81.782895] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.786950] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 81.788925] systemd[1]: Reached target Remote File Systems. machine # [ 81.789790] systemd[1]: Reached target Local File Systems. machine # [ 81.798709] systemd[1]: Starting linger-users.service... machine # [ 81.809929] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 81.817094] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 81.818081] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 81.819488] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 81.832625] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 81.834465] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.835765] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.883579] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 81.886651] systemd[1]: Finished linger-users.service. machine # [ 82.019980] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 82.023339] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 82.283782] nixos[5179]: finished switching to system configuration /nix/store/i1697qfa3kl28vp6l5qki6gk4srvli08-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.99 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 82.554290] nixos[5321]: switching to system configuration /nix/store/1842c6kmxp4hb05v0bp8bzz5gci8a46c-nixos-system-machine-test machine # [ 82.556956] systemd[1]: Stopped target Local File Systems. machine # [ 82.559360] systemd[1]: Stopped target Remote File Systems. machine # [ 82.833232] systemd[1]: Reload requested from client PID 5321 ('.switch-to-conf') (unit backdoor.service)... machine # [ 82.834863] systemd[1]: Reloading... machine # [ 83.229592] systemd[1]: Reloading finished in 393 ms. machine # [ 83.320406] systemd[573]: Reexecution requested from client PID 5390 ('switch-to-confi')... machine # [ 83.324522] systemd[573]: Reexecuting. machine # [ 83.379860] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.503704] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.510636] systemd[573]: Reload requested from client PID 5390 ('switch-to-confi')... machine # [ 83.513366] systemd[573]: Reloading... machine # [ 83.628628] systemd[573]: Reloading finished in 114 ms. machine # [ 83.644185] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.653620] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 83.656243] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 83.658585] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 83.692234] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 83.696100] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 83.698264] systemd[1]: Stopping Reactivate sysinit units... machine # [ 83.699217] systemd[1]: Reached target Reactivate sysinit units. machine # [ 83.703236] systemd[1]: test.service: Deactivated successfully. machine # [ 83.704266] systemd[1]: Stopped test.service. machine # [ 83.704927] systemd[1]: Stopping test.service... machine # [ 83.706596] systemd[1]: Starting test.service... machine # [ 83.734572] systemd[1]: Finished test.service. machine # [ 83.741407] systemd[1]: Reached target Local File Systems. machine # [ 83.744487] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 83.748521] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 83.749458] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 83.750727] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 83.766941] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 83.768828] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.770124] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.771330] systemd[1]: Reached target Remote File Systems. machine # [ 83.772178] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.773494] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 83.953503] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 83.959224] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 83.962251] systemd[1]: Starting linger-users.service... machine # [ 84.010112] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 84.012130] systemd[1]: Finished linger-users.service. machine # [ 84.274253] nixos[5321]: finished switching to system configuration /nix/store/1842c6kmxp4hb05v0bp8bzz5gci8a46c-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.99 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 84.582886] nixos[5463]: switching to system configuration /nix/store/lh6b00hf3b4s9fyhsxnldva26670k0fm-nixos-system-machine-test machine # [ 84.585490] systemd[1]: Stopped target Local File Systems. machine # [ 84.587897] systemd[1]: Stopped target Remote File Systems. machine # [ 84.902369] systemd[1]: Reload requested from client PID 5463 ('.switch-to-conf') (unit backdoor.service)... machine # [ 84.904580] systemd[1]: Reloading... machine # [ 85.273838] systemd[1]: Reloading finished in 367 ms. machine # [ 85.376569] systemd[573]: Reexecution requested from client PID 5532 ('switch-to-confi')... machine # [ 85.378069] systemd[573]: Reexecuting. machine # [ 85.431596] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.557195] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.564652] systemd[573]: Reload requested from client PID 5532 ('switch-to-confi')... machine # [ 85.566163] systemd[573]: Reloading... machine # [ 85.683781] systemd[573]: Reloading finished in 115 ms. machine # [ 85.700200] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.710987] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 85.713590] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 85.715806] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 85.753749] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 85.758033] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 85.760778] systemd[1]: Stopping Reactivate sysinit units... machine # [ 85.761803] systemd[1]: Reached target Reactivate sysinit units. machine # [ 85.765544] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.767016] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 85.770116] systemd[1]: Reached target Remote File Systems. machine # [ 85.773208] systemd[1]: Reached target Local File Systems. machine # [ 85.775587] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 85.784955] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 85.785943] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 85.787261] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 85.797551] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 85.799374] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.800958] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.980507] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 85.984423] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 85.988673] systemd[1]: Starting linger-users.service... machine # [ 86.032491] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 86.035343] systemd[1]: Finished linger-users.service. machine # [ 86.295901] nixos[5463]: finished switching to system configuration /nix/store/lh6b00hf3b4s9fyhsxnldva26670k0fm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 2.02 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 86.610584] nixos[5603]: switching to system configuration /nix/store/x1w42z6iqagwa4npcbzi7b3knnmnq6km-nixos-system-machine-test machine # [ 86.613630] systemd[1]: Stopped target Remote File Systems. machine # [ 86.616215] systemd[1]: Stopped target Local File Systems. machine # [ 86.939460] systemd[1]: Reload requested from client PID 5603 ('.switch-to-conf') (unit backdoor.service)... machine # [ 86.941878] systemd[1]: Reloading... machine # [ 87.434241] systemd[1]: Reloading finished in 490 ms. machine # [ 87.529848] systemd[573]: Reexecution requested from client PID 5672 ('switch-to-confi')... machine # [ 87.531344] systemd[573]: Reexecuting. machine # [ 87.587505] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.708952] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.716125] systemd[573]: Reload requested from client PID 5672 ('switch-to-confi')... machine # [ 87.717476] systemd[573]: Reloading... machine # [ 87.837513] systemd[573]: Reloading finished in 118 ms. machine # [ 87.852194] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.862495] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 87.863611] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 87.866630] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 87.901529] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 87.905896] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 87.907962] systemd[1]: Stopping Reactivate sysinit units... machine # [ 87.911863] systemd[1]: Reached target Reactivate sysinit units. machine # [ 87.913126] systemd[1]: test.service: Deactivated successfully. machine # [ 87.914031] systemd[1]: Stopped test.service. machine # [ 87.914691] systemd[1]: Stopping test.service... machine # [ 87.916671] systemd[1]: Starting test.service... machine # [ 87.941681] systemd[1]: Finished test.service. machine # [ 87.946192] systemd[1]: Reached target Remote File Systems. machine # [ 87.952542] systemd[1]: Starting linger-users.service... machine # [ 87.960346] systemd[1]: Reached target Local File Systems. machine # [ 87.963406] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.965181] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 87.970026] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 87.977530] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 87.980582] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 87.984818] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 87.990232] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 87.992868] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.994618] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 88.039509] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 88.042568] systemd[1]: Finished linger-users.service. machine # [ 88.183939] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 88.187086] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 88.447346] nixos[5603]: finished switching to system configuration /nix/store/x1w42z6iqagwa4npcbzi7b3knnmnq6km-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 2.15 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 88.755081] nixos[5745]: switching to system configuration /nix/store/wfpl2y2qxi6iws3pss82fd0v45ab8pzl-nixos-system-machine-test machine # [ 88.757897] systemd[1]: Stopped target Remote File Systems. machine # [ 88.760587] systemd[1]: Stopped target Local File Systems. machine # [ 89.052672] systemd[1]: Reload requested from client PID 5745 ('.switch-to-conf') (unit backdoor.service)... machine # [ 89.054738] systemd[1]: Reloading... machine # [ 89.394233] systemd[1]: Reloading finished in 337 ms. machine # [ 89.488754] systemd[573]: Reexecution requested from client PID 5814 ('switch-to-confi')... machine # [ 89.491801] systemd[573]: Reexecuting. machine # [ 89.547877] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.667519] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.675553] systemd[573]: Reload requested from client PID 5814 ('switch-to-confi')... machine # [ 89.679938] systemd[573]: Reloading... machine # [ 89.794411] systemd[573]: Reloading finished in 115 ms. machine # [ 89.808186] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.817678] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 89.820355] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 89.822691] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 89.857918] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 89.861622] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 89.863773] systemd[1]: Stopping Reactivate sysinit units... machine # [ 89.867890] systemd[1]: Reached target Reactivate sysinit units. machine # [ 89.869212] systemd[1]: test.service: Deactivated successfully. machine # [ 89.870071] systemd[1]: Stopped test.service. machine # [ 89.870743] systemd[1]: Stopping test.service... machine # [ 89.872853] systemd[1]: Starting test.service... machine # [ 89.902039] systemd[1]: Finished test.service. machine # [ 89.905089] systemd[1]: Reached target Local File Systems. machine # [ 89.910618] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 89.915052] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 89.920594] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 89.921962] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 89.931446] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 89.937412] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.938985] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.940243] systemd[1]: Reached target Remote File Systems. machine # [ 89.941026] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.942275] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 90.118134] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 90.123193] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 90.125759] systemd[1]: Starting linger-users.service... machine # [ 90.172910] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 90.174754] systemd[1]: Finished linger-users.service. machine # [ 90.434132] nixos[5745]: finished switching to system configuration /nix/store/wfpl2y2qxi6iws3pss82fd0v45ab8pzl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.99 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 90.702508] nixos[5887]: switching to system configuration /nix/store/zsx36qppvrp5mxnk37ycqfyx65szibdh-nixos-system-machine-test machine # [ 90.707447] systemd[1]: Stopped target Remote File Systems. machine # [ 90.710460] systemd[1]: Stopped target Local File Systems. machine # [ 91.017113] systemd[1]: Reload requested from client PID 5887 ('.switch-to-conf') (unit backdoor.service)... machine # [ 91.019176] systemd[1]: Reloading... machine # [ 91.367018] systemd[1]: Reloading finished in 345 ms. machine # [ 91.460987] systemd[573]: Reexecution requested from client PID 5956 ('switch-to-confi')... machine # [ 91.464993] systemd[573]: Reexecuting. machine # [ 91.511087] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.629121] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.635966] systemd[573]: Reload requested from client PID 5956 ('switch-to-confi')... machine # [ 91.637386] systemd[573]: Reloading... machine # [ 91.753498] systemd[573]: Reloading finished in 114 ms. machine # [ 91.768255] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.778310] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 91.780927] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 91.783163] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 91.817700] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 91.821712] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 91.823807] systemd[1]: Stopping Reactivate sysinit units... machine # [ 91.827757] systemd[1]: Reached target Reactivate sysinit units. machine # [ 91.829054] systemd[1]: test.service: Deactivated successfully. machine # [ 91.829931] systemd[1]: Stopped test.service. machine # [ 91.830716] systemd[1]: Stopping test.service... machine # [ 91.832677] systemd[1]: Starting test.service... machine # [ 91.858171] systemd[1]: Finished test.service. machine # [ 91.862902] systemd[1]: Reached target Remote File Systems. machine # [ 91.865552] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.867001] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 91.873902] systemd[1]: Reached target Local File Systems. machine # [ 91.874815] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 91.885780] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 91.886758] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 91.892183] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 91.894456] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 91.896447] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.897775] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 92.067660] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 92.072617] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 92.075192] systemd[1]: Starting linger-users.service... machine # [ 92.118801] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 92.120826] systemd[1]: Finished linger-users.service. machine # [ 92.382572] nixos[5887]: finished switching to system configuration /nix/store/zsx36qppvrp5mxnk37ycqfyx65szibdh-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 1.95 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 92.672423] nixos[6029]: switching to system configuration /nix/store/1842c6kmxp4hb05v0bp8bzz5gci8a46c-nixos-system-machine-test machine # [ 92.675377] systemd[1]: Stopped target Remote File Systems. machine # [ 92.678027] systemd[1]: Stopped target Local File Systems. machine # [ 92.957534] systemd[1]: Reload requested from client PID 6029 ('.switch-to-conf') (unit backdoor.service)... machine # [ 92.959588] systemd[1]: Reloading... machine # [ 93.290835] systemd[1]: Reloading finished in 329 ms. machine # [ 93.382715] systemd[573]: Reexecution requested from client PID 6098 ('switch-to-confi')... machine # [ 93.386899] systemd[573]: Reexecuting. machine # [ 93.436182] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.556140] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.564568] systemd[573]: Reload requested from client PID 6098 ('switch-to-confi')... machine # [ 93.567305] systemd[573]: Reloading... machine # [ 93.685288] systemd[573]: Reloading finished in 116 ms. machine # [ 93.700430] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.712143] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 93.713268] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 93.716397] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 93.749943] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 93.754577] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 93.759728] systemd[1]: Stopping Reactivate sysinit units... machine # [ 93.761238] systemd[1]: Reached target Reactivate sysinit units. machine # [ 93.762219] systemd[1]: test.service: Deactivated successfully. machine # [ 93.763148] systemd[1]: Stopped test.service. machine # [ 93.763838] systemd[1]: Stopping test.service... machine # [ 93.768519] systemd[1]: Starting test.service... machine # [ 93.789526] systemd[1]: Finished test.service. machine # [ 93.792409] systemd[1]: Reached target Local File Systems. machine # [ 93.797572] systemd[1]: Reached target Remote File Systems. machine # [ 93.800511] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.801898] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 93.808065] systemd[1]: Starting linger-users.service... machine # [ 93.814430] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 93.824120] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 93.825077] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 93.826353] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 93.835570] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 93.837415] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.838732] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.891615] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 93.895596] systemd[1]: Finished linger-users.service. machine # [ 94.032805] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 94.036519] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 94.291108] nixos[6029]: finished switching to system configuration /nix/store/1842c6kmxp4hb05v0bp8bzz5gci8a46c-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.91 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 94.596117] nixos[6171]: switching to system configuration /nix/store/z8yy2bc7phh9lpwjfdby5lfk9knz6vly-nixos-system-machine-test machine # [ 94.600466] systemd[1]: Stopped target Local File Systems. machine # [ 94.602501] systemd[1]: Stopped target Remote File Systems. machine # [ 94.950056] systemd[1]: Reload requested from client PID 6171 ('.switch-to-conf') (unit backdoor.service)... machine # [ 94.952241] systemd[1]: Reloading... machine # [ 95.299833] systemd[1]: Reloading finished in 346 ms. machine # [ 95.397856] systemd[573]: Reexecution requested from client PID 6239 ('switch-to-confi')... machine # [ 95.402370] systemd[573]: Reexecuting. machine # [ 95.463809] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.587949] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.595071] systemd[573]: Reload requested from client PID 6239 ('switch-to-confi')... machine # [ 95.597792] systemd[573]: Reloading... machine # [ 95.714770] systemd[573]: Reloading finished in 115 ms. machine # [ 95.732188] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.741442] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 95.743954] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 95.746280] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 95.781842] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 95.786128] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 95.790954] systemd[1]: Stopping Reactivate sysinit units... machine # [ 95.791982] systemd[1]: Reached target Reactivate sysinit units. machine # [ 95.794694] systemd[1]: Reloading test.service... machine # [ 95.824179] systemd[1]: Reloaded test.service. machine # [ 95.828747] systemd[1]: Reached target Remote File Systems. machine # [ 95.834278] systemd[1]: Starting linger-users.service... machine # [ 95.840405] systemd[1]: Reached target Local File Systems. machine # [ 95.845388] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.846866] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 95.856477] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 95.863346] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 95.869332] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 95.870790] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 95.881773] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 95.883558] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.885943] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.938042] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 95.940125] systemd[1]: Finished linger-users.service. machine # [ 96.117825] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 96.121678] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 96.378697] nixos[6171]: finished switching to system configuration /nix/store/z8yy2bc7phh9lpwjfdby5lfk9knz6vly-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 2.09 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 96.687087] nixos[6313]: switching to system configuration /nix/store/q62gm9j5l9lc62wbh3f4sqfnpykldszm-nixos-system-machine-test machine # [ 96.692396] systemd[1]: Stopped target Local File Systems. machine # [ 96.693320] systemd[1]: Stopped target Remote File Systems. machine # [ 96.981640] systemd[1]: Reload requested from client PID 6313 ('.switch-to-conf') (unit backdoor.service)... machine # [ 96.983700] systemd[1]: Reloading... machine # [ 97.320675] systemd[1]: Reloading finished in 335 ms. machine # [ 97.408468] systemd[573]: Reexecution requested from client PID 6382 ('switch-to-confi')... machine # [ 97.409855] systemd[573]: Reexecuting. machine # [ 97.467323] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 97.586572] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 97.593098] systemd[573]: Reload requested from client PID 6382 ('switch-to-confi')... machine # [ 97.595469] systemd[573]: Reloading... machine # [ 97.707267] systemd[573]: Reloading finished in 111 ms. machine # [ 97.724194] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 97.732911] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 97.735308] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 97.737474] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 97.769657] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 97.773536] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 97.777810] systemd[1]: Stopping Reactivate sysinit units... machine # [ 97.778861] systemd[1]: Reached target Reactivate sysinit units. machine # [ 97.780790] systemd[1]: Reloading test.service... machine # [ 97.806109] systemd[1]: Reloaded test.service. machine # [ 97.809667] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 97.813697] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 97.816712] systemd[1]: Reached target Local File Systems. machine # [ 97.822033] systemd[1]: Reached target Remote File Systems. machine # [ 97.824742] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 97.831318] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 97.835417] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 97.840197] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 97.842513] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 97.845840] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 97.847174] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.011264] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 98.016279] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 98.018356] systemd[1]: Starting linger-users.service... machine # [ 98.062141] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 98.064723] systemd[1]: Finished linger-users.service. machine # [ 98.323401] nixos[6313]: finished switching to system configuration /nix/store/q62gm9j5l9lc62wbh3f4sqfnpykldszm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.94 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 98.620737] nixos[6455]: switching to system configuration /nix/store/p75jzjlpy46x8yhn98p8zmsriz83lhfj-nixos-system-machine-test machine # [ 98.626027] systemd[1]: Stopped target Local File Systems. machine # [ 98.626962] systemd[1]: Stopped target Remote File Systems. machine # [ 98.939906] systemd[1]: Reload requested from client PID 6455 ('.switch-to-conf') (unit backdoor.service)... machine # [ 98.942328] systemd[1]: Reloading... machine # [ 99.282699] systemd[1]: Reloading finished in 338 ms. machine # [ 99.375956] systemd[573]: Reexecution requested from client PID 6524 ('switch-to-confi')... machine # [ 99.379898] systemd[573]: Reexecuting. machine # [ 99.435815] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.557552] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.564570] systemd[573]: Reload requested from client PID 6524 ('switch-to-confi')... machine # [ 99.565860] systemd[573]: Reloading... machine # [ 99.679478] systemd[573]: Reloading finished in 112 ms. machine # [ 99.696557] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.706007] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 99.709351] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 99.711732] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 99.750084] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 99.755036] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 99.760780] systemd[1]: Stopping Reactivate sysinit units... machine # [ 99.761788] systemd[1]: Reached target Reactivate sysinit units. machine # [ 99.762741] systemd[1]: test.service: Deactivated successfully. machine # [ 99.763642] systemd[1]: Stopped test.service. machine # [ 99.764558] systemd[1]: Stopping test.service... machine # [ 99.766778] systemd[1]: Starting test.service... machine # [ 99.797126] systemd[1]: Finished test.service. machine # [ 99.803078] systemd[1]: Reached target Local File Systems. machine # [ 99.808655] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 99.811753] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 99.816795] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 99.818339] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 99.821820] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 99.823836] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.836395] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.837830] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.839197] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 99.841745] systemd[1]: Reached target Remote File Systems. machine # [ 100.023943] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 100.027378] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 100.032919] systemd[1]: Starting linger-users.service... machine # [ 100.074557] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 100.077527] systemd[1]: Finished linger-users.service. machine # [ 100.335794] nixos[6455]: finished switching to system configuration /nix/store/p75jzjlpy46x8yhn98p8zmsriz83lhfj-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 2.01 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 100.609681] nixos[6597]: switching to system configuration /nix/store/x1w42z6iqagwa4npcbzi7b3knnmnq6km-nixos-system-machine-test machine # [ 100.612504] systemd[1]: Stopped target Remote File Systems. machine # [ 100.614364] systemd[1]: Stopped target Local File Systems. machine # [ 100.889400] systemd[1]: Reload requested from client PID 6597 ('.switch-to-conf') (unit backdoor.service)... machine # [ 100.891069] systemd[1]: Reloading... machine # [ 101.224115] systemd[1]: Reloading finished in 331 ms. machine # [ 101.319610] systemd[573]: Reexecution requested from client PID 6666 ('switch-to-confi')... machine # [ 101.324492] systemd[573]: Reexecuting. machine # [ 101.383751] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.503415] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.511150] systemd[573]: Reload requested from client PID 6666 ('switch-to-confi')... machine # [ 101.514358] systemd[573]: Reloading... machine # [ 101.627860] systemd[573]: Reloading finished in 114 ms. machine # [ 101.644475] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.655319] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 101.657995] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 101.660594] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 101.705669] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 101.710456] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 101.712745] systemd[1]: Stopping Reactivate sysinit units... machine # [ 101.713801] systemd[1]: Reached target Reactivate sysinit units. machine # [ 101.718823] systemd[1]: Reached target Remote File Systems. machine # [ 101.725266] systemd[1]: Starting linger-users.service... machine # [ 101.728647] systemd[1]: Reached target Local File Systems. machine # [ 101.742319] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.743892] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 101.751875] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 101.759988] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 101.767209] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 101.774580] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 101.779527] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 101.783422] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.787492] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.828169] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 101.831318] systemd[1]: Finished linger-users.service. machine # [ 102.002015] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 102.005082] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 102.264900] nixos[6597]: finished switching to system configuration /nix/store/x1w42z6iqagwa4npcbzi7b3knnmnq6km-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.93 seconds) (finished: subtest: unit file parser, in 25.87 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 102.552743] nixos[6737]: switching to system configuration /nix/store/a8j4c2ynk6h4xcahvnhr77mr8g8kghsg-nixos-system-machine-test machine # [ 102.557326] systemd[1]: Stopped target Local File Systems. machine # [ 102.559087] systemd[1]: Stopped target Remote File Systems. machine # [ 102.836833] systemd[1]: Reload requested from client PID 6737 ('.switch-to-conf') (unit backdoor.service)... machine # [ 102.838884] systemd[1]: Reloading... machine # [ 103.166037] systemd[1]: Reloading finished in 324 ms. machine # [ 103.254688] systemd[573]: Reexecution requested from client PID 6806 ('switch-to-confi')... machine # [ 103.258997] systemd[573]: Reexecuting. machine # [ 103.316556] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.439317] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.446393] systemd[573]: Reload requested from client PID 6806 ('switch-to-confi')... machine # [ 103.450151] systemd[573]: Reloading... machine # [ 103.564258] systemd[573]: Reloading finished in 115 ms. machine # [ 103.580175] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.590861] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 103.593252] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 103.595469] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 103.629902] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 103.633712] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 103.637215] systemd[1]: Stopping Reactivate sysinit units... machine # [ 103.638118] systemd[1]: Reached target Reactivate sysinit units. machine # [ 103.641430] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.645977] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 103.647431] systemd[1]: Reached target Local File Systems. machine # [ 103.652282] systemd[1]: Reached target Remote File Systems. machine # [ 103.654326] systemd[1]: Starting linger-users.service... machine # [ 103.659232] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 103.664135] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 103.665107] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 103.666388] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 103.680389] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 103.682053] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.683356] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.738960] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 103.742160] systemd[1]: Finished linger-users.service. machine # [ 103.883954] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 103.886943] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 104.147376] nixos[6737]: finished switching to system configuration /nix/store/a8j4c2ynk6h4xcahvnhr77mr8g8kghsg-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.88 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 104.455057] nixos[6877]: switching to system configuration /nix/store/kbj5fwrn6aqjvg7b9dq1ar4pr65dj7nd-nixos-system-machine-test machine # [ 104.457950] systemd[1]: test.service: Deactivated successfully. machine # [ 104.461496] systemd[1]: Stopped test.service. machine # [ 104.463060] systemd[1]: Stopped target Remote File Systems. machine # [ 104.463881] systemd[1]: Stopped target Local File Systems. machine # [ 104.754932] systemd[1]: Reload requested from client PID 6877 ('.switch-to-conf') (unit backdoor.service)... machine # [ 104.757922] systemd[1]: Reloading... machine # [ 105.231644] systemd[1]: Reloading finished in 472 ms. machine # [ 105.322678] systemd[573]: Reexecution requested from client PID 6948 ('switch-to-confi')... machine # [ 105.324725] systemd[573]: Reexecuting. machine # [ 105.371218] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.486908] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.493807] systemd[573]: Reload requested from client PID 6948 ('switch-to-confi')... machine # [ 105.496397] systemd[573]: Reloading... machine # [ 105.610439] systemd[573]: Reloading finished in 113 ms. machine # [ 105.628177] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.638694] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 105.641185] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 105.643495] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 105.676650] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 105.680966] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 105.683001] systemd[1]: Stopping Reactivate sysinit units... machine # [ 105.683862] systemd[1]: Reached target Reactivate sysinit units. machine # [ 105.697445] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 105.699945] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 105.704505] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 105.705643] systemd[1]: Reached target Remote File Systems. machine # [ 105.708265] systemd[1]: Starting linger-users.service... machine # [ 105.712651] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 105.716398] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 105.736138] systemd[1]: Starting reload-triggers.service... machine # [ 105.737111] systemd[1]: Starting simple-service.service... machine # [ 105.750970] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 105.758066] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 105.775857] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 105.796379] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 105.797645] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 105.798819] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 105.852385] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 105.853877] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 105.855302] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 105.916642] systemd[1]: Reached target Local File Systems. machine # [ 105.917707] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 105.918895] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 105.971151] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 105.995870] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 106.009142] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 106.021025] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 106.023397] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 106.040288] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 106.041786] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 106.043032] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 106.043988] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 106.055402] systemd[1]: Finished reload-triggers.service. machine # [ 106.058398] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 106.059572] systemd[1]: Finished simple-service.service. machine # [ 106.065778] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 106.072271] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 106.073319] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 106.074386] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 106.075340] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 106.080502] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 106.084950] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 106.085958] systemd[1]: Finished linger-users.service. machine # [ 106.228755] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 106.232296] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 106.236284] systemd[1]: Starting no-restart-service.service... machine # [ 106.240618] systemd[1]: Starting simple-reload-service.service... machine # [ 106.244319] systemd[1]: Starting simple-restart-service.service... machine # [ 106.256605] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 106.312813] systemd[1]: Finished no-restart-service.service. machine # [ 106.315326] systemd[1]: Finished simple-reload-service.service. machine # [ 106.317246] systemd[1]: Finished simple-restart-service.service. machine # [ 106.320384] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 106.579917] nixos[6877]: finished switching to system configuration /nix/store/kbj5fwrn6aqjvg7b9dq1ar4pr65dj7nd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.43 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 106.911380] nixos[7047]: switching to system configuration /nix/store/kbj5fwrn6aqjvg7b9dq1ar4pr65dj7nd-nixos-system-machine-test machine # [ 106.914300] systemd[1]: Stopped target Local File Systems. machine # [ 106.916706] systemd[1]: Stopped target Remote File Systems. machine # [ 107.206958] systemd[1]: Reload requested from client PID 7047 ('.switch-to-conf') (unit backdoor.service)... machine # [ 107.209010] systemd[1]: Reloading... machine # [ 107.563799] systemd[1]: Reloading finished in 353 ms. machine # [ 107.662394] systemd[573]: Reexecution requested from client PID 7117 ('switch-to-confi')... machine # [ 107.667058] systemd[573]: Reexecuting. machine # [ 107.715347] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.831234] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.837647] systemd[573]: Reload requested from client PID 7117 ('switch-to-confi')... machine # [ 107.841551] systemd[573]: Reloading... machine # [ 107.953115] systemd[573]: Reloading finished in 112 ms. machine # [ 107.968164] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.976964] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 107.979289] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 107.981388] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 108.012077] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 108.015944] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 108.018931] systemd[1]: Stopping Reactivate sysinit units... machine # [ 108.019770] systemd[1]: Reached target Reactivate sysinit units. machine # [ 108.024468] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 108.029639] systemd[1]: Reloading reload-triggers.service... machine # [ 108.042652] systemd[1]: Reloading simple-reload-service.service... machine # [ 108.050767] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 108.060470] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 108.068579] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 108.130654] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 108.138754] systemd[1]: Reloaded reload-triggers.service. machine # [ 108.139649] systemd[1]: Reloaded simple-reload-service.service. machine # [ 108.141462] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 108.148994] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 108.151357] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 108.154557] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 108.160510] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 108.161615] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 108.162641] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 108.171629] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 108.185730] systemd[1]: Stopped simple-restart-service.service. machine # [ 108.186711] systemd[1]: Stopping simple-restart-service.service... machine # [ 108.187634] systemd[1]: Starting simple-restart-service.service... machine # [ 108.210794] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 108.211872] systemd[1]: Stopped simple-service.service. machine # [ 108.221656] systemd[1]: Stopping simple-service.service... machine # [ 108.222683] systemd[1]: Starting simple-service.service... machine # [ 108.223570] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 108.245277] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 108.246576] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 108.266113] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 108.280318] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 108.281889] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 108.282955] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 108.301650] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 108.305466] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 108.306998] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 108.308422] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 108.309481] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 108.310482] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 108.311430] systemd[1]: Finished simple-restart-service.service. machine # [ 108.312692] systemd[1]: Finished simple-service.service. machine # [ 108.313876] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 108.315219] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 108.319458] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 108.326661] systemd[1]: Reached target Remote File Systems. machine # [ 108.330907] systemd[1]: Starting linger-users.service... machine # [ 108.343865] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.352439] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 108.353785] systemd[1]: Reached target Local File Systems. machine # [ 108.354998] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 108.362815] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 108.363797] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 108.370292] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 108.378895] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 108.383201] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.388244] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.418665] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 108.422644] systemd[1]: Finished linger-users.service. machine # [ 108.556431] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 108.558320] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 108.818383] nixos[7047]: finished switching to system configuration /nix/store/kbj5fwrn6aqjvg7b9dq1ar4pr65dj7nd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.24 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 109.165415] nixos[7213]: switching to system configuration /nix/store/3ipy6ra2zqiz7q1dj7j9sd207cx0nn6m-nixos-system-machine-test machine # [ 109.168079] systemd[1]: Stopped target Local File Systems. machine # [ 109.170322] systemd[1]: Stopped target Remote File Systems. machine # [ 109.478096] systemd[1]: Reload requested from client PID 7213 ('.switch-to-conf') (unit backdoor.service)... machine # [ 109.480148] systemd[1]: Reloading... machine # [ 109.837401] systemd[1]: Reloading finished in 355 ms. machine # [ 109.929849] systemd[573]: Reexecution requested from client PID 7284 ('switch-to-confi')... machine # [ 109.933848] systemd[573]: Reexecuting. machine # [ 109.986780] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 110.098857] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 110.105353] systemd[573]: Reload requested from client PID 7284 ('switch-to-confi')... machine # [ 110.107771] systemd[573]: Reloading... machine # [ 110.220213] systemd[573]: Reloading finished in 111 ms. machine # [ 110.236162] systemd[573]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 110.245853] systemd[573]: Stopped Run user-specific NixOS activation. machine # [ 110.248065] systemd[573]: Stopping Run user-specific NixOS activation... machine # [ 110.250353] systemd[573]: Starting Run user-specific NixOS activation... machine # [ 110.285661] systemd[573]: Finished Run user-specific NixOS activation. machine # [ 110.291897] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 110.293656] systemd[1]: Stopping Reactivate sysinit units... machine # [ 110.294663] systemd[1]: Reached target Reactivate sysinit units. machine # [ 110.301166] systemd[1]: Reloading reload-triggers.service... machine # [ 110.314780] systemd[1]: Reloading simple-reload-service.service... machine # [ 110.323288] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 110.333445] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 110.379670] systemd[1]: Reloaded simple-reload-service.service. machine # [ 110.395415] systemd[1]: Reloaded reload-triggers.service. machine # [ 110.399051] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 110.404713] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 110.410797] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 110.413956] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 110.415124] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 110.426612] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 110.427795] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 110.443339] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 110.455386] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 110.461296] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 110.462531] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 110.463865] systemd[1]: Stopped simple-restart-service.service. machine # [ 110.493380] systemd[1]: Stopping simple-restart-service.service... machine # [ 110.494593] systemd[1]: Starting simple-restart-service.service... machine # [ 110.495757] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 110.526769] systemd[1]: Stopped simple-service.service. machine # [ 110.527808] systemd[1]: Stopping simple-service.service... machine # [ 110.553107] systemd[1]: Starting simple-service.service... machine # [ 110.554320] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 110.555997] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 110.596333] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 110.608222] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 110.613279] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 110.622658] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 110.623938] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 110.625671] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 110.626856] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 110.633520] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 110.634791] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 110.635897] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 110.640959] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 110.642383] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 110.643379] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 110.648831] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 110.649941] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 110.650973] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 110.651916] systemd[1]: Finished simple-restart-service.service. machine # [ 110.654236] systemd[1]: Finished simple-service.service. machine # [ 110.655074] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 110.657645] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 110.658890] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 110.659999] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 110.664984] systemd[1]: Reached target Local File Systems. machine # [ 110.665907] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 110.671878] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 110.676433] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 110.677777] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 110.679952] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 110.689187] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 110.690624] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 110.691909] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 110.693585] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 110.694953] systemd[1]: Reached target Remote File Systems. machine # [ 110.850451] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 110.855280] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 110.860363] systemd[1]: Starting linger-users.service... machine # [ 110.896974] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 110.899814] systemd[1]: Finished linger-users.service. machine # [ 111.160797] nixos[7213]: finished switching to system configuration /nix/store/3ipy6ra2zqiz7q1dj7j9sd207cx0nn6m-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.34 seconds) machine: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/yvg124id1riyamlyilm2wvs8myd9qir8-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.40 seconds) (finished: subtest: restart and reload by activation script, in 9.30 seconds) (finished: run the VM test script, in 112.42 seconds) test script finished in 112.82s cleanup kill QemuMachine (pid 45) machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14) machine # [2026-09-15T03:04:55Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-15T03:04:55Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-15T03:04:55Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.21 seconds) additionally exposed symbols: machine, other, vlan1, 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