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.01 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.TcoEMsUlXC', 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: e5fb7b1c-1358-44cd-adf4-7e178c357316 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-10-01T03:46:09Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-01T03:46:09Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-01T03:46:09Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-01T03:46:09Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-01T03:46:09Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-01T03:46:09Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-01T03:46:09Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-01T03:46:09Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-01T03:46:09Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-01T03:46:09Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-01T03:46:09Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-01T03:46:09Z INFO virtiofsd] Client connected, servicing requests machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 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 s186776 r8192 d116328 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/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/init regInfo=/nix/.ro-store/7snk21cif5fc9kvnpgs1sarawmyf4kkf-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/7snk21cif5fc9kvnpgs1sarawmyf4kkf-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 75026 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.000077] arm-pv: using stolen time PV machine # [ 0.002826] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.003029] Console: colour dummy device 80x25 machine # [ 0.003038] printk: legacy console [tty0] enabled machine # [ 0.003248] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.003255] pid_max: default: 32768 minimum: 301 machine # [ 0.003370] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.003894] landlock: Up and running. machine # [ 0.003897] Yama: becoming mindful. machine # [ 0.006583] LSM support for eBPF active machine # [ 0.006911] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.006944] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.009127] rcu: Hierarchical SRCU implementation. machine # [ 0.009135] rcu: Max phase no-delay instances is 1000. machine # [ 0.010534] fsl-mc MSI: its@8080000 domain created machine # [ 0.010666] EFI services will not be available. machine # [ 0.010792] smp: Bringing up secondary CPUs ... machine # [ 0.010803] smp: Brought up 1 node, 1 CPU machine # [ 0.010806] SMP: Total of 1 processors activated. machine # [ 0.010809] CPU: All CPU(s) started at EL1 machine # [ 0.010820] CPU features: detected: Branch Target Identification machine # [ 0.010828] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.010831] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.010835] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.010839] CPU features: detected: Common not Private translations machine # [ 0.010842] CPU features: detected: CRC32 instructions machine # [ 0.010845] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.010848] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.010852] CPU features: detected: Data independent timing control (DIT) machine # [ 0.010855] CPU features: detected: E0PD machine # [ 0.010857] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.010860] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.010864] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.010867] CPU features: detected: Fine Grained Traps machine # [ 0.010871] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.010875] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.010878] CPU features: detected: LSE atomic instructions machine # [ 0.010881] CPU features: detected: Privileged Access Never machine # [ 0.010883] CPU features: detected: PMUv3 machine # [ 0.010886] CPU features: detected: RAS Extension Support machine # [ 0.010889] CPU features: detected: RASv1p1 Extension Support machine # [ 0.010892] CPU features: detected: Random Number Generator machine # [ 0.010894] CPU features: detected: Speculation barrier (SB) machine # [ 0.010897] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.010899] CPU features: detected: TLB range maintenance instructions machine # [ 0.010904] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.010963] alternatives: applying system-wide alternatives machine # [ 0.014298] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.014564] Memory: 893460K/1048576K available (24512K kernel code, 7094K rwdata, 26568K rodata, 4736K init, 1106K bss, 113608K reserved, 32768K cma-reserved) machine # [ 0.014967] devtmpfs: initialized machine # [ 0.016856] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.016882] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.017099] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.017104] 0 pages in range for non-PLT usage machine # [ 0.017105] 508208 pages in range for PLT usage machine # [ 0.017228] pinctrl core: initialized pinctrl subsystem machine # [ 0.018201] DMI not present or invalid. machine # [ 0.025138] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.027829] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.027999] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.028164] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.028199] audit: initializing netlink subsys (disabled) machine # [ 0.028915] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.028917] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.028921] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.028924] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.028926] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.028959] audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1 machine # [ 0.028967] cpuidle: using governor ladder machine # [ 0.028973] cpuidle: using governor menu machine # [ 0.029198] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.029215] ASID allocator initialised with 65536 entries machine # [ 0.030645] Serial: AMBA PL011 UART driver machine # [ 0.036650] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.036848] printk: console [ttyAMA0] enabled machine # [ 0.178144] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.178157] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.178161] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.178164] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.178167] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.178170] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.178173] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.178175] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.179754] fbcon: Taking over console machine # [ 0.179767] ACPI: Interpreter disabled. machine # [ 0.189940] iommu: Default domain type: Translated machine # [ 0.189948] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.190454] SCSI subsystem initialized machine # [ 0.192632] usbcore: registered new interface driver usbfs machine # [ 0.192672] usbcore: registered new interface driver hub machine # [ 0.192696] usbcore: registered new device driver usb machine # [ 0.193025] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.193029] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.193038] PTP clock support registered machine # [ 0.193080] EDAC MC: Ver: 3.0.0 machine # [ 0.194408] scmi_core: SCMI protocol bus registered machine # [ 0.200517] FPGA manager framework machine # [ 0.203284] vgaarb: loaded machine # [ 0.203613] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.209365] VFS: Disk quotas dquot_6.6.0 machine # [ 0.209398] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.213352] netfs: FS-Cache loaded machine # [ 0.213525] pnp: PnP ACPI: disabled machine # [ 0.218754] NET: Registered PF_INET protocol family machine # [ 0.218938] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.251898] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.251945] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.251975] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.252023] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.252095] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.252188] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.252253] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.252301] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.252397] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.252415] NET: Registered PF_XDP protocol family machine # [ 0.252433] PCI: CLS 0 bytes, default 64 machine # [ 0.252723] Trying to unpack rootfs image as initramfs... machine # [ 0.271657] kvm [1]: HYP mode not available machine # [ 0.432256] Initialise system trusted keyrings machine # [ 0.432406] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.432814] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.432865] 9p: Installing v9fs 9p2000 file system support machine # [ 0.461103] Key type asymmetric registered machine # [ 0.461123] Asymmetric key parser 'x509' registered machine # [ 0.461216] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.461525] io scheduler mq-deadline registered machine # [ 0.461530] io scheduler kyber registered machine # [ 0.474431] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.475050] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.475453] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.475468] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.475478] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.475483] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.475506] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.475527] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.475603] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.475610] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.475613] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.475617] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.495745] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.495877] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.496413] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.496607] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.496619] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.496646] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.496658] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.497147] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.497349] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.497361] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.497388] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.497922] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.498112] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.498124] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.498151] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.498644] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.498835] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.498847] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.498874] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.498886] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.499388] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.499588] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.499640] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.500131] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.500325] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.500351] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.500770] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.500961] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.501267] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.501467] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.501494] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.502092] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.502299] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.502326] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.502828] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.503025] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.503052] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.503564] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.503892] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.503905] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.503932] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.504445] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.504643] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.504655] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.504682] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.505340] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.505346] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.505350] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.505395] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.505438] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.505482] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.505531] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.505576] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.505621] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.505665] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.505710] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.505754] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.505835] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.505889] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.505908] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.505926] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.505945] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.505963] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.505984] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.506003] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.506021] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.506040] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.506062] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.506081] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.506101] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.506120] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.506139] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.506156] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned machine # [ 0.506174] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned machine # [ 0.506192] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.506210] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.506235] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.506244] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.506246] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.507203] pci 0000:00:07.0: enabling device (0000 -> 0002) machine # [ 0.615888] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.618041] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.627916] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.630283] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.640844] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002) machine # [ 0.643107] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002) machine # [ 0.646809] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.657087] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.659323] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.663134] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.673283] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.685104] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.687336] msm_serial: driver initialized machine # [ 0.687480] SuperH (H)SCI(F) driver initialized machine # [ 0.687543] STM32 USART driver initialized machine # [ 0.726207] loop: module loaded machine # [ 0.726418] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 0.727328] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.740475] megasas: 07.734.00.00-rc1 machine # [ 0.741314] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.743530] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.743551] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.749240] Using buffer write method machine # [ 0.749291] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.751155] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.751177] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.766144] Using buffer write method machine # [ 0.766173] Concatenating MTD devices: machine # [ 0.766176] (0): "0.flash" machine # [ 0.766178] (1): "0.flash" machine # [ 0.766180] into device "0.flash" machine # [ 1.076977] Freeing initrd memory: 26428K machine # [ 1.083985] tun: Universal TUN/TAP device driver, 1.6 machine # [ 1.087531] thunder_xcv, ver 1.0 machine # [ 1.087562] thunder_bgx, ver 1.0 machine # [ 1.087581] nicpf, ver 1.0 machine # [ 1.090272] e1000: Intel(R) PRO/1000 Network Driver machine # [ 1.090279] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 1.090304] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 1.090315] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 1.090338] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 1.090342] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 1.090361] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 1.090364] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 1.090499] sky2: driver version 1.30 machine # [ 1.098972] usbcore: registered new interface driver usb-storage machine # [ 1.099144] usbcore: registered new interface driver usbserial_generic machine # [ 1.099157] usbserial: USB Serial support registered for generic machine # [ 1.100470] ehci-pci 0000:00:07.0: EHCI Host Controller machine # [ 1.100496] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1 machine # [ 1.100673] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000 machine # [ 1.106210] hv_vmbus: registering driver hyperv_keyboard machine # [ 1.107217] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 1.107239] rtc-pl031 9010000.pl031: setting system clock to 2026-10-01T03:46:12 UTC (1790826372) machine # [ 1.107555] i2c_dev: i2c /dev entries driver machine # [ 1.111863] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00 machine # [ 1.112171] hub 1-0:1.0: USB hub found machine # [ 1.112189] hub 1-0:1.0: 6 ports detected machine # [ 1.115182] sdhci: Secure Digital Host Controller Interface driver machine # [ 1.115189] sdhci: Copyright(c) Pierre Ossman machine # [ 1.115480] Synopsys Designware Multimedia Card Interface Driver machine # [ 1.120028] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 1.121737] hid: raw HID events driver (C) Jiri Kosina machine # [ 1.122007] usbcore: registered new interface driver usbhid machine # [ 1.122011] usbhid: USB HID core driver machine # [ 1.123249] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 1.124900] drop_monitor: Initializing network drop monitor service machine # [ 1.125097] NET: Registered PF_INET6 protocol family machine # [ 1.131156] Segment Routing with IPv6 machine # [ 1.131182] In-situ OAM (IOAM) with IPv6 machine # [ 1.131212] NET: Registered PF_PACKET protocol family machine # [ 1.131283] 9pnet: Installing 9P2000 support machine # [ 1.131330] Key type dns_resolver registered machine # [ 1.140337] registered taskstats version 1 machine # [ 1.140501] Loading compiled-in X.509 certificates machine # [ 1.149789] Demotion targets for Node 0: null machine # [ 1.149964] Key type .fscrypt registered machine # [ 1.149968] Key type fscrypt-provisioning registered machine # [ 1.150074] ima: No TPM chip found, activating TPM-bypass! machine # [ 1.150092] ima: Allocated hash algorithm: sha1 machine # [ 1.150115] ima: No architecture policies found machine # [ 1.150932] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 1.175973] clk: Disabling unused clocks machine # [ 1.175993] PM: genpd: Disabling unused power domains machine # [ 1.179068] Freeing unused kernel memory: 4736K machine # [ 1.179271] Run /init as init process machine # [ 1.198826] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.199326] systemd[1]: systemd 263-889bc48 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 1.199342] systemd[1]: Detected virtualization qemu. machine # [ 1.199384] systemd[1]: Detected architecture arm64. machine # [ 1.199389] systemd[1]: Running in initrd. machine # [ 1.206741] systemd[1]: Initializing machine ID from random generator. machine # [ 1.206878] systemd[1]: Hostname set to . machine # [ 1.309451] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.367737] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.373318] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.379118] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.379322] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.379352] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.379374] systemd[1]: Reached target Path Units. machine # [ 1.379387] systemd[1]: Reached target Slice Units. machine # [ 1.379403] systemd[1]: Reached target Swaps. machine # [ 1.379418] systemd[1]: Reached target Timer Units. machine # [ 1.379569] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.386003] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.386164] systemd[1]: Listening on Journal Sockets. machine # [ 1.386250] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.386266] systemd[1]: Reached target Socket Units. machine # [ 1.391871] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.391954] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.399901] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.410074] systemd[1]: Starting Journal Service... machine # [ 1.424091] systemd[1]: Starting Load Kernel Modules... machine # [ 1.424215] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.455889] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.464409] systemd-journald[71]: Collecting audit messages is disabled. machine # [ 1.470753] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.504398] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.505129] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.545137] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1 machine # [ 1.561247] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.565527] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.572564] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.577101] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.587964] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0 machine # [ 1.588214] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.588217] [drm] features: -context_init machine # [ 1.589002] [drm] number of scanouts: 1 machine # [ 1.589013] [drm] number of cap sets: 0 machine # [ 1.608102] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic machine # [ 1.608119] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0 machine # [ 1.639979] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0 machine # [ 1.640526] Console: switching to colour frame buffer device 160x50 machine # [ 1.651056] systemd[1]: Started Journal Service. machine # [ 1.636559] systemd-modules-load[73]: Inserted module 'dm_mod' machine # [ 1.640387] systemd-modules-load[73]: Module 'virtio_balloon' is built in machine # [ 1.661599] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.648503] systemd-modules-load[73]: Module 'virtio_console' is built in machine # [ 1.652863] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.655162] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.661815] systemd[1]: Reached target Local File Systems. machine # [ 1.662904] systemd[1]: Starting Create System Files and Directories... machine # [ 1.663946] systemd-modules-load[73]: Inserted module 'virtio_gpu' machine # [ 1.675469] systemd-modules-load[73]: Module 'virtio_rng' is built in machine # [ 1.676637] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.678003] systemd[1]: Finished Load Kernel Modules. machine # [ 1.708619] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.743173] systemd[1]: Finished Create System Files and Directories.[ 1.759987] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # machine # [ 1.761976] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.781534] systemd-udevd[79]: Using default interface naming scheme 'v261'. machine # [ 1.820115] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.895484] systemd[1]: Starting Virtual Console Setup... machine # [ 1.926994] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 machine # [ 1.927294] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0 machine # [ 1.994619] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.004466] systemd[1]: Finished Virtual Console Setup. machine # [ 2.715227] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.716285] systemd[1]: Reached target System Initialization. machine # [ 2.717153] systemd[1]: Reached target Basic System. machine # [ 2.923342] (udev-worker)[90]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.928209] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.988995] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.995481] systemd[1]: Reached target Initrd Root Device. machine # [ 3.001886] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 3.058656] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 3.067300] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 3.069243] systemd[1]: Mounting /sysroot... machine # [ 3.128934] EXT4-fs (vda): mounted filesystem e5fb7b1c-1358-44cd-adf4-7e178c357316 r/w with ordered data mode. Quota mode: none. machine # [ 3.115028] systemd[1]: Mounted /sysroot. machine # [ 3.117042] systemd[1]: Reached target Initrd Root File System. machine # [ 3.123373] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 3.152492] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 3.161661] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 3.164921] systemd[1]: Reloading... machine # [ 3.379792] systemd[1]: Reloading finished in 214 ms. machine # [ 3.412266] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace... machine # [ 3.417129] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace... machine # [ 3.427344] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.430591] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.432795] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.448262] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.453105] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.460194] systemd[1]: Mounting /sysroot/run... machine # [ 3.480338] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.516416] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.598920] fuse: init (API version 7.45) machine # [ 3.616400] virtiofs virtio6: discovered new tag: nix-store machine # [ 3.617257] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 3.610649] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.633358] virtiofs virtio7: discovered new tag: shared machine # [ 3.634212] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 3.620606] systemd[1]: Mounted /sysroot/run. machine # [ 3.644311] virtiofs virtio8: discovered new tag: xchg machine # [ 3.645163] virtiofs virtio8: virtio_fs_setup_dax: No cache capability machine # [ 3.653442] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.656878] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.658669] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.662970] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.695816] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.699072] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.701912] systemd[1]: Mounting /sysroot/nix/store... machine # [ 3.753344] systemd[1]: Mounted /sysroot/nix/store. machine # [ 3.755656] systemd[1]: Reached target Initrd File Systems. machine # [ 3.758002] systemd[1]: Starting Find NixOS closure... machine # [ 3.766583] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 3.814682] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 3.825950] systemd[1]: Finished Find NixOS closure. machine # [ 3.829099] systemd[1]: Reached target Initrd Default Target. machine # [ 3.834475] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 3.875876] systemd[1]: Stopped target Initrd Default Target. machine # [ 3.878976] systemd[1]: Stopped target Basic System. machine # [ 3.885073] systemd[1]: Stopped target Initrd Root Device. machine # [ 3.887041] systemd[1]: Stopped target Path Units. machine # [ 3.887839] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 3.891985] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 3.895126] systemd[1]: Stopped target Slice Units. machine # [ 3.901965] systemd[1]: Stopped target Socket Units. machine # [ 3.902954] systemd[1]: Stopped target System Initialization. machine # [ 3.904866] systemd[1]: Stopped target Swaps. machine # [ 3.908756] systemd[1]: Stopped target Timer Units. machine # [ 3.912276] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 3.915563] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 3.918637] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 3.919837] systemd[1]: Stopped Find NixOS closure. machine # [ 3.925892] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.926921] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 3.927931] systemd[1]: Stopped Apply Kernel Variables. machine # [ 3.934172] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 3.940918] systemd[1]: Stopped Load Kernel Modules. machine # [ 3.942292] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 3.943538] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 3.952380] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 3.953593] systemd[1]: Stopped Create System Files and Directories. machine # [ 3.954943] systemd[1]: Stopped target Local File Systems. machine # [ 3.960009] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 3.964561] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 3.968356] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 3.969624] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 3.973755] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 3.975003] systemd[1]: Stopped Virtual Console Setup. machine # [ 3.975782] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 3.976949] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 3.977939] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.979022] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.983611] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 3.987090] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 3.988310] systemd[1]: systemd-udevd.service: Consumed 1.044s CPU time over 2.324s wall clock time, 18.4M memory peak. machine # [ 3.992535] systemd[1]: Starting Cleanup udev Database... machine # [ 3.993512] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 3.996374] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 3.999588] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.001247] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.002432] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.003457] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.035703] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.038304] systemd[1]: Finished Cleanup udev Database. machine # [ 4.042784] systemd[1]: Reached target Switch Root. machine # [ 4.044421] systemd[1]: Starting NixOS Activation... machine # [ 4.133223] initrd-nixos-activation-start[168]: booting system configuration /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test machine # [ 4.169690] initrd-nixos-activation-start[168]: running activation script... machine # [ 4.423671] initrd-nixos-activation-start[191]: setting up /etc... machine # [ 4.557658] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 4.560238] systemd[1]: Finished NixOS Activation. machine # [ 4.562565] systemd[1]: Starting Switch Root... machine # [ 4.590470] systemd[1]: Switching root. machine # [ 4.777510] systemd-journald[71]: Received SIGTERM from PID 1 (systemd). machine # [ 4.925485] systemd[1]: systemd 263-889bc48 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 4.926644] systemd[1]: Detected virtualization qemu. machine # [ 4.926691] systemd[1]: Detected architecture arm64. machine # [ 4.926766] systemd[1]: Detected first boot. machine # [ 4.935133] systemd[1]: Initializing machine ID from random generator. machine # [ 5.075516] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 5.225964] systemd[1]: Applying preset policy. machine # [ 5.440052] systemd[1]: Populated /etc with preset unit settings. machine # [ 5.646334] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 5.647245] systemd[1]: Stopped initrd-switch-root.service. machine # [ 5.652610] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 5.654506] systemd[1]: Created slice Slice /system/getty. machine # [ 5.658191] systemd[1]: Created slice User and Session Slice. machine # [ 5.658842] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 5.662136] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 5.662613] systemd[1]: Expecting device /dev/hvc0... machine # [ 5.663311] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 5.667024] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 5.667490] systemd[1]: Stopped target initrd-fs.target. machine # [ 5.670436] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 5.670884] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 5.671602] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 5.675278] systemd[1]: Reached target Path Units. machine # [ 5.677259] systemd[1]: Reached target Remote File Systems. machine # [ 5.677691] systemd[1]: Reached target Slice Units. machine # [ 5.678503] systemd[1]: Reached target Swaps. machine # [ 5.682723] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 5.686315] systemd[1]: Listening on Process Core Dump Socket. machine # [ 5.688699] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 5.690093] systemd[1]: Listening on Factory Reset Management. machine # [ 5.690645] systemd[1]: Listening on Hostname Service Socket. machine # [ 5.697008] systemd[1]: Starting Journal Log Access Socket... machine # [ 5.698899] systemd[1]: Listening on Journal Audit Socket. machine # [ 5.703401] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 5.705617] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 5.707004] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.711407] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 5.717093] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 5.717745] systemd[1]: Listening on udev Varlink Socket. machine # [ 5.723667] systemd[1]: Mounting Huge Pages File System... machine # [ 5.729178] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 5.747921] systemd[1]: Mounting Kernel Debug File System... machine # [ 5.754202] systemd[1]: Mounting Kernel Trace File System... machine # [ 5.774037] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 5.782321] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 5.808748] systemd[1]: Mounting Kernel Configuration File System... machine # [ 5.809429] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 5.820588] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 5.821188] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 5.841047] systemd[1]: Mounting FUSE Control File System... machine # [ 5.843516] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 5.877121] systemd[1]: Starting Journal Service... machine # [ 5.896745] systemd[1]: Starting Load Kernel Modules... machine # [ 5.911229] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 5.938326] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 5.938758] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.977600] systemd[1]: Starting Coldplug All udev Devices... machine # [ 5.987579] systemd[1]: Listening on Journal Log Access Socket. machine # [ 5.999123] systemd[1]: Mounted Huge Pages File System. machine # [ 6.004818] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 6.005496] systemd[1]: Mounted Kernel Debug File System. machine # [ 6.006103] systemd[1]: Mounted Kernel Trace File System. machine # [ 6.016439] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 6.020020] systemd-journald[263]: Collecting audit messages is enabled. machine # [ 6.017501] systemd[1]: Queued start job for default target Multi-User System. machine # [ 6.019236] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 6.048709] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 6.049462] systemd[1]: Started Journal Service. machine # [ 6.035869] systemd-modules-load[264]: Module 'atkbd' is built in machine # [ 6.047119] systemd-modules-load[264]: Module 'loop' is built in machine # [ 6.065913] systemd[1]: Finished Load Kernel Modules. machine # [ 6.095868] EXT4-fs (vda): re-mounted e5fb7b1c-1358-44cd-adf4-7e178c357316. machine # [ 6.105585] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 6.112647] systemd-oomd[265]: No swap; memory pressure usage will be degraded machine # [ 6.124932] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 6.132398] systemd[1]: Mounted Kernel Configuration File System. machine # [ 6.133502] systemd[1]: Mounted FUSE Control File System. machine # [ 6.142600] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 6.150851] systemd[1]: Starting Firewall... machine # [ 6.158649] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 6.159789] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 6.169788] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 6.182426] systemd[1]: Starting Apply Kernel Variables... machine # [ 6.183450] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.314148] systemd-journald[263]: Received client request to flush runtime journal. machine # [ 6.453445] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 6.455106] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 6.462325] systemd[1]: Finished Apply Kernel Variables. machine # [ 6.463244] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 6.476378] systemd[1]: Reached target First Boot Complete. machine # [ 6.477346] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 6.594676] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 6.595865] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 6.600716] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 6.639304] systemd[1]: Mounting /run/wrappers... machine # [ 6.724596] systemd[1]: Mounted /run/wrappers. machine # [ 6.725782] systemd[1]: Reached target Local File Systems. machine # [ 6.734462] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 6.746906] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 6.747963] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 6.756512] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 6.768206] systemd[1]: Starting Create System Files and Directories... machine # [ 7.056557] systemd[1]: Finished Create System Files and Directories. machine # [ 7.072333] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 7.079879] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 7.227957] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 7.249030] systemd-udevd[302]: Using default interface naming scheme 'v261'. machine # [ 7.250512] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 7.290464] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 7.307926] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 7.328295] systemd[1]: Starting Update is Completed... machine # [ 7.427259] systemd[1]: Finished Update is Completed. machine # [ 7.448164] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 8.061207] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 8.072227] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 8.156974] systemd[1]: Finished Coldplug All udev Devices. machine # [ 8.159379] systemd[1]: Reached target System Initialization. machine # [ 8.166521] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 8.167691] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 8.172937] systemd[1]: Reached target Timer Units. machine # [ 8.173775] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 8.174802] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 8.183336] systemd[1]: Reached target Socket Units. machine # [ 8.186979] systemd[1]: Reached target Basic System. machine # [ 8.187830] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 8.195811] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 8.198097] systemd[1]: Starting Post-Boot Actions... machine # [ 8.215014] systemd[1]: Started Reset console on configuration changes. machine # [ 8.242566] systemd[1]: Starting resolvconf update... machine # [ 8.332192] systemd[1]: Starting D-Bus System Message Bus... machine # [ 8.408641] nsncd[420]: Oct 01 03:46:19.817 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 8.429279] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 8.430434] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 8.431397] systemd[1]: Reached target User and Group Name Lookups. machine # [ 8.467059] systemd[1]: Starting User Login Management... machine # [ 8.508530] systemd[1]: Finished Post-Boot Actions. machine # [ 8.547548] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 8.640579] dbus-broker-launch[429]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 8.648367] dbus-broker-launch[429]: NSS returned no entry for 'systemd-timesync' machine # [ 8.649601] dbus-broker-launch[429]: Invalid user-name in /nix/store/r21qlc763yx2sp1lnrvn2wkyx9l5bgx1-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 8.708179] systemd[1]: Started D-Bus System Message Bus. machine # [ 8.754427] systemd-logind[445]: New seat seat0. machine # [ 8.764480] systemd[1]: Started User Login Management. machine # [ 8.772783] dbus-broker-launch[429]: Ready machine # [ 8.779236] systemd[1]: Starting linger-users.service... machine # [ 8.855933] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 8.866137] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 8.867443] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 8.871660] systemd[1]: Stopping User and Group Name Lookups... machine # [ 8.875673] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 8.880631] systemd[1]: nscd.service: Deactivated successfully. machine # [ 8.881611] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 8.932331] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 8.982250] systemd[1]: Created slice Slice /user/1001. machine # [ 9.008429] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 9.059962] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 9.070998] nsncd[510]: Oct 01 03:46:20.471 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 9.087763] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 9.093542] systemd[1]: Finished linger-users.service. machine # [ 9.094474] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 9.095461] systemd[1]: Reached target User and Group Name Lookups. machine # [ 9.157569] systemd[1]: Finished resolvconf update. machine # [ 9.162527] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 9.183943] systemd[1]: Starting DHCP Client... machine # [ 9.225807] systemd[1]: Starting User Manager for UID 1001... machine # [ 9.389684] (systemd)[550]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 9.429021] systemd-logind[445]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 9.492605] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 9.817111] systemd[550]: Queued start job for default target Main User Target. machine # [ 9.851898] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 9.894873] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3 machine # [ 9.905386] systemd[550]: Created slice User Application Slice. machine # [ 9.906702] systemd[550]: Started Daily Cleanup of User's Temporary Directories. machine # [ 9.907851] systemd[550]: Reached target Paths. machine # [ 9.961001] systemd[550]: Reached target Timers. machine # [ 9.976428] systemd[550]: Starting D-Bus User Message Bus Socket... machine # [ 9.990414] systemd[550]: Starting Create User Files and Directories... machine # [ 10.012247] systemd[550]: Finished Create User Files and Directories. machine # [ 10.029062] systemd[550]: Listening on D-Bus User Message Bus Socket. machine # [ 10.040794] systemd[550]: Reached target Sockets. machine # [ 10.055120] systemd[550]: Reached target Basic System. machine # [ 10.070123] systemd[1]: Started User Manager for UID 1001. machine # [ 10.088912] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 10.100932] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 10.118813] systemd[550]: Reached target Main User Target. machine # [ 10.140344] systemd[550]: Startup finished in 453ms. machine # [ 10.297872] systemd[1]: Finished Firewall. machine # [ 10.301187] systemd[1]: Reached target Preparation for Network. machine # [ 10.305656] systemd[1]: Starting Extra networking commands.... machine # [ 10.323241] dhcpcd[568]: dhcpcd-10.3.2 starting machine # [ 10.336995] dhcpcd[589]: dev: loaded udev machine # [ 10.344095] dhcpcd[589]: no valid interfaces found machine # [ 10.349684] dhcpcd[589]: no valid interfaces found machine # [ 10.505051] systemd[1]: Starting Virtual Console Setup... machine # [ 10.532510] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 10.720174] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 10.753537] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 10.777293] systemd[1]: Started backdoor.service. machine # [ 10.877443] 8021q: 802.1Q VLAN Support v1.8 machine # [ 10.915441] (udev-worker)[590]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.[ 11.001151] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # machine # [ 10.989859] (udev-worker)[590]: Network interface NamePolicy= disabled on kernel command line. machine # [ 11.083509] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 11.085126] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 11.089224] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 11.089601] cfg80211: failed to load regulatory.db machine # [ 11.269343] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 11.298604] systemd-logind[445]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # [ 11.337833] systemd[1]: Starting Address configuration of eth1... machine # connecting to host... machine # [ 11.462852] mousedev: PS/2 mouse device common for all mice machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 13.41 seconds) machine: (finished: waiting for the VM to finish booting, in 13.84 seconds) machine # [ 11.528317] dhcpcd[659]: /nix/store/92w4pf1lqszlcwfq9ma2y2vaad5dssks-openresolv-3.17.4/sbin/.resolvconf-wrapped: line 1250: kill: (603) - Operation not permitted machine # [ 11.530497] dhcpcd[659]: .resolvconf-wrapped: clearing stale lock pid 603 machine # [ 11.664146] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 11.667446] systemd[1]: Finished Extra networking commands.. machine # [ 11.685802] systemd[1]: Reached target Network. machine # [ 11.686654] systemd[1]: Starting Permit User Sessions... machine # [ 11.779806] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 11.767567] systemd-logind[445]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 11.796765] network-addresses-eth1-start[645]: adding address 192.168.1.1/24... done machine # [ 11.798305] dhcpcd[589]: eth0: waiting for carrier machine # [ 11.799176] dhcpcd[589]: eth0: carrier acquired machine # [ 11.904426] network-addresses-eth1-start[645]: adding address 2001:db8:1::1/64... done machine # [ 11.928894] dhcpcd[589]: DUID 00:01:00:01:32:50:94:0f:52:54:00:12:34:56 machine # [ 11.930055] dhcpcd[589]: eth0: IAID 00:12:34:56 machine # [ 11.930908] dhcpcd[589]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 12.040712] systemd[1]: Finished Permit User Sessions. machine # [ 12.041663] systemd[1]: Started Getty on tty1. machine # [ 12.042560] systemd[1]: Reached target Login Prompts. machine # [ 12.088648] systemd[1]: Finished Address configuration of eth1. machine # [ 12.103723] systemd-vconsole-setup[604]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 12.131821] systemd[1]: Finished Virtual Console Setup. machine # [ 12.648260] dhcpcd[589]: eth0: soliciting a DHCP lease machine # [ 12.668911] dhcpcd[589]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 12.669959] dhcpcd[589]: eth0: probing address 10.0.2.15/24 machine # [ 13.056478] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 13.057787] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 13.058982] systemd[1]: Stopped Virtual Console Setup. machine # [ 13.095370] systemd[1]: Stopping Virtual Console Setup... machine # [ 13.100889] systemd[1]: Starting Virtual Console Setup... machine # [ 13.115104] systemd-logind[445]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 13.122667] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 13.123829] systemd[1]: Stopped Virtual Console Setup. machine # [ 13.128378] systemd[1]: Starting Virtual Console Setup... machine # [ 13.284424] systemd-vconsole-setup[707]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 13.292231] systemd[1]: Finished Virtual Console Setup. machine # [ 14.489489] dhcpcd[589]: eth0: soliciting an IPv6 router machine # [ 14.491766] dhcpcd[589]: eth0: Router Advertisement from fe80::2 machine # [ 14.493490] dhcpcd[589]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 14.495068] dhcpcd[589]: eth0: adding route to fec0::/64 machine # [ 14.496531] dhcpcd[589]: eth0: adding default route via fe80::2 machine # [ 17.694788] dhcpcd[589]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 17.697829] dhcpcd[589]: eth0: adding route to 10.0.2.0/24 machine # [ 17.699201] dhcpcd[589]: eth0: adding default route via 10.0.2.2 machine # [ 17.807761] systemd[1]: Started DHCP Client. machine # [ 17.810581] systemd[1]: Reached target Multi-User System. machine # [ 17.811459] systemd[1]: Startup finished in 1.166s (kernel) + 3.666s (initrd) + 12.977s (userspace) = 17.809s. machine: (finished: waiting for unit multi-user.target, in 20.99 seconds) machine: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 18.863809] nixos[824]: switching to system configuration /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test machine # [ 18.866936] systemd[1]: Stopped target Local File Systems. machine # [ 18.869050] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # setting up /etc... machine # [ 19.192800] systemd[1]: Reload requested from client PID 824 ('.switch-to-conf') (unit backdoor.service)... machine # [ 19.194598] systemd[1]: Reloading... machine # [ 19.529744] systemd[1]: Reloading finished in 333 ms. machine # reloading user units for usertest... machine # [ 19.586529] systemd[550]: Created slice User Core Session Slice. machine # [ 19.588985] systemd[550]: Starting D-Bus User Message Bus... machine # [ 19.620768] dbus-broker-launch[894]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/r21qlc763yx2sp1lnrvn2wkyx9l5bgx1-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 19.623973] dbus-broker-launch[894]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/r21qlc763yx2sp1lnrvn2wkyx9l5bgx1-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 19.627117] dbus-broker-launch[894]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/r21qlc763yx2sp1lnrvn2wkyx9l5bgx1-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 19.630287] dbus-broker-launch[894]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/r21qlc763yx2sp1lnrvn2wkyx9l5bgx1-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 19.635071] dbus-broker-launch[894]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 19.638024] dbus-broker-launch[894]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 19.639792] systemd[550]: Started D-Bus User Message Bus. machine # [ 19.644110] dbus-broker-launch[894]: Ready machine # [ 19.688138] systemd[550]: Reexecution requested from client PID 893 ('switch-to-confi')... machine # [ 19.692247] systemd[550]: Reexecuting. machine # [ 19.747771] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.860856] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.868082] systemd[550]: Reload requested from client PID 893 ('switch-to-confi')... machine # [ 19.869458] systemd[550]: Reloading... machine # [ 19.979716] systemd[550]: Reloading finished in 108 ms. machine # [ 19.996223] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 20.008114] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 20.011887] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 20.014667] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 20.049122] systemd[550]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 20.061933] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 20.152282] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 20.153605] systemd[1]: Reached target Reactivate sysinit units. machine # [ 20.159639] systemd[1]: Reached target Remote File Systems. machine # [ 20.164842] systemd[1]: Starting linger-users.service... machine # [ 20.172575] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.174066] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 20.179944] systemd[1]: Reached target Local File Systems. machine # [ 20.181542] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 20.189644] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 20.190709] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 20.201972] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 20.210960] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 20.214838] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.217788] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.256481] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 20.258481] systemd[1]: Finished linger-users.service. machine # [ 20.418413] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 20.420469] systemd[1]: Finished Create SUID/SGID Wrappers. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 20.679799] nixos[824]: finished switching to system configuration /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/bin/switch-to-configuration test, in 2.04 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.03 seconds) machine: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/lhyz1cqawdrp86fih2gasi7wyafp6sqs-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/lhyz1cqawdrp86fih2gasi7wyafp6sqs-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 20.944573] nixos[971]: switching to system configuration /nix/store/lhyz1cqawdrp86fih2gasi7wyafp6sqs-nixos-system-other-test machine # [ 20.947223] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # [ 20.950120] systemd[1]: Stopped target Local File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 21.283405] systemd[1]: Reload requested from client PID 971 ('.switch-to-conf') (unit backdoor.service)... machine # [ 21.285601] systemd[1]: Reloading... machine # [ 21.616907] systemd[1]: Reloading finished in 329 ms. machine # reloading user units for usertest... machine # [ 21.707592] systemd[550]: Reexecution requested from client PID 1043 ('switch-to-confi')... machine # [ 21.710499] systemd[550]: Reexecuting. machine # [ 21.768578] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.885748] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.892671] systemd[550]: Reload requested from client PID 1043 ('switch-to-confi')... machine # [ 21.895219] systemd[550]: Reloading... machine # [ 22.003223] systemd[550]: Reloading finished in 106 ms. machine # [ 22.020239] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 22.031671] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 22.034382] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 22.036871] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 22.069625] systemd[550]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 22.074600] systemd[1]: Stopped target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service machine # [ 22.078554] systemd[1]: Stopping Reactivate sysinit units... machine # [ 22.079485] systemd[1]: Reached target Reactivate sysinit units. machine # [ 22.082640] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 22.084800] dbus-broker-launch[429]: Caught SIGHUP, trigger reload. machine # [ 22.089195] dbus-broker-launch[429]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 22.091440] dbus-broker-launch[429]: NSS returned no entry for 'systemd-timesync' machine # [ 22.092831] dbus-broker-launch[429]: Invalid user-name in /nix/store/bazmz3pkgsxs31n9mf1a0bzwvrdy5sq6-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 22.109821] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 22.116921] systemd[1]: Stopping Address configuration of eth1... machine # [ 22.148329] network-addresses-eth1-pre-stop[1055]: deleting address 192.168.1.1/24... done machine # [ 22.155049] network-addresses-eth1-pre-stop[1055]: deleting address 2001:db8:1::1/64... done machine # [ 22.162313] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 22.165386] systemd[1]: Stopped Address configuration of eth1. machine # [ 22.170274] systemd[1]: Starting Address configuration of eth1... machine # [ 22.216513] network-addresses-eth1-start[1060]: adding address 192.168.1.2/24... done machine # [ 22.223928] network-addresses-eth1-start[1060]: adding address 2001:db8:1::2/64... done machine # [ 22.233763] systemd[1]: Finished Address configuration of eth1. machine # [ 22.239696] systemd[1]: Reached target Local File Systems. machine # [ 22.244777] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 22.252749] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 22.253819] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 22.255137] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 22.265337] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 22.267201] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.273400] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.274895] systemd[1]: Reached target Remote File Systems. machine # [ 22.278119] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.281068] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 22.455939] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 22.460318] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 22.463660] systemd[1]: Starting linger-users.service... machine # [ 22.494464] linger-users-start[1132]: id: ‘usertest’: no such user machine # [ 22.496573] linger-users-start[1130]: Removing linger for missing user usertest machine # [ 22.503279] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 22.506243] systemd[1]: Finished linger-users.service. machine # [ 22.761922] nixos[971]: finished switching to system configuration /nix/store/lhyz1cqawdrp86fih2gasi7wyafp6sqs-nixos-system-other-test machine: (finished: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/lhyz1cqawdrp86fih2gasi7wyafp6sqs-nixos-system-other-test/bin/switch-to-configuration test, in 2.05 seconds) subtest: services machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 22.982818] nixos[1138]: switching to system configuration /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test machine # [ 22.985425] systemd[1]: Stopped target Local File Systems. machine # [ 22.988517] systemd[1]: Stopped target Remote File Systems. machine # [ 23.286524] systemd[1]: Reload requested from client PID 1138 ('.switch-to-conf') (unit backdoor.service)... machine # [ 23.288723] systemd[1]: Reloading... machine # [ 23.618684] systemd[1]: Reloading finished in 328 ms. machine # [ 23.704609] systemd[550]: Reexecution requested from client PID 1207 ('switch-to-confi')... machine # [ 23.708977] systemd[550]: Reexecuting. machine # [ 23.767950] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.888337] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.895841] systemd[550]: Reload requested from client PID 1207 ('switch-to-confi')... machine # [ 23.899898] systemd[550]: Reloading... machine # [ 24.010300] systemd[550]: Reloading finished in 111 ms. machine # [ 24.024197] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.034907] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 24.037393] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 24.039638] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 24.072329] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 24.076669] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 24.077699] systemd[1]: Stopping Reactivate sysinit units... machine # [ 24.081867] systemd[1]: Reached target Reactivate sysinit units. machine # [ 24.083950] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 24.085444] dbus-broker-launch[429]: Caught SIGHUP, trigger reload. machine # [ 24.088837] dbus-broker-launch[429]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 24.091064] dbus-broker-launch[429]: NSS returned no entry for 'systemd-timesync' machine # [ 24.092371] dbus-broker-launch[429]: Invalid user-name in /nix/store/r21qlc763yx2sp1lnrvn2wkyx9l5bgx1-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 24.109907] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 24.115575] systemd[1]: Stopping Address configuration of eth1... machine # [ 24.147917] network-addresses-eth1-pre-stop[1219]: deleting address 192.168.1.2/24... done machine # [ 24.154350] network-addresses-eth1-pre-stop[1219]: deleting address 2001:db8:1::2/64... done machine # [ 24.161102] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 24.163466] systemd[1]: Stopped Address configuration of eth1. machine # [ 24.167935] systemd[1]: Starting Address configuration of eth1... machine # [ 24.210205] network-addresses-eth1-start[1224]: adding address 192.168.1.1/24... done machine # [ 24.217659] network-addresses-eth1-start[1224]: adding address 2001:db8:1::1/64... done machine # [ 24.227252] systemd[1]: Finished Address configuration of eth1. machine # [ 24.230422] systemd[1]: Reached target Local File Systems. machine # [ 24.233560] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.238350] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 24.239772] systemd[1]: Reached target Remote File Systems. machine # [ 24.246912] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 24.254309] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 24.255252] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 24.260657] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 24.263000] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 24.266637] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.267988] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.464311] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 24.466269] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 24.472255] systemd[1]: Starting linger-users.service... machine # [ 24.507588] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 24.509534] systemd[1]: Finished linger-users.service. machine # [ 24.766000] nixos[1138]: finished switching to system configuration /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.00 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 24.992134] nixos[1294]: switching to system configuration /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test machine # [ 24.995354] systemd[1]: Stopped target Local File Systems. machine # [ 24.998762] systemd[1]: Stopped target Remote File Systems. machine # [ 25.296297] systemd[1]: Reload requested from client PID 1294 ('.switch-to-conf') (unit backdoor.service)... machine # [ 25.298490] systemd[1]: Reloading... machine # [ 25.622376] systemd[1]: Reloading finished in 322 ms. machine # [ 25.712433] systemd[550]: Reexecution requested from client PID 1363 ('switch-to-confi')... machine # [ 25.715743] systemd[550]: Reexecuting. machine # [ 25.775904] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.889000] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.896279] systemd[550]: Reload requested from client PID 1363 ('switch-to-confi')... machine # [ 25.900728] systemd[550]: Reloading... machine # [ 26.005565] systemd[550]: Reloading finished in 106 ms. machine # [ 26.020190] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.031498] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 26.033958] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 26.036431] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 26.067981] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 26.072794] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 26.073785] systemd[1]: Stopping Reactivate sysinit units... machine # [ 26.074732] systemd[1]: Reached target Reactivate sysinit units. machine # [ 26.078090] systemd[1]: Reached target Remote File Systems. machine # [ 26.082019] systemd[1]: Starting linger-users.service... machine # [ 26.086319] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.087755] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 26.094577] systemd[1]: Reached target Local File Systems. machine # [ 26.095401] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 26.104543] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 26.105457] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 26.106853] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 26.119629] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 26.122536] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.123938] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.179969] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 26.182890] systemd[1]: Finished linger-users.service. machine # [ 26.311713] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 26.314835] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 26.570816] nixos[1294]: finished switching to system configuration /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.80 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 26.789651] nixos[1434]: switching to system configuration /nix/store/yqy05d2nkby18liz87hjgdfqmzikdmxw-nixos-system-machine-test machine # [ 26.792623] systemd[1]: Stopped target Remote File Systems. machine # [ 26.794328] systemd[1]: Stopped target Local File Systems. machine # [ 27.077051] systemd[1]: Reload requested from client PID 1434 ('.switch-to-conf') (unit backdoor.service)... machine # [ 27.079068] systemd[1]: Reloading... machine # [ 27.398543] systemd[1]: Reloading finished in 318 ms. machine # [ 27.484277] systemd[550]: Reexecution requested from client PID 1503 ('switch-to-confi')... machine # [ 27.488551] systemd[550]: Reexecuting. machine # [ 27.543365] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.690235] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.696858] systemd[550]: Reload requested from client PID 1503 ('switch-to-confi')... machine # [ 27.699320] systemd[550]: Reloading... machine # [ 27.805731] systemd[550]: Reloading finished in 105 ms. machine # [ 27.820183] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.831647] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 27.834174] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 27.836325] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 27.868086] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 27.871958] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 27.875278] systemd[1]: Stopping Reactivate sysinit units... machine # [ 27.877063] systemd[1]: Reached target Reactivate sysinit units. machine # [ 27.877965] systemd[1]: Reached target Local File Systems. machine # [ 27.885300] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 27.894521] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 27.895563] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 27.902540] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 27.907146] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 27.908962] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.910268] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.911487] systemd[1]: Reached target Remote File Systems. machine # [ 27.913002] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.914428] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 28.065228] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 28.070354] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 28.073798] systemd[1]: Starting linger-users.service... machine # [ 28.077465] systemd[1]: Starting test.service... machine # [ 28.116308] systemd[1]: Finished test.service. machine # [ 28.134818] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 28.136868] systemd[1]: Finished linger-users.service. machine # [ 28.394167] nixos[1434]: finished switching to system configuration /nix/store/yqy05d2nkby18liz87hjgdfqmzikdmxw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.82 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 28.598387] nixos[1577]: switching to system configuration /nix/store/yqy05d2nkby18liz87hjgdfqmzikdmxw-nixos-system-machine-test machine # [ 28.600968] systemd[1]: Stopped target Local File Systems. machine # [ 28.603759] systemd[1]: Stopped target Remote File Systems. machine # [ 28.868003] systemd[1]: Reload requested from client PID 1577 ('.switch-to-conf') (unit backdoor.service)... machine # [ 28.870076] systemd[1]: Reloading... machine # [ 29.184410] systemd[1]: Reloading finished in 312 ms. machine # [ 29.268068] systemd[550]: Reexecution requested from client PID 1646 ('switch-to-confi')... machine # [ 29.269512] systemd[550]: Reexecuting. machine # [ 29.327659] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.439411] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.446061] systemd[550]: Reload requested from client PID 1646 ('switch-to-confi')... machine # [ 29.449703] systemd[550]: Reloading... machine # [ 29.555165] systemd[550]: Reloading finished in 106 ms. machine # [ 29.572183] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.581739] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 29.584124] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 29.586355] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 29.614763] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 29.618726] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 29.621691] systemd[1]: Stopping Reactivate sysinit units... machine # [ 29.622650] systemd[1]: Reached target Reactivate sysinit units. machine # [ 29.623509] systemd[1]: Reached target Remote File Systems. machine # [ 29.629371] systemd[1]: Starting linger-users.service... machine # [ 29.632890] systemd[1]: Reached target Local File Systems. machine # [ 29.640074] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 29.646776] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 29.647680] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 29.655244] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 29.663447] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 29.668217] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.672920] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.679934] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.684228] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 29.718794] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 29.723552] systemd[1]: Finished linger-users.service. machine # [ 29.849909] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 29.853966] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 30.107787] nixos[1577]: finished switching to system configuration /nix/store/yqy05d2nkby18liz87hjgdfqmzikdmxw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.71 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 30.325575] nixos[1717]: switching to system configuration /nix/store/8j38pkacfxg7wcdcxrklsbw74ayshkv7-nixos-system-machine-test machine # [ 30.328393] systemd[1]: Stopped target Remote File Systems. machine # [ 30.330832] systemd[1]: Stopped target Local File Systems. machine # [ 30.604941] systemd[1]: Reload requested from client PID 1717 ('.switch-to-conf') (unit backdoor.service)... machine # [ 30.606909] systemd[1]: Reloading... machine # [ 31.017109] systemd[1]: Reloading finished in 408 ms. machine # [ 31.134419] systemd[550]: Reexecution requested from client PID 1786 ('switch-to-confi')... machine # [ 31.135864] systemd[550]: Reexecuting. machine # [ 31.182973] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.290360] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.297767] systemd[550]: Reload requested from client PID 1786 ('switch-to-confi')... machine # [ 31.301281] systemd[550]: Reloading... machine # [ 31.403986] systemd[550]: Reloading finished in 103 ms. machine # [ 31.420174] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.429574] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 31.431912] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 31.434194] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 31.467468] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 31.471779] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 31.477353] systemd[1]: Stopping Reactivate sysinit units... machine # [ 31.478271] systemd[1]: Reached target Reactivate sysinit units. machine # [ 31.479155] systemd[1]: Reached target Local File Systems. machine # [ 31.479946] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 31.484790] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 31.485727] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 31.487050] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 31.495893] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 31.501964] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.503320] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.510993] systemd[1]: Reached target Remote File Systems. machine # [ 31.512946] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.514971] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 31.660399] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 31.664466] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 31.667526] systemd[1]: Starting linger-users.service... machine # [ 31.707696] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 31.709519] systemd[1]: Finished linger-users.service. machine # [ 31.965755] nixos[1717]: finished switching to system configuration /nix/store/8j38pkacfxg7wcdcxrklsbw74ayshkv7-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 1.86 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 32.196594] nixos[1858]: switching to system configuration /nix/store/v9dgrzy7y8kapjwvi1fciij8nhxi3bky-nixos-system-machine-test machine # [ 32.199172] systemd[1]: Stopped target Remote File Systems. machine # [ 32.202927] systemd[1]: Stopped target Local File Systems. machine # [ 32.203787] systemd[1]: test.service: Deactivated successfully. machine # [ 32.205293] systemd[1]: Stopped Test unit. machine # [ 32.489671] systemd[1]: Reload requested from client PID 1858 ('.switch-to-conf') (unit backdoor.service)... machine # [ 32.491707] systemd[1]: Reloading... machine # [ 32.809645] systemd[1]: Reloading finished in 316 ms. machine # [ 32.892100] systemd[550]: Reexecution requested from client PID 1927 ('switch-to-confi')... machine # [ 32.896355] systemd[550]: Reexecuting. machine # [ 32.951673] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.062238] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.068520] systemd[550]: Reload requested from client PID 1927 ('switch-to-confi')... machine # [ 33.070910] systemd[550]: Reloading... machine # [ 33.174455] systemd[550]: Reloading finished in 102 ms. machine # [ 33.188171] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.197705] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 33.200050] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 33.202266] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 33.234428] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 33.238277] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 33.241043] systemd[1]: Stopping Reactivate sysinit units... machine # [ 33.246425] systemd[1]: Reached target Reactivate sysinit units. machine # [ 33.247348] systemd[1]: Reached target Remote File Systems. machine # [ 33.250748] systemd[1]: Starting linger-users.service... machine # [ 33.252920] systemd[1]: Starting test.service... machine # [ 33.257862] systemd[1]: Reached target Local File Systems. machine # [ 33.269243] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 33.270885] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 33.271723] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 33.285258] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 33.287480] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 33.297862] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.299358] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.311033] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.317867] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 33.331132] systemd[1]: Finished test.service. machine # [ 33.359950] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 33.363538] systemd[1]: Finished linger-users.service. machine # [ 33.485511] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 33.489241] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 33.743239] nixos[1858]: finished switching to system configuration /nix/store/v9dgrzy7y8kapjwvi1fciij8nhxi3bky-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.77 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 33.963091] nixos[2000]: switching to system configuration /nix/store/cbsymq7lb09snni660gz9vpbjxjplvzp-nixos-system-machine-test machine # [ 33.966024] systemd[1]: Stopped target Local File Systems. machine # [ 33.968339] systemd[1]: Stopped target Remote File Systems. machine # [ 34.243714] systemd[1]: Reload requested from client PID 2000 ('.switch-to-conf') (unit backdoor.service)... machine # [ 34.245850] systemd[1]: Reloading... machine # [ 34.570651] systemd[1]: Reloading finished in 323 ms. machine # [ 34.690874] systemd[550]: Reexecution requested from client PID 2069 ('switch-to-confi')... machine # [ 34.694954] systemd[550]: Reexecuting. machine # [ 34.751216] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.863361] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.870505] systemd[550]: Reload requested from client PID 2069 ('switch-to-confi')... machine # [ 34.871826] systemd[550]: Reloading... machine # [ 34.975156] systemd[550]: Reloading finished in 102 ms. machine # [ 34.989551] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.997519] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 34.999792] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 35.001938] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 35.030592] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 35.034309] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 35.038778] systemd[1]: Stopping Reactivate sysinit units... machine # [ 35.039671] systemd[1]: Reached target Reactivate sysinit units. machine # [ 35.040829] systemd[1]: test.service: Deactivated successfully. machine # [ 35.041656] systemd[1]: Stopped test.service. machine # [ 35.042375] systemd[1]: Stopping test.service... machine # [ 35.044000] systemd[1]: Starting test.service... machine # [ 35.067976] systemd[1]: Finished test.service. machine # [ 35.073697] systemd[1]: Reached target Local File Systems. machine # [ 35.078182] systemd[1]: Reached target Remote File Systems. machine # [ 35.081189] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 35.084336] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 35.085199] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 35.086518] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 35.097289] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 35.098979] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.103045] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.104423] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.105701] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 35.252747] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 35.256822] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 35.258871] systemd[1]: Starting linger-users.service... machine # [ 35.299207] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 35.301940] systemd[1]: Finished linger-users.service. machine # [ 35.557286] nixos[2000]: finished switching to system configuration /nix/store/cbsymq7lb09snni660gz9vpbjxjplvzp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 35.771862] nixos[2143]: switching to system configuration /nix/store/x41089kz91w512ybfcpnp4nny3bkf1xl-nixos-system-machine-test machine # [ 35.774480] systemd[1]: Stopped target Remote File Systems. machine # [ 35.776864] systemd[1]: Stopped target Local File Systems. machine # [ 36.050664] systemd[1]: Reload requested from client PID 2143 ('.switch-to-conf') (unit backdoor.service)... machine # [ 36.052751] systemd[1]: Reloading... machine # [ 36.365571] systemd[1]: Reloading finished in 311 ms. machine # [ 36.448414] systemd[550]: Reexecution requested from client PID 2212 ('switch-to-confi')... machine # [ 36.450248] systemd[550]: Reexecuting. machine # [ 36.511347] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.624876] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.631782] systemd[550]: Reload requested from client PID 2212 ('switch-to-confi')... machine # [ 36.634205] systemd[550]: Reloading... machine # [ 36.737000] systemd[550]: Reloading finished in 101 ms. machine # [ 36.752181] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.761862] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 36.764522] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 36.766480] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 36.800536] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 36.804111] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 36.808408] systemd[1]: Stopping Reactivate sysinit units... machine # [ 36.809335] systemd[1]: Reached target Reactivate sysinit units. machine # [ 36.811119] systemd[1]: Reloading test.service... machine # [ 36.836860] systemd[1]: Reloaded test.service. machine # [ 36.841119] systemd[1]: Reached target Remote File Systems. machine # [ 36.845303] systemd[1]: Starting linger-users.service... machine # [ 36.857783] systemd[1]: Reached target Local File Systems. machine # [ 36.859582] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 36.866324] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 36.867239] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 36.876903] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 36.879250] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 36.888249] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.889608] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.890898] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.900598] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 36.937124] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 36.940102] systemd[1]: Finished linger-users.service. machine # [ 37.068638] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 37.072411] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 37.327606] nixos[2143]: finished switching to system configuration /nix/store/x41089kz91w512ybfcpnp4nny3bkf1xl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 1.77 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 37.547212] nixos[2285]: switching to system configuration /nix/store/3gx66a8k8b55mc1w5735vb0aiykd2nqw-nixos-system-machine-test machine # [ 37.549753] systemd[1]: Stopped target Remote File Systems. machine # [ 37.552923] systemd[1]: Stopped target Local File Systems. machine # [ 37.884332] systemd[1]: Reload requested from client PID 2285 ('.switch-to-conf') (unit backdoor.service)... machine # [ 37.886396] systemd[1]: Reloading... machine # [ 38.200467] systemd[1]: Reloading finished in 312 ms. machine # [ 38.282322] systemd[550]: Reexecution requested from client PID 2355 ('switch-to-confi')... machine # [ 38.286075] systemd[550]: Reexecuting. machine # [ 38.343288] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.451891] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.459467] systemd[550]: Reload requested from client PID 2355 ('switch-to-confi')... machine # [ 38.462524] systemd[550]: Reloading... machine # [ 38.565078] systemd[550]: Reloading finished in 103 ms. machine # [ 38.580176] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.590205] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 38.592475] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 38.594600] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 38.627360] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 38.630996] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 38.632992] systemd[1]: Stopping Reactivate sysinit units... machine # [ 38.633885] systemd[1]: Reached target Reactivate sysinit units. machine # [ 38.639720] systemd[1]: Reached target Remote File Systems. machine # [ 38.642758] systemd[1]: Starting linger-users.service... machine # [ 38.654772] systemd[1]: Reached target Local File Systems. machine # [ 38.655735] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 38.662117] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 38.663008] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 38.675465] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 38.679715] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 38.687424] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.691111] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.694256] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.700372] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 38.731863] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 38.736604] systemd[1]: Finished linger-users.service. machine # [ 38.863411] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 38.866532] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 39.121754] nixos[2285]: finished switching to system configuration /nix/store/3gx66a8k8b55mc1w5735vb0aiykd2nqw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.79 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.29 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 39.588472] nixos[2436]: switching to system configuration /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test machine # [ 39.591312] systemd[1]: test.service: Deactivated successfully. machine # [ 39.595376] systemd[1]: Stopped test.service. machine # [ 39.596323] systemd[1]: Stopped target Remote File Systems. machine # [ 39.597148] systemd[1]: Stopped target Local File Systems. machine # [ 39.853601] systemd[1]: Reload requested from client PID 2436 ('.switch-to-conf') (unit backdoor.service)... machine # [ 39.855599] systemd[1]: Reloading... machine # [ 40.164296] systemd[1]: Reloading finished in 307 ms. machine # [ 40.250518] systemd[550]: Reexecution requested from client PID 2504 ('switch-to-confi')... machine # [ 40.251911] systemd[550]: Reexecuting. machine # [ 40.315432] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.427963] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.434721] systemd[550]: Reload requested from client PID 2504 ('switch-to-confi')... machine # [ 40.438248] systemd[550]: Reloading... machine # [ 40.540499] systemd[550]: Reloading finished in 103 ms. machine # [ 40.556161] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.565716] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 40.567940] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 40.570127] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 40.603502] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 40.607807] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 40.609293] systemd[1]: Stopping Reactivate sysinit units... machine # [ 40.610230] systemd[1]: Reached target Reactivate sysinit units. machine # [ 40.613613] systemd[1]: Reached target Local File Systems. machine # [ 40.617791] systemd[1]: Reached target Remote File Systems. machine # [ 40.622075] systemd[1]: Starting linger-users.service... machine # [ 40.631682] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 40.641300] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 40.642294] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 40.643533] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 40.650380] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 40.657675] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.659227] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.667042] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.672307] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 40.707869] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 40.709877] systemd[1]: Finished linger-users.service. machine # [ 40.835761] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 40.837800] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 41.093854] nixos[2436]: finished switching to system configuration /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.68 seconds) machine: must succeed: /nix/store/dy887fbf4wsw1bvb2j3csj73qrs59ryd-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 41.295178] nixos[2577]: switching to system configuration /nix/store/wlib51fxw0c635lglsya69rp1fcwdzh5-nixos-system-machine-test machine # [ 41.300279] systemd[1]: Stopped target Local File Systems. machine # [ 41.301160] systemd[1]: Stopped target Remote File Systems. machine # [ 41.570531] systemd[1]: Reload requested from client PID 2577 ('.switch-to-conf') (unit backdoor.service)... machine # [ 41.572705] systemd[1]: Reloading... machine # [ 41.870213] systemd[1]: Reloading finished in 296 ms. machine # [ 41.961730] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 41.965656] systemd[550]: Reexecution requested from client PID 2645 ('switch-to-confi')... machine # [ 41.967144] systemd[550]: Reexecuting. machine # [ 42.027259] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.139622] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.146290] systemd[550]: Reload requested from client PID 2645 ('switch-to-confi')... machine # [ 42.148551] systemd[550]: Reloading... machine # [ 42.249400] systemd[550]: Reloading finished in 99 ms. machine # [ 42.264159] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.275749] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 42.281107] systemd[1]: Stopping Reactivate sysinit units... machine # [ 42.282071] systemd[1]: Reached target Reactivate sysinit units. machine # [ 42.282925] systemd[1]: Reached target Local File Systems. machine # [ 42.283746] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 42.287116] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 42.292476] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 42.293836] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 42.301613] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 42.303307] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.313224] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.314637] systemd[1]: Reached target Remote File Systems. machine # [ 42.315978] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.317467] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 42.460467] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 42.464674] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 42.468371] systemd[1]: Starting linger-users.service... machine # [ 42.470889] systemd[1]: Starting test.service... machine # [ 42.511095] systemd[1]: Finished test.service. machine # [ 42.527858] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 42.530606] systemd[1]: Finished linger-users.service. machine # [ 42.787434] nixos[2577]: finished switching to system configuration /nix/store/wlib51fxw0c635lglsya69rp1fcwdzh5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/dy887fbf4wsw1bvb2j3csj73qrs59ryd-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.69 seconds) machine: must succeed: ! test -e /run/current-system/activate machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.02 seconds) machine: must succeed: ! test -e /run/current-system/dry-activate machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.02 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.02 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 43.037302] nixos[2725]: switching to system configuration /nix/store/k326krzhs9sf0skh117fzgbxfgyvp6dm-nixos-system-machine-test machine # [ 43.040349] systemd[1]: Stopped target Remote File Systems. machine # [ 43.042106] systemd[1]: Stopped target Local File Systems. machine # [ 43.044822] systemd[1]: test.service: Deactivated successfully. machine # [ 43.045757] systemd[1]: Stopped test.service. machine # [ 43.314164] systemd[1]: Reload requested from client PID 2725 ('.switch-to-conf') (unit backdoor.service)... machine # [ 43.316185] systemd[1]: Reloading... machine # [ 43.624678] systemd[1]: Reloading finished in 307 ms. machine # [ 43.706659] systemd[550]: Reexecution requested from client PID 2794 ('switch-to-confi')... machine # [ 43.708977] systemd[550]: Reexecuting. machine # [ 43.763679] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.873094] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.879665] systemd[550]: Reload requested from client PID 2794 ('switch-to-confi')... machine # [ 43.883817] systemd[550]: Reloading... machine # [ 43.985594] systemd[550]: Reloading finished in 103 ms. machine # [ 44.001636] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.010772] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 44.043238] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 44.046260] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 44.050235] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 44.051301] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 44.059173] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 44.061233] systemd[1]: Stopping Reactivate sysinit units... machine # [ 44.062111] systemd[1]: Reached target Reactivate sysinit units. machine # [ 44.076830] systemd[1]: Started test.service. machine # [ 44.083160] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.092626] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 44.093984] systemd[1]: Reached target Local File Systems. machine # [ 44.094784] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 44.113241] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 44.114257] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 44.115517] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 44.139706] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 44.146161] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.149217] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.150616] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 44.151584] systemd[1]: Reached target Remote File Systems. machine # [ 44.157550] systemd[1]: test.service: Deactivated successfully. machine # [ 44.342352] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 44.348946] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 44.351631] systemd[1]: Starting linger-users.service... machine # [ 44.391448] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 44.393327] systemd[1]: Finished linger-users.service. machine # [ 44.649897] nixos[2725]: finished switching to system configuration /nix/store/k326krzhs9sf0skh117fzgbxfgyvp6dm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 44.863592] nixos[2871]: switching to system configuration /nix/store/m3cr7xjy4dsr61mfp6kvrnjxfsiv736a-nixos-system-machine-test machine # [ 44.866372] systemd[1]: Stopped target Remote File Systems. machine # [ 44.868992] systemd[1]: Stopped target Local File Systems. machine # [ 45.138874] systemd[1]: Reload requested from client PID 2871 ('.switch-to-conf') (unit backdoor.service)... machine # [ 45.141069] systemd[1]: Reloading... machine # [ 45.450533] systemd[1]: Reloading finished in 308 ms. machine # [ 45.536662] systemd[550]: Reexecution requested from client PID 2940 ('switch-to-confi')... machine # [ 45.541102] systemd[550]: Reexecuting. machine # [ 45.587029] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.694187] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.700715] systemd[550]: Reload requested from client PID 2940 ('switch-to-confi')... machine # [ 45.703031] systemd[550]: Reloading... machine # [ 45.807391] systemd[550]: Reloading finished in 103 ms. machine # [ 45.825548] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.835654] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 45.837956] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 45.840083] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 45.870476] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 45.873958] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 45.876677] systemd[1]: Stopping Reactivate sysinit units... machine # [ 45.877546] systemd[1]: Reached target Reactivate sysinit units. machine # [ 45.882313] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.883669] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 45.886662] systemd[1]: Reached target Remote File Systems. machine # [ 45.889291] systemd[1]: Reached target Local File Systems. machine # [ 45.893185] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 45.899570] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 45.902876] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 45.908140] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 45.910413] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 45.912652] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.914032] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.060468] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 46.063352] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 46.068177] systemd[1]: Starting escaped\x2ddash.service... machine # [ 46.072333] systemd[1]: Starting linger-users.service... machine # [ 46.111806] systemd[1]: Finished escaped\x2ddash.service. machine # [ 46.129458] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 46.132811] systemd[1]: Finished linger-users.service. machine # [ 46.388610] nixos[2871]: finished switching to system configuration /nix/store/m3cr7xjy4dsr61mfp6kvrnjxfsiv736a-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 1.74 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 46.603313] nixos[3013]: switching to system configuration /nix/store/645n01gjgmd0dd8v4xd5m4r8vlpb1zrp-nixos-system-machine-test machine # [ 46.606408] systemd[1]: Stopped target Remote File Systems. machine # [ 46.609728] systemd[1]: Stopped target Local File Systems. machine # [ 46.611246] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 46.613254] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 46.884741] systemd[1]: Reload requested from client PID 3013 ('.switch-to-conf') (unit backdoor.service)... machine # [ 46.886714] systemd[1]: Reloading... machine # [ 47.194611] systemd[1]: Reloading finished in 306 ms. machine # [ 47.279603] systemd[550]: Reexecution requested from client PID 3081 ('switch-to-confi')... machine # [ 47.281831] systemd[550]: Reexecuting. machine # [ 47.339319] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.452840] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.459461] systemd[550]: Reload requested from client PID 3081 ('switch-to-confi')... machine # [ 47.462797] systemd[550]: Reloading... machine # [ 47.566644] systemd[550]: Reloading finished in 104 ms. machine # [ 47.580162] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.589495] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 47.591818] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 47.594115] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 47.622776] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 47.626745] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 47.629786] systemd[1]: Stopping Reactivate sysinit units... machine # [ 47.630691] systemd[1]: Reached target Reactivate sysinit units. machine # [ 47.635264] systemd[1]: Starting escaped\x2ddash.service... machine # [ 47.640326] systemd[1]: Reached target Remote File Systems. machine # [ 47.644539] systemd[1]: Starting linger-users.service... machine # [ 47.658149] systemd[1]: Reached target Local File Systems. machine # [ 47.659055] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 47.671059] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 47.677204] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 47.682728] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 47.693718] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 47.702476] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.703907] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.714714] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.718255] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 47.719597] systemd[1]: Finished escaped\x2ddash.service. machine # [ 47.755868] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 47.758761] systemd[1]: Finished linger-users.service. machine # [ 47.886008] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 47.888334] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 48.144261] nixos[3013]: finished switching to system configuration /nix/store/645n01gjgmd0dd8v4xd5m4r8vlpb1zrp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 1.76 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 48.411622] nixos[3155]: switching to system configuration /nix/store/rymlvfv1gkyjr7kl61h2yi7vmxvcc6d4-nixos-system-machine-test machine # [ 48.414239] systemd[1]: Stopped target Remote File Systems. machine # [ 48.416721] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 48.417746] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 48.419242] systemd[1]: Stopped target Local File Systems. machine # [ 48.701150] systemd[1]: Reload requested from client PID 3155 ('.switch-to-conf') (unit backdoor.service)... machine # [ 48.703091] systemd[1]: Reloading... machine # [ 49.015226] systemd[1]: Reloading finished in 310 ms. machine # [ 49.100310] systemd[550]: Reexecution requested from client PID 3224 ('switch-to-confi')... machine # [ 49.101714] systemd[550]: Reexecuting. machine # [ 49.159660] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.269973] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.276214] systemd[550]: Reload requested from client PID 3224 ('switch-to-confi')... machine # [ 49.278428] systemd[550]: Reloading... machine # [ 49.381639] systemd[550]: Reloading finished in 102 ms. machine # [ 49.396168] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.405115] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 49.407309] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 49.409335] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 49.438262] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 49.442003] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 49.443947] systemd[1]: Stopping Reactivate sysinit units... machine # [ 49.446063] systemd[1]: Reached target Reactivate sysinit units. machine # [ 49.449733] systemd[1]: Reached target Remote File Systems. machine # [ 49.452144] systemd[1]: Starting -.service... machine # [ 49.455358] systemd[1]: Starting linger-users.service... machine # [ 49.460998] systemd[1]: Reached target Local File Systems. machine # [ 49.470608] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 49.481700] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 49.482672] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 49.483907] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 49.489623] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 49.491323] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.501075] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.502401] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.515788] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 49.528781] systemd[1]: Finished -.service. machine # [ 49.561670] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 49.563890] systemd[1]: Finished linger-users.service. machine # [ 49.685736] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 49.688572] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 49.945308] nixos[3155]: finished switching to system configuration /nix/store/rymlvfv1gkyjr7kl61h2yi7vmxvcc6d4-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.80 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 50.167727] nixos[3297]: switching to system configuration /nix/store/jschm6qwrdp44ls1zny99c6mwacnbn8z-nixos-system-machine-test machine # [ 50.171082] systemd[1]: Stopped target Local File Systems. machine # [ 50.173256] systemd[1]: Stopped target Remote File Systems. machine # [ 50.443918] systemd[1]: Reload requested from client PID 3297 ('.switch-to-conf') (unit backdoor.service)... machine # [ 50.446295] systemd[1]: Reloading... machine # [ 50.761730] systemd[1]: Reloading finished in 313 ms. machine # [ 50.843812] systemd[550]: Reexecution requested from client PID 3366 ('switch-to-confi')... machine # [ 50.848250] systemd[550]: Reexecuting. machine # [ 50.903161] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.014769] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.021576] systemd[550]: Reload requested from client PID 3366 ('switch-to-confi')... machine # [ 51.023947] systemd[550]: Reloading... machine # [ 51.127435] systemd[550]: Reloading finished in 102 ms. machine # [ 51.144167] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.154196] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 51.156588] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 51.158658] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 51.190529] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 51.194971] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 51.199004] systemd[1]: Stopping Reactivate sysinit units... machine # [ 51.199895] systemd[1]: Reached target Reactivate sysinit units. machine # [ 51.202083] systemd[1]: Reloading -.service... machine # [ 51.224258] systemd[1]: Reloaded -.service. machine # [ 51.229038] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.235030] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 51.237586] systemd[1]: Reached target Remote File Systems. machine # [ 51.238439] systemd[1]: Starting linger-users.service... machine # [ 51.245729] systemd[1]: Reached target Local File Systems. machine # [ 51.251849] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 51.261181] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 51.262165] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 51.263436] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 51.273752] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 51.278422] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.279846] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.325957] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 51.330405] systemd[1]: Finished linger-users.service. machine # [ 51.457434] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 51.460924] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 51.714809] nixos[3297]: finished switching to system configuration /nix/store/jschm6qwrdp44ls1zny99c6mwacnbn8z-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.77 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 51.937159] nixos[3439]: switching to system configuration /nix/store/p3w69z15w5pmg4j7ll8v8z2yg8y7q3r7-nixos-system-machine-test machine # [ 51.939741] systemd[1]: Stopped target Remote File Systems. machine # [ 51.942492] systemd[1]: -.service: Deactivated successfully. machine # [ 51.943359] systemd[1]: Stopped -.service. machine # [ 51.944480] systemd[1]: Stopped target Local File Systems. machine # [ 52.216744] systemd[1]: Reload requested from client PID 3439 ('.switch-to-conf') (unit backdoor.service)... machine # [ 52.218740] systemd[1]: Reloading... machine # [ 52.535268] systemd[1]: Reloading finished in 315 ms. machine # [ 52.620902] systemd[550]: Reexecution requested from client PID 3508 ('switch-to-confi')... machine # [ 52.625357] systemd[550]: Reexecuting. machine # [ 52.683255] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.794334] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.800950] systemd[550]: Reload requested from client PID 3508 ('switch-to-confi')... machine # [ 52.804251] systemd[550]: Reloading... machine # [ 52.905389] systemd[550]: Reloading finished in 102 ms. machine # [ 52.920153] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.930307] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 52.932639] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 52.934673] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 52.966449] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 52.970226] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 52.973386] systemd[1]: Stopping Reactivate sysinit units... machine # [ 52.974301] systemd[1]: Reached target Reactivate sysinit units. machine # [ 52.975138] systemd[1]: Reached target Remote File Systems. machine # [ 52.979762] systemd[1]: Reached target Local File Systems. machine # [ 52.983233] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 52.986779] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 52.987632] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 52.996571] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 52.998866] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 53.005098] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.006373] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.007565] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.008949] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 53.155339] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 53.160292] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 53.163229] systemd[1]: Starting linger-users.service... machine # [ 53.167277] systemd[1]: Starting required-service.service... machine # [ 53.170749] systemd[1]: Starting test-service.service... machine # [ 53.219788] systemd[1]: Finished required-service.service. machine # [ 53.223407] systemd[1]: Finished test-service.service. machine # [ 53.239350] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 53.241570] systemd[1]: Finished linger-users.service. machine # [ 53.497963] nixos[3439]: finished switching to system configuration /nix/store/p3w69z15w5pmg4j7ll8v8z2yg8y7q3r7-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.78 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 53.717807] nixos[3583]: switching to system configuration /nix/store/c2n9w68lz10q5db4xkr794abm9rv6ss9-nixos-system-machine-test machine # [ 53.720401] systemd[1]: Stopped target Local File Systems. machine # [ 53.725194] systemd[1]: Stopped target Remote File Systems. machine # [ 53.726079] systemd[1]: required-service.service: Deactivated successfully. machine # [ 53.727055] systemd[1]: Stopped required-service.service. machine # [ 53.727827] systemd[1]: test-service.service: Deactivated successfully. machine # [ 53.731581] systemd[1]: Stopped test-service.service. machine # [ 54.003919] systemd[1]: Reload requested from client PID 3583 ('.switch-to-conf') (unit backdoor.service)... machine # [ 54.006058] systemd[1]: Reloading... machine # [ 54.321768] systemd[1]: Reloading finished in 314 ms. machine # [ 54.402950] systemd[550]: Reexecution requested from client PID 3651 ('switch-to-confi')... machine # [ 54.405070] systemd[550]: Reexecuting. machine # [ 54.463343] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.573707] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.580341] systemd[550]: Reload requested from client PID 3651 ('switch-to-confi')... machine # [ 54.582645] systemd[550]: Reloading... machine # [ 54.686588] systemd[550]: Reloading finished in 102 ms. machine # [ 54.704165] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.714804] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 54.715841] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 54.718735] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 54.746441] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 54.750156] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 54.752187] systemd[1]: Stopping Reactivate sysinit units... machine # [ 54.753355] systemd[1]: Reached target Reactivate sysinit units. machine # [ 54.756952] systemd[1]: Reached target Remote File Systems. machine # [ 54.763521] systemd[1]: Starting linger-users.service... machine # [ 54.768176] systemd[1]: Starting required-service.service... machine # [ 54.776752] systemd[1]: Starting test-service.service... machine # [ 54.791994] systemd[1]: Reached target Local File Systems. machine # [ 54.792935] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 54.804275] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 54.805198] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 54.806506] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 54.822812] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 54.832367] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.833901] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.835215] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.858591] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 54.864411] systemd[1]: Finished required-service.service. machine # [ 54.868702] systemd[1]: Finished test-service.service. machine # [ 54.894511] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 54.898716] systemd[1]: Finished linger-users.service. machine # [ 55.019398] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 55.022715] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 55.276519] nixos[3583]: finished switching to system configuration /nix/store/c2n9w68lz10q5db4xkr794abm9rv6ss9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.78 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 55.495975] nixos[3727]: switching to system configuration /nix/store/bfcw6hm7d8v22lcy1yaa2igvh45kp3fh-nixos-system-machine-test machine # [ 55.499572] systemd[1]: required-service.service: Deactivated successfully. machine # [ 55.503313] systemd[1]: Stopped required-service.service. machine # [ 55.505210] systemd[1]: test-service.service: Deactivated successfully. machine # [ 55.506189] systemd[1]: Stopped test-service.service. machine # [ 55.506915] systemd[1]: Stopped target Local File Systems. machine # [ 55.507709] systemd[1]: Stopped target Remote File Systems. machine # [ 55.774628] systemd[1]: Reload requested from client PID 3727 ('.switch-to-conf') (unit backdoor.service)... machine # [ 55.776618] systemd[1]: Reloading... machine # [ 56.082634] systemd[1]: Reloading finished in 304 ms. machine # [ 56.168163] systemd[550]: Reexecution requested from client PID 3796 ('switch-to-confi')... machine # [ 56.169573] systemd[550]: Reexecuting. machine # [ 56.227255] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.337516] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.343795] systemd[550]: Reload requested from client PID 3796 ('switch-to-confi')... machine # [ 56.347117] systemd[550]: Reloading... machine # [ 56.447911] systemd[550]: Reloading finished in 101 ms. machine # [ 56.464157] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.473037] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 56.475409] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 56.477429] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 56.506137] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 56.510042] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 56.513514] systemd[1]: Stopping Reactivate sysinit units... machine # [ 56.514451] systemd[1]: Reached target Reactivate sysinit units. machine # [ 56.518879] systemd[1]: Starting required-service.service... machine # [ 56.525889] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.527265] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 56.532884] systemd[1]: Reached target Remote File Systems. machine # [ 56.534812] systemd[1]: Reached target Local File Systems. machine # [ 56.540468] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 56.550357] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 56.551253] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 56.557097] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 56.559356] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 56.568066] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.570794] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.573393] systemd[1]: Finished required-service.service. machine # [ 56.714575] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 56.719288] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 56.722739] systemd[1]: Starting linger-users.service... machine # [ 56.725919] systemd[1]: Starting test-service.service... machine # [ 56.762469] systemd[1]: Finished test-service.service. machine # [ 56.779960] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 56.782598] systemd[1]: Finished linger-users.service. machine # [ 57.037686] nixos[3727]: finished switching to system configuration /nix/store/bfcw6hm7d8v22lcy1yaa2igvh45kp3fh-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.76 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 57.255776] nixos[3871]: switching to system configuration /nix/store/544d65y2xjf1l9bbd7844z5cbv5is45d-nixos-system-machine-test machine # [ 57.258667] systemd[1]: required-service.service: Deactivated successfully. machine # [ 57.261338] systemd[1]: Stopped required-service.service. machine # [ 57.262203] systemd[1]: test-service.service: Deactivated successfully. machine # [ 57.263115] systemd[1]: Stopped test-service.service. machine # [ 57.264349] systemd[1]: Stopped target Remote File Systems. machine # [ 57.267152] systemd[1]: Stopped target Local File Systems. machine # [ 57.539326] systemd[1]: Reload requested from client PID 3871 ('.switch-to-conf') (unit backdoor.service)... machine # [ 57.541385] systemd[1]: Reloading... machine # [ 57.848171] systemd[1]: Reloading finished in 305 ms. machine # [ 57.931867] systemd[550]: Reexecution requested from client PID 3940 ('switch-to-confi')... machine # [ 57.934128] systemd[550]: Reexecuting. machine # [ 57.991636] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.102273] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.108731] systemd[550]: Reload requested from client PID 3940 ('switch-to-confi')... machine # [ 58.112081] systemd[550]: Reloading... machine # [ 58.214527] systemd[550]: Reloading finished in 103 ms. machine # [ 58.232169] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.243480] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 58.245800] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 58.247847] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 58.278779] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 58.282698] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 58.285701] systemd[1]: Stopping Reactivate sysinit units... machine # [ 58.286564] systemd[1]: Reached target Reactivate sysinit units. machine # [ 58.287845] systemd[1]: Reached target Local File Systems. machine # [ 58.292791] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 58.301884] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 58.302778] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 58.313236] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 58.315572] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 58.318141] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.319436] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.321933] systemd[1]: Created slice Slice /system/instantiated. machine # [ 58.324088] systemd[1]: Reached target Remote File Systems. machine # [ 58.325477] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.327653] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 58.472358] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 58.474243] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 58.479061] systemd[1]: Starting instantiated@one.service... machine # [ 58.483916] systemd[1]: Starting instantiated@two.service... machine # [ 58.495023] systemd[1]: Starting linger-users.service... machine # [ 58.537161] systemd[1]: Finished instantiated@two.service. machine # [ 58.540379] systemd[1]: Finished instantiated@one.service. machine # [ 58.557259] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 58.560343] systemd[1]: Finished linger-users.service. machine # [ 58.814966] nixos[3871]: finished switching to system configuration /nix/store/544d65y2xjf1l9bbd7844z5cbv5is45d-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.78 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 59.040868] nixos[4015]: switching to system configuration /nix/store/va5w8bprhigx1kylyy5dcv934h2zwm8b-nixos-system-machine-test machine # [ 59.043410] systemd[1]: Stopped target Local File Systems. machine # [ 59.046016] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 59.047020] systemd[1]: Stopped instantiated@two.service. machine # [ 59.048387] systemd[1]: Stopped target Remote File Systems. machine # [ 59.050823] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 59.052432] systemd[1]: Stopped instantiated@one.service. machine # [ 59.317372] systemd[1]: Reload requested from client PID 4015 ('.switch-to-conf') (unit backdoor.service)... machine # [ 59.319272] systemd[1]: Reloading... machine # [ 59.630080] systemd[1]: Reloading finished in 308 ms. machine # [ 59.711144] systemd[550]: Reexecution requested from client PID 4084 ('switch-to-confi')... machine # [ 59.714876] systemd[550]: Reexecuting. machine # [ 59.775235] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.887780] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.894185] systemd[550]: Reload requested from client PID 4084 ('switch-to-confi')... machine # [ 59.896462] systemd[550]: Reloading... machine # [ 59.998991] systemd[550]: Reloading finished in 101 ms. machine # [ 60.016205] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.027765] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 60.030127] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 60.032278] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 60.063062] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 60.066698] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 60.072246] systemd[1]: Stopping Reactivate sysinit units... machine # [ 60.073139] systemd[1]: Reached target Reactivate sysinit units. machine # [ 60.074070] systemd[1]: Reached target Local File Systems. machine # [ 60.074843] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 60.078748] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 60.079643] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 60.091436] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 60.096794] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 60.098468] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.099725] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.103790] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.106052] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 60.107352] systemd[1]: Reached target Remote File Systems. machine # [ 60.254147] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 60.258504] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 60.261777] systemd[1]: Starting instantiated@one.service... machine # [ 60.265972] systemd[1]: Starting instantiated@two.service... machine # [ 60.279145] systemd[1]: Starting linger-users.service... machine # [ 60.321423] systemd[1]: Finished instantiated@one.service. machine # [ 60.325583] systemd[1]: Finished instantiated@two.service. machine # [ 60.341256] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 60.344409] systemd[1]: Finished linger-users.service. machine # [ 60.598485] nixos[4015]: finished switching to system configuration /nix/store/va5w8bprhigx1kylyy5dcv934h2zwm8b-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.78 seconds) (finished: subtest: services, in 37.84 seconds) subtest: failing units machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 60.808370] nixos[4159]: switching to system configuration /nix/store/v9dgrzy7y8kapjwvi1fciij8nhxi3bky-nixos-system-machine-test machine # [ 60.811744] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 60.814241] systemd[1]: Stopped instantiated@one.service. machine # [ 60.815047] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 60.815994] systemd[1]: Stopped instantiated@two.service. machine # [ 60.819104] systemd[1]: Stopped target Local File Systems. machine # [ 60.819894] systemd[1]: Stopped target Remote File Systems. machine # [ 61.071805] systemd[1]: Reload requested from client PID 4159 ('.switch-to-conf') (unit backdoor.service)... machine # [ 61.074019] systemd[1]: Reloading... machine # [ 61.372177] systemd[1]: Reloading finished in 296 ms. machine # [ 61.455769] systemd[550]: Reexecution requested from client PID 4228 ('switch-to-confi')... machine # [ 61.458673] systemd[550]: Reexecuting. machine # [ 61.519287] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.631026] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.638362] systemd[550]: Reload requested from client PID 4228 ('switch-to-confi')... machine # [ 61.639732] systemd[550]: Reloading... machine # [ 61.742541] systemd[550]: Reloading finished in 101 ms. machine # [ 61.764182] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.774111] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 61.776445] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 61.778669] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 61.811464] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 61.815218] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 61.817205] systemd[1]: Stopping Reactivate sysinit units... machine # [ 61.818137] systemd[1]: Reached target Reactivate sysinit units. machine # [ 61.820460] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.821830] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 61.825242] systemd[1]: Reached target Remote File Systems. machine # [ 61.830306] systemd[1]: Starting linger-users.service... machine # [ 61.834146] systemd[1]: Starting test.service... machine # [ 61.848825] systemd[1]: Reached target Local File Systems. machine # [ 61.849857] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 61.865039] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 61.866079] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 61.873404] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 61.883450] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 61.892707] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.894036] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.904169] systemd[1]: Finished test.service. machine # [ 61.931171] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 61.935985] systemd[1]: Finished linger-users.service. machine # [ 62.066607] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 62.069867] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 62.325139] nixos[4159]: finished switching to system configuration /nix/store/v9dgrzy7y8kapjwvi1fciij8nhxi3bky-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.73 seconds) machine: must fail: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 62.541580] nixos[4301]: switching to system configuration /nix/store/z0cx6jxfkkga6mjmr0ybc55yc24l662g-nixos-system-machine-test machine # [ 62.544150] systemd[1]: test.service: Deactivated successfully. machine # [ 62.548081] systemd[1]: Stopped test.service. machine # [ 62.548809] systemd[1]: Stopped target Remote File Systems. machine # [ 62.549629] systemd[1]: Stopped target Local File Systems. machine # [ 62.825920] systemd[1]: Reload requested from client PID 4301 ('.switch-to-conf') (unit backdoor.service)... machine # [ 62.827835] systemd[1]: Reloading... machine # [ 63.137078] systemd[1]: Reloading finished in 307 ms. machine # [ 63.220426] systemd[550]: Reexecution requested from client PID 4370 ('switch-to-confi')... machine # [ 63.224081] systemd[550]: Reexecuting. machine # [ 63.283259] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.393046] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.400197] systemd[550]: Reload requested from client PID 4370 ('switch-to-confi')... machine # [ 63.401592] systemd[550]: Reloading... machine # [ 63.506497] systemd[550]: Reloading finished in 103 ms. machine # [ 63.520183] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.529277] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 63.531573] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 63.533687] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 63.563044] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 63.566659] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 63.569794] systemd[1]: Stopping Reactivate sysinit units... machine # [ 63.570677] systemd[1]: Reached target Reactivate sysinit units. machine # [ 63.571513] systemd[1]: Reached target Local File Systems. machine # [ 63.577406] systemd[1]: Starting test.service... machine # [ 63.581823] systemd[1]: Reached target Remote File Systems. machine # [ 63.584822] systemd[1]: Starting linger-users.service... machine # [ 63.591800] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 63.603555] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 63.605163] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 63.606482] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 63.617357] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 63.619115] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.625567] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.626953] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.637680] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 63.658057] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 63.659463] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 63.664907] systemd[1]: Failed to start test.service. machine # [ 63.690322] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 63.694623] systemd[1]: Finished linger-users.service. machine # [ 63.818758] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 63.822250] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 64.097472] nixos[4301]: switching to system configuration /nix/store/z0cx6jxfkkga6mjmr0ybc55yc24l662g-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.77 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 64.306794] nixos[4444]: switching to system configuration /nix/store/m78zd7xzjbhlpi0pfz0f3wm0cda9hm7p-nixos-system-machine-test machine # [ 64.309488] systemd[1]: Stopped target Remote File Systems. machine # [ 64.311699] systemd[1]: Stopped target Local File Systems. machine # [ 64.589425] systemd[1]: Reload requested from client PID 4444 ('.switch-to-conf') (unit backdoor.service)... machine # [ 64.591402] systemd[1]: Reloading... machine # [ 64.901721] systemd[1]: Reloading finished in 308 ms. machine # [ 64.981684] systemd[550]: Reexecution requested from client PID 4513 ('switch-to-confi')... machine # [ 64.985381] systemd[550]: Reexecuting. machine # [ 65.043699] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.153870] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.160223] systemd[550]: Reload requested from client PID 4513 ('switch-to-confi')... machine # [ 65.162550] systemd[550]: Reloading... machine # [ 65.264976] systemd[550]: Reloading finished in 101 ms. machine # [ 65.277522] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.285123] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 65.287344] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 65.289391] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 65.317995] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 65.321966] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 65.325170] systemd[1]: Stopping Reactivate sysinit units... machine # [ 65.326049] systemd[1]: Reached target Reactivate sysinit units. machine # [ 65.328400] systemd[1]: Reached target Local File Systems. machine # [ 65.329233] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 65.336147] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 65.337038] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 65.338338] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 65.351179] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 65.354980] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.356358] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.357567] systemd[1]: Reached target Remote File Systems. machine # [ 65.358365] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.359622] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 65.505557] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 65.507985] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 65.512160] systemd[1]: Started autorestart.service. machine # [ 65.517120] systemd[1]: Starting linger-users.service... machine # [ 65.554260] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 65.572325] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 65.575257] systemd[1]: Finished linger-users.service. machine # [ 65.830533] nixos[4444]: finished switching to system configuration /nix/store/m78zd7xzjbhlpi0pfz0f3wm0cda9hm7p-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.73 seconds) machine # [ 65.869465] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 66.062215] nixos[4591]: switching to system configuration /nix/store/m78zd7xzjbhlpi0pfz0f3wm0cda9hm7p-nixos-system-machine-test machine # [ 66.064673] systemd[1]: Stopped target Remote File Systems. machine # [ 66.067503] systemd[1]: Stopped target Local File Systems. machine # [ 66.317031] systemd[1]: Reload requested from client PID 4591 ('.switch-to-conf') (unit backdoor.service)... machine # [ 66.319191] systemd[1]: Reloading... machine # [ 66.616422] systemd[1]: Reloading finished in 295 ms. machine # [ 66.699027] systemd[550]: Reexecution requested from client PID 4660 ('switch-to-confi')... machine # [ 66.702598] systemd[550]: Reexecuting. machine # [ 66.759183] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.868225] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.874427] systemd[550]: Reload requested from client PID 4660 ('switch-to-confi')... machine # [ 66.877788] systemd[550]: Reloading... machine # [ 66.978098] systemd[550]: Reloading finished in 101 ms. machine # [ 66.992147] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.001325] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 67.003602] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 67.005637] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 67.034095] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 67.037791] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 67.040661] systemd[1]: Stopping Reactivate sysinit units... machine # [ 67.041536] systemd[1]: Reached target Reactivate sysinit units. machine # [ 67.043094] systemd[1]: Reached target Remote File Systems. machine # [ 67.051273] systemd[1]: Started autorestart.service. machine # [ 67.056220] systemd[1]: Starting linger-users.service... machine # [ 67.057048] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.058345] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 67.070858] systemd[1]: Reached target Local File Systems. machine # [ 67.073346] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 67.081604] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 67.082566] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 67.083795] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 67.099945] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 67.104995] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.110412] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.119814] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 67.150900] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 67.154574] systemd[1]: Finished linger-users.service. machine # [ 67.283830] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 67.286873] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 67.543681] nixos[4591]: finished switching to system configuration /nix/store/m78zd7xzjbhlpi0pfz0f3wm0cda9hm7p-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.67 seconds) machine # [ 67.582823] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 67.791325] nixos[4738]: switching to system configuration /nix/store/5riwgdg245wnwh4knrs7p7xjb9hjmayl-nixos-system-machine-test machine # [ 67.794399] systemd[1]: Stopped target Remote File Systems. machine # [ 67.796132] systemd[1]: Stopped target Local File Systems. machine # [ 68.065105] systemd[1]: Reload requested from client PID 4738 ('.switch-to-conf') (unit backdoor.service)... machine # [ 68.067101] systemd[1]: Reloading... machine # [ 68.375280] systemd[1]: Reloading finished in 306 ms. machine # [ 68.459974] systemd[550]: Reexecution requested from client PID 4807 ('switch-to-confi')... machine # [ 68.461404] systemd[550]: Reexecuting. machine # [ 68.519088] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.630434] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.636959] systemd[550]: Reload requested from client PID 4807 ('switch-to-confi')... machine # [ 68.640081] systemd[550]: Reloading... machine # [ 68.743987] systemd[550]: Reloading finished in 104 ms. machine # [ 68.764177] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.773372] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 68.775598] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 68.777642] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 68.806516] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 68.810403] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 68.814280] systemd[1]: Stopping Reactivate sysinit units... machine # [ 68.815176] systemd[1]: Reached target Reactivate sysinit units. machine # [ 68.820426] systemd[1]: Reached target Local File Systems. machine # [ 68.821323] systemd[1]: Reached target Remote File Systems. machine # [ 68.824374] systemd[1]: Started autorestart.service. machine # [ 68.829272] systemd[1]: Starting linger-users.service... machine # [ 68.843356] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.847695] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 68.855005] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 68.861704] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 68.865937] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 68.872414] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 68.882781] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 68.890328] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.891740] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.900584] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 68.901965] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 68.930660] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 68.934249] systemd[1]: Finished linger-users.service. machine # [ 69.056902] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 69.060309] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 69.335695] nixos[4738]: switching to system configuration /nix/store/5riwgdg245wnwh4knrs7p7xjb9hjmayl-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.75 seconds) (finished: subtest: failing units, in 8.74 seconds) subtest: unit file parser machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 69.530620] nixos[4881]: switching to system configuration /nix/store/cbsymq7lb09snni660gz9vpbjxjplvzp-nixos-system-machine-test machine # [ 69.533369] systemd[1]: Stopped target Remote File Systems. machine # [ 69.535614] systemd[1]: Stopped autorestart.service. machine # [ 69.537764] systemd[1]: Stopped target Local File Systems. machine # [ 69.789287] systemd[1]: Reload requested from client PID 4881 ('.switch-to-conf') (unit backdoor.service)... machine # [ 69.791231] systemd[1]: Reloading... machine # [ 70.093595] systemd[1]: Reloading finished in 300 ms. machine # [ 70.176410] systemd[550]: Reexecution requested from client PID 4950 ('switch-to-confi')... machine # [ 70.180152] systemd[550]: Reexecuting. machine # [ 70.235238] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.347426] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.354216] systemd[550]: Reload requested from client PID 4950 ('switch-to-confi')... machine # [ 70.356530] systemd[550]: Reloading... machine # [ 70.462391] systemd[550]: Reloading finished in 104 ms. machine # [ 70.476148] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.485898] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 70.488066] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 70.489980] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 70.518190] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 70.522112] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 70.524895] systemd[1]: Stopping Reactivate sysinit units... machine # [ 70.525802] systemd[1]: Reached target Reactivate sysinit units. machine # [ 70.526694] systemd[1]: Reached target Remote File Systems. machine # [ 70.532175] systemd[1]: Reached target Local File Systems. machine # [ 70.533079] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 70.538328] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 70.539233] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 70.548535] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 70.550806] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 70.553015] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.554398] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.557703] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.559069] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 70.708289] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 70.712616] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.716173] systemd[1]: Starting linger-users.service... machine # [ 70.718971] systemd[1]: Starting test.service... machine # [ 70.758698] systemd[1]: Finished test.service. machine # [ 70.775824] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 70.778187] systemd[1]: Finished linger-users.service. machine # [ 71.034641] nixos[4881]: finished switching to system configuration /nix/store/cbsymq7lb09snni660gz9vpbjxjplvzp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.70 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 71.256219] nixos[5023]: switching to system configuration /nix/store/80y53wma71wfc3cjjhr9cl76q17bwr9h-nixos-system-machine-test machine # [ 71.259044] systemd[1]: Stopped target Local File Systems. machine # [ 71.261010] systemd[1]: Stopped target Remote File Systems. machine # [ 71.530637] systemd[1]: Reload requested from client PID 5023 ('.switch-to-conf') (unit backdoor.service)... machine # [ 71.532651] systemd[1]: Reloading... machine # [ 71.842503] systemd[1]: Reloading finished in 308 ms. machine # [ 71.931478] systemd[550]: Reexecution requested from client PID 5092 ('switch-to-confi')... machine # [ 71.933727] systemd[550]: Reexecuting. machine # [ 71.995180] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.114434] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.120808] systemd[550]: Reload requested from client PID 5092 ('switch-to-confi')... machine # [ 72.123234] systemd[550]: Reloading... machine # [ 72.227871] systemd[550]: Reloading finished in 103 ms. machine # [ 72.248152] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.257163] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 72.259404] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 72.261479] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 72.290181] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 72.294072] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 72.298888] systemd[1]: Stopping Reactivate sysinit units... machine # [ 72.299812] systemd[1]: Reached target Reactivate sysinit units. machine # [ 72.301184] systemd[1]: test.service: Deactivated successfully. machine # [ 72.302070] systemd[1]: Stopped test.service. machine # [ 72.302738] systemd[1]: Stopping test.service... machine # [ 72.308397] systemd[1]: Starting test.service... machine # [ 72.327837] systemd[1]: Finished test.service. machine # [ 72.331646] systemd[1]: Reached target Remote File Systems. machine # [ 72.335709] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.339568] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 72.343304] systemd[1]: Reached target Local File Systems. machine # [ 72.345896] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 72.352476] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 72.353438] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 72.354769] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 72.363890] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 72.365712] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.366990] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.511560] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 72.513537] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 72.518367] systemd[1]: Starting linger-users.service... machine # [ 72.554482] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 72.556758] systemd[1]: Finished linger-users.service. machine # [ 72.812254] nixos[5023]: finished switching to system configuration /nix/store/80y53wma71wfc3cjjhr9cl76q17bwr9h-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.78 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 73.034495] nixos[5165]: switching to system configuration /nix/store/q0wiypaj23lvyys0skhmq644abqddfnc-nixos-system-machine-test machine # [ 73.036880] systemd[1]: Stopped target Remote File Systems. machine # [ 73.039350] systemd[1]: Stopped target Local File Systems. machine # [ 73.308786] systemd[1]: Reload requested from client PID 5165 ('.switch-to-conf') (unit backdoor.service)... machine # [ 73.310672] systemd[1]: Reloading... machine # [ 73.617843] systemd[1]: Reloading finished in 305 ms. machine # [ 73.704751] systemd[550]: Reexecution requested from client PID 5234 ('switch-to-confi')... machine # [ 73.708824] systemd[550]: Reexecuting. machine # [ 73.767204] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.881149] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.887555] systemd[550]: Reload requested from client PID 5234 ('switch-to-confi')... machine # [ 73.891110] systemd[550]: Reloading... machine # [ 73.992912] systemd[550]: Reloading finished in 102 ms. machine # [ 74.008154] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.017951] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 74.020123] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 74.022427] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 74.055302] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 74.059178] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 74.063620] systemd[1]: Stopping Reactivate sysinit units... machine # [ 74.064781] systemd[1]: Reached target Reactivate sysinit units. machine # [ 74.065730] systemd[1]: test.service: Deactivated successfully. machine # [ 74.066572] systemd[1]: Stopped test.service. machine # [ 74.067227] systemd[1]: Stopping test.service... machine # [ 74.072224] systemd[1]: Starting test.service... machine # [ 74.091572] systemd[1]: Finished test.service. machine # [ 74.099052] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.102172] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 74.103482] systemd[1]: Reached target Remote File Systems. machine # [ 74.105482] systemd[1]: Reached target Local File Systems. machine # [ 74.110618] systemd[1]: Starting linger-users.service... machine # [ 74.115124] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 74.118847] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 74.119741] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 74.130822] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 74.133365] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 74.134963] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.136281] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.187249] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 74.190005] systemd[1]: Finished linger-users.service. machine # [ 74.312211] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 74.314922] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 74.570561] nixos[5165]: finished switching to system configuration /nix/store/q0wiypaj23lvyys0skhmq644abqddfnc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.76 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 74.772480] nixos[5307]: switching to system configuration /nix/store/cbsymq7lb09snni660gz9vpbjxjplvzp-nixos-system-machine-test machine # [ 74.774905] systemd[1]: Stopped target Remote File Systems. machine # [ 74.777493] systemd[1]: Stopped target Local File Systems. machine # [ 75.027324] systemd[1]: Reload requested from client PID 5307 ('.switch-to-conf') (unit backdoor.service)... machine # [ 75.029614] systemd[1]: Reloading... machine # [ 75.323252] systemd[1]: Reloading finished in 292 ms. machine # [ 75.406858] systemd[550]: Reexecution requested from client PID 5376 ('switch-to-confi')... machine # [ 75.408862] systemd[550]: Reexecuting. machine # [ 75.471219] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.582822] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.589094] systemd[550]: Reload requested from client PID 5376 ('switch-to-confi')... machine # [ 75.592200] systemd[550]: Reloading... machine # [ 75.693985] systemd[550]: Reloading finished in 102 ms. machine # [ 75.712161] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.721091] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 75.723331] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 75.725331] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 75.753589] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 75.756900] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 75.758778] systemd[1]: Stopping Reactivate sysinit units... machine # [ 75.759622] systemd[1]: Reached target Reactivate sysinit units. machine # [ 75.763234] systemd[1]: test.service: Deactivated successfully. machine # [ 75.764363] systemd[1]: Stopped test.service. machine # [ 75.765004] systemd[1]: Stopping test.service... machine # [ 75.766640] systemd[1]: Starting test.service... machine # [ 75.787321] systemd[1]: Finished test.service. machine # [ 75.791766] systemd[1]: Reached target Local File Systems. machine # [ 75.797197] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 75.798851] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 75.799677] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 75.813114] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 75.815340] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 75.818217] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.819514] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.820788] systemd[1]: Reached target Remote File Systems. machine # [ 75.821583] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.822861] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 75.968198] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 75.971022] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 75.975042] systemd[1]: Starting linger-users.service... machine # [ 76.014158] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 76.016361] systemd[1]: Finished linger-users.service. machine # [ 76.272110] nixos[5307]: finished switching to system configuration /nix/store/cbsymq7lb09snni660gz9vpbjxjplvzp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.70 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 76.487603] nixos[5449]: switching to system configuration /nix/store/m8kqkf8v6s3vka995prjp55r4scg2wq7-nixos-system-machine-test machine # [ 76.490559] systemd[1]: Stopped target Local File Systems. machine # [ 76.493069] systemd[1]: Stopped target Remote File Systems. machine # [ 76.759029] systemd[1]: Reload requested from client PID 5449 ('.switch-to-conf') (unit backdoor.service)... machine # [ 76.761267] systemd[1]: Reloading... machine # [ 77.063993] systemd[1]: Reloading finished in 301 ms. machine # [ 77.150191] systemd[550]: Reexecution requested from client PID 5518 ('switch-to-confi')... machine # [ 77.154050] systemd[550]: Reexecuting. machine # [ 77.211037] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.325008] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.331413] systemd[550]: Reload requested from client PID 5518 ('switch-to-confi')... machine # [ 77.334742] systemd[550]: Reloading... machine # [ 77.435823] systemd[550]: Reloading finished in 102 ms. machine # [ 77.452140] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.460741] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 77.462834] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 77.464765] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 77.493186] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 77.497571] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 77.498580] systemd[1]: Stopping Reactivate sysinit units... machine # [ 77.499372] systemd[1]: Reached target Reactivate sysinit units. machine # [ 77.504666] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.506098] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 77.508492] systemd[1]: Reached target Remote File Systems. machine # [ 77.510973] systemd[1]: Reached target Local File Systems. machine # [ 77.515117] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 77.522339] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 77.523227] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 77.529107] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 77.531326] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 77.534918] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.536274] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.681732] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 77.686186] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 77.688287] systemd[1]: Starting linger-users.service... machine # [ 77.726194] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 77.729129] systemd[1]: Finished linger-users.service. machine # [ 77.983016] nixos[5449]: finished switching to system configuration /nix/store/m8kqkf8v6s3vka995prjp55r4scg2wq7-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.71 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 78.199150] nixos[5589]: switching to system configuration /nix/store/bk16lyhhcmr4z92mz9ss9fxxjwxrmhvs-nixos-system-machine-test machine # [ 78.201910] systemd[1]: Stopped target Remote File Systems. machine # [ 78.203548] systemd[1]: Stopped target Local File Systems. machine # [ 78.468235] systemd[1]: Reload requested from client PID 5589 ('.switch-to-conf') (unit backdoor.service)... machine # [ 78.470119] systemd[1]: Reloading... machine # [ 78.775480] systemd[1]: Reloading finished in 303 ms. machine # [ 78.858484] systemd[550]: Reexecution requested from client PID 5658 ('switch-to-confi')... machine # [ 78.862516] systemd[550]: Reexecuting. machine # [ 78.918990] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.027002] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.033852] systemd[550]: Reload requested from client PID 5658 ('switch-to-confi')... machine # [ 79.035179] systemd[550]: Reloading... machine # [ 79.136737] systemd[550]: Reloading finished in 100 ms. machine # [ 79.152148] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.160855] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 79.163241] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 79.165218] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 79.193414] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 79.197039] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 79.198891] systemd[1]: Stopping Reactivate sysinit units... machine # [ 79.199727] systemd[1]: Reached target Reactivate sysinit units. machine # [ 79.203250] systemd[1]: test.service: Deactivated successfully. machine # [ 79.204354] systemd[1]: Stopped test.service. machine # [ 79.205011] systemd[1]: Stopping test.service... machine # [ 79.206596] systemd[1]: Starting test.service... machine # [ 79.227095] systemd[1]: Finished test.service. machine # [ 79.231575] systemd[1]: Reached target Remote File Systems. machine # [ 79.235420] systemd[1]: Starting linger-users.service... machine # [ 79.240532] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.241927] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 79.248118] systemd[1]: Reached target Local File Systems. machine # [ 79.249993] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 79.256116] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 79.256977] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 79.258288] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 79.275086] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 79.278389] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.279679] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.315446] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 79.320373] systemd[1]: Finished linger-users.service. machine # [ 79.445962] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 79.448981] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 79.704425] nixos[5589]: finished switching to system configuration /nix/store/bk16lyhhcmr4z92mz9ss9fxxjwxrmhvs-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.72 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 79.922412] nixos[5731]: switching to system configuration /nix/store/b31bx232lb6np76bzhqjwdim29ic98ln-nixos-system-machine-test machine # [ 79.925299] systemd[1]: Stopped target Remote File Systems. machine # [ 79.927491] systemd[1]: Stopped target Local File Systems. machine # [ 80.187899] systemd[1]: Reload requested from client PID 5731 ('.switch-to-conf') (unit backdoor.service)... machine # [ 80.189969] systemd[1]: Reloading... machine # [ 80.491568] systemd[1]: Reloading finished in 300 ms. machine # [ 80.579775] systemd[550]: Reexecution requested from client PID 5800 ('switch-to-confi')... machine # [ 80.583411] systemd[550]: Reexecuting. machine # [ 80.630933] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.737216] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.743882] systemd[550]: Reload requested from client PID 5800 ('switch-to-confi')... machine # [ 80.747406] systemd[550]: Reloading... machine # [ 80.848898] systemd[550]: Reloading finished in 102 ms. machine # [ 80.865634] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.873618] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 80.875736] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 80.877890] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 80.905740] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 80.909501] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 80.912345] systemd[1]: Stopping Reactivate sysinit units... machine # [ 80.913240] systemd[1]: Reached target Reactivate sysinit units. machine # [ 80.914160] systemd[1]: test.service: Deactivated successfully. machine # [ 80.916925] systemd[1]: Stopped test.service. machine # [ 80.917677] systemd[1]: Stopping test.service... machine # [ 80.919250] systemd[1]: Starting test.service... machine # [ 80.943990] systemd[1]: Finished test.service. machine # [ 80.946660] systemd[1]: Reached target Local File Systems. machine # [ 80.949786] systemd[1]: Reached target Remote File Systems. machine # [ 80.956927] systemd[1]: Starting linger-users.service... machine # [ 80.962543] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 80.972399] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 80.973259] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 80.974495] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 80.982406] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 80.983997] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.985272] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.986529] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.987773] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 81.040619] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 81.043622] systemd[1]: Finished linger-users.service. machine # [ 81.163873] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 81.166851] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 81.422225] nixos[5731]: finished switching to system configuration /nix/store/b31bx232lb6np76bzhqjwdim29ic98ln-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.72 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 81.670429] nixos[5873]: switching to system configuration /nix/store/hf7rrvv9drs21hzdcqsw9xsf6mfkar4d-nixos-system-machine-test machine # [ 81.672946] systemd[1]: Stopped target Local File Systems. machine # [ 81.675355] systemd[1]: Stopped target Remote File Systems. machine # [ 81.935204] systemd[1]: Reload requested from client PID 5873 ('.switch-to-conf') (unit backdoor.service)... machine # [ 81.937262] systemd[1]: Reloading... machine # [ 82.240190] systemd[1]: Reloading finished in 301 ms. machine # [ 82.320609] systemd[550]: Reexecution requested from client PID 5942 ('switch-to-confi')... machine # [ 82.324931] systemd[550]: Reexecuting. machine # [ 82.379160] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.488421] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.494729] systemd[550]: Reload requested from client PID 5942 ('switch-to-confi')... machine # [ 82.498155] systemd[550]: Reloading... machine # [ 82.599873] systemd[550]: Reloading finished in 102 ms. machine # [ 82.616148] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.626807] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 82.629018] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 82.630995] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 82.661211] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 82.664769] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 82.666770] systemd[1]: Stopping Reactivate sysinit units... machine # [ 82.667626] systemd[1]: Reached target Reactivate sysinit units. machine # [ 82.670958] systemd[1]: test.service: Deactivated successfully. machine # [ 82.671817] systemd[1]: Stopped test.service. machine # [ 82.672811] systemd[1]: Stopping test.service... machine # [ 82.674867] systemd[1]: Starting test.service... machine # [ 82.694873] systemd[1]: Finished test.service. machine # [ 82.697297] systemd[1]: Reached target Remote File Systems. machine # [ 82.702236] systemd[1]: Reached target Local File Systems. machine # [ 82.703101] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 82.706668] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 82.707556] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 82.715998] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 82.718598] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 82.725065] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.726398] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.727593] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.731798] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 82.875593] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 82.880220] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 82.882219] systemd[1]: Starting linger-users.service... machine # [ 82.917680] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 82.920228] systemd[1]: Finished linger-users.service. machine # [ 83.175342] nixos[5873]: finished switching to system configuration /nix/store/hf7rrvv9drs21hzdcqsw9xsf6mfkar4d-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 1.75 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 83.376930] nixos[6015]: switching to system configuration /nix/store/cbsymq7lb09snni660gz9vpbjxjplvzp-nixos-system-machine-test machine # [ 83.379661] systemd[1]: Stopped target Remote File Systems. machine # [ 83.382550] systemd[1]: Stopped target Local File Systems. machine # [ 83.631925] systemd[1]: Reload requested from client PID 6015 ('.switch-to-conf') (unit backdoor.service)... machine # [ 83.634316] systemd[1]: Reloading... machine # [ 83.931753] systemd[1]: Reloading finished in 295 ms. machine # [ 84.016088] systemd[550]: Reexecution requested from client PID 6083 ('switch-to-confi')... machine # [ 84.017511] systemd[550]: Reexecuting. machine # [ 84.075024] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.185959] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.191955] systemd[550]: Reload requested from client PID 6083 ('switch-to-confi')... machine # [ 84.195427] systemd[550]: Reloading... machine # [ 84.297417] systemd[550]: Reloading finished in 102 ms. machine # [ 84.312145] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.320949] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 84.323157] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 84.325170] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 84.353429] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 84.357158] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 84.358933] systemd[1]: Stopping Reactivate sysinit units... machine # [ 84.359771] systemd[1]: Reached target Reactivate sysinit units. machine # [ 84.363382] systemd[1]: test.service: Deactivated successfully. machine # [ 84.364538] systemd[1]: Stopped test.service. machine # [ 84.365178] systemd[1]: Stopping test.service... machine # [ 84.366782] systemd[1]: Starting test.service... machine # [ 84.387438] systemd[1]: Finished test.service. machine # [ 84.391214] systemd[1]: Reached target Remote File Systems. machine # [ 84.399130] systemd[1]: Starting linger-users.service... machine # [ 84.401782] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.408626] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 84.414427] systemd[1]: Reached target Local File Systems. machine # [ 84.415275] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 84.423137] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 84.424001] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 84.425338] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 84.427563] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 84.436556] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.437928] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.480110] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 84.483553] systemd[1]: Finished linger-users.service. machine # [ 84.602463] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 84.605320] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 84.860356] nixos[6015]: finished switching to system configuration /nix/store/cbsymq7lb09snni660gz9vpbjxjplvzp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.68 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 85.075430] nixos[6157]: switching to system configuration /nix/store/0awp9qx60h9sjqjdimlx39q54f6qd3cn-nixos-system-machine-test machine # [ 85.077911] systemd[1]: Stopped target Local File Systems. machine # [ 85.080185] systemd[1]: Stopped target Remote File Systems. machine # [ 85.340152] systemd[1]: Reload requested from client PID 6157 ('.switch-to-conf') (unit backdoor.service)... machine # [ 85.342066] systemd[1]: Reloading... machine # [ 85.646874] systemd[1]: Reloading finished in 303 ms. machine # [ 85.734121] systemd[550]: Reexecution requested from client PID 6226 ('switch-to-confi')... machine # [ 85.735527] systemd[550]: Reexecuting. machine # [ 85.799888] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.912108] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.918190] systemd[550]: Reload requested from client PID 6226 ('switch-to-confi')... machine # [ 85.921478] systemd[550]: Reloading... machine # [ 86.020425] systemd[550]: Reloading finished in 99 ms. machine # [ 86.036138] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.046305] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 86.047355] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 86.050239] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 86.073572] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 86.077169] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 86.078530] systemd[1]: Stopping Reactivate sysinit units... machine # [ 86.079354] systemd[1]: Reached target Reactivate sysinit units. machine # [ 86.084607] systemd[1]: Reloading test.service... machine # [ 86.107297] systemd[1]: Reloaded test.service. machine # [ 86.111639] systemd[1]: Reached target Remote File Systems. machine # [ 86.115476] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.124445] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 86.125802] systemd[1]: Starting linger-users.service... machine # [ 86.126564] systemd[1]: Reached target Local File Systems. machine # [ 86.127341] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 86.142074] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 86.142937] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 86.149574] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 86.151813] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 86.162439] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.166050] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.199048] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 86.202161] systemd[1]: Finished linger-users.service. machine # [ 86.325203] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 86.328794] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 86.582624] nixos[6157]: finished switching to system configuration /nix/store/0awp9qx60h9sjqjdimlx39q54f6qd3cn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.72 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 86.797755] nixos[6299]: switching to system configuration /nix/store/hpk2mzvh7brxrym1sq988qv67vfddiwq-nixos-system-machine-test machine # [ 86.800492] systemd[1]: Stopped target Local File Systems. machine # [ 86.802880] systemd[1]: Stopped target Remote File Systems. machine # [ 87.066642] systemd[1]: Reload requested from client PID 6299 ('.switch-to-conf') (unit backdoor.service)... machine # [ 87.068585] systemd[1]: Reloading... machine # [ 87.370516] systemd[1]: Reloading finished in 300 ms. machine # [ 87.455234] systemd[550]: Reexecution requested from client PID 6368 ('switch-to-confi')... machine # [ 87.457209] systemd[550]: Reexecuting. machine # [ 87.514982] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.622669] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.629345] systemd[550]: Reload requested from client PID 6368 ('switch-to-confi')... machine # [ 87.630651] systemd[550]: Reloading... machine # [ 87.733806] systemd[550]: Reloading finished in 100 ms. machine # [ 87.748135] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.756730] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 87.758879] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 87.760907] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 87.788841] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 87.792388] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 87.796353] systemd[1]: Stopping Reactivate sysinit units... machine # [ 87.797222] systemd[1]: Reached target Reactivate sysinit units. machine # [ 87.799149] systemd[1]: Reloading test.service... machine # [ 87.819491] systemd[1]: Reloaded test.service. machine # [ 87.823415] systemd[1]: Reached target Local File Systems. machine # [ 87.826747] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 87.835172] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 87.836503] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 87.837787] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 87.839946] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 87.846259] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.847564] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.853512] systemd[1]: Reached target Remote File Systems. machine # [ 87.854378] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.856277] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 87.996129] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 88.000513] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 88.002740] systemd[1]: Starting linger-users.service... machine # [ 88.042200] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 88.044597] systemd[1]: Finished linger-users.service. machine # [ 88.300088] nixos[6299]: finished switching to system configuration /nix/store/hpk2mzvh7brxrym1sq988qv67vfddiwq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.72 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 88.518713] nixos[6441]: switching to system configuration /nix/store/m89va0dbm4lz17aqzj7p0mfpbpr46r8j-nixos-system-machine-test machine # [ 88.523691] systemd[1]: Stopped target Remote File Systems. machine # [ 88.526001] systemd[1]: Stopped target Local File Systems. machine # [ 88.788307] systemd[1]: Reload requested from client PID 6441 ('.switch-to-conf') (unit backdoor.service)... machine # [ 88.789879] systemd[1]: Reloading... machine # [ 89.092654] systemd[1]: Reloading finished in 301 ms. machine # [ 89.174378] systemd[550]: Reexecution requested from client PID 6510 ('switch-to-confi')... machine # [ 89.175776] systemd[550]: Reexecuting. machine # [ 89.235582] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.346484] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.353362] systemd[550]: Reload requested from client PID 6510 ('switch-to-confi')... machine # [ 89.354747] systemd[550]: Reloading... machine # [ 89.457467] systemd[550]: Reloading finished in 101 ms. machine # [ 89.472158] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.481137] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 89.483439] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 89.485589] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 89.514387] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 89.518681] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 89.519642] systemd[1]: Stopping Reactivate sysinit units... machine # [ 89.520784] systemd[1]: Reached target Reactivate sysinit units. machine # [ 89.524391] systemd[1]: test.service: Deactivated successfully. machine # [ 89.525313] systemd[1]: Stopped test.service. machine # [ 89.525976] systemd[1]: Stopping test.service... machine # [ 89.527988] systemd[1]: Starting test.service... machine # [ 89.552112] systemd[1]: Finished test.service. machine # [ 89.558829] systemd[1]: Reached target Remote File Systems. machine # [ 89.562857] systemd[1]: Starting linger-users.service... machine # [ 89.571121] systemd[1]: Reached target Local File Systems. machine # [ 89.575371] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 89.584797] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 89.585761] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 89.591689] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 89.595772] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 89.600562] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.601936] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.608967] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.610350] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 89.643931] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 89.647860] systemd[1]: Finished linger-users.service. machine # [ 89.772606] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 89.775353] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 90.030866] nixos[6441]: finished switching to system configuration /nix/store/m89va0dbm4lz17aqzj7p0mfpbpr46r8j-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.73 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 90.231720] nixos[6583]: switching to system configuration /nix/store/bk16lyhhcmr4z92mz9ss9fxxjwxrmhvs-nixos-system-machine-test machine # [ 90.234749] systemd[1]: Stopped target Local File Systems. machine # [ 90.237347] systemd[1]: Stopped target Remote File Systems. machine # [ 90.480781] systemd[1]: Reload requested from client PID 6583 ('.switch-to-conf') (unit backdoor.service)... machine # [ 90.482710] systemd[1]: Reloading... machine # [ 90.774348] systemd[1]: Reloading finished in 290 ms. machine # [ 90.861815] systemd[550]: Reexecution requested from client PID 6651 ('switch-to-confi')... machine # [ 90.865179] systemd[550]: Reexecuting. machine # [ 90.923115] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.034993] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.041218] systemd[550]: Reload requested from client PID 6651 ('switch-to-confi')... machine # [ 91.043463] systemd[550]: Reloading... machine # [ 91.145147] systemd[550]: Reloading finished in 100 ms. machine # [ 91.160145] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.169887] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 91.170836] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 91.173528] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 91.201022] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 91.204552] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 91.207288] systemd[1]: Stopping Reactivate sysinit units... machine # [ 91.209831] systemd[1]: Reached target Reactivate sysinit units. machine # [ 91.210706] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.211974] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 91.215383] systemd[1]: Reached target Remote File Systems. machine # [ 91.218646] systemd[1]: Reached target Local File Systems. machine # [ 91.222665] systemd[1]: Starting linger-users.service... machine # [ 91.232162] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 91.240735] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 91.241672] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 91.242891] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 91.252536] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 91.254185] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.262491] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.295851] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 91.297798] systemd[1]: Finished linger-users.service. machine # [ 91.421984] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 91.424306] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 91.679570] nixos[6583]: finished switching to system configuration /nix/store/bk16lyhhcmr4z92mz9ss9fxxjwxrmhvs-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.65 seconds) (finished: subtest: unit file parser, in 22.34 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 91.881586] nixos[6723]: switching to system configuration /nix/store/3gx66a8k8b55mc1w5735vb0aiykd2nqw-nixos-system-machine-test machine # [ 91.884059] systemd[1]: Stopped target Remote File Systems. machine # [ 91.886773] systemd[1]: Stopped target Local File Systems. machine # [ 92.134521] systemd[1]: Reload requested from client PID 6723 ('.switch-to-conf') (unit backdoor.service)... machine # [ 92.136461] systemd[1]: Reloading... machine # [ 92.430247] systemd[1]: Reloading finished in 292 ms. machine # [ 92.513400] systemd[550]: Reexecution requested from client PID 6792 ('switch-to-confi')... machine # [ 92.517313] systemd[550]: Reexecuting. machine # [ 92.575034] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.686646] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.693095] systemd[550]: Reload requested from client PID 6792 ('switch-to-confi')... machine # [ 92.696083] systemd[550]: Reloading... machine # [ 92.798875] systemd[550]: Reloading finished in 103 ms. machine # [ 92.816163] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.826284] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 92.827238] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 92.829872] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 92.857213] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 92.860844] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 92.863134] systemd[1]: Stopping Reactivate sysinit units... machine # [ 92.865179] systemd[1]: Reached target Reactivate sysinit units. machine # [ 92.867800] systemd[1]: Reached target Remote File Systems. machine # [ 92.870885] systemd[1]: Reached target Local File Systems. machine # [ 92.874405] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 92.875767] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 92.880654] systemd[1]: Starting linger-users.service... machine # [ 92.883396] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 92.891255] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 92.899233] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 92.900775] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 92.903019] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 92.904849] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 92.906200] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 92.960981] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 92.963216] systemd[1]: Finished linger-users.service. machine # [ 93.081637] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 93.084340] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 93.340050] nixos[6723]: finished switching to system configuration /nix/store/3gx66a8k8b55mc1w5735vb0aiykd2nqw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.66 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 93.551722] nixos[6863]: switching to system configuration /nix/store/5b02nzd0pwz2459gd6prmii9rv94fipl-nixos-system-machine-test machine # [ 93.554607] systemd[1]: Stopped target Remote File Systems. machine # [ 93.558076] systemd[1]: test.service: Deactivated successfully. machine # [ 93.559620] systemd[1]: Stopped test.service. machine # [ 93.561214] systemd[1]: Stopped target Local File Systems. machine # [ 93.830122] systemd[1]: Reload requested from client PID 6863 ('.switch-to-conf') (unit backdoor.service)... machine # [ 93.832004] systemd[1]: Reloading... machine # [ 94.145760] systemd[1]: Reloading finished in 311 ms. machine # [ 94.228408] systemd[550]: Reexecution requested from client PID 6934 ('switch-to-confi')... machine # [ 94.229857] systemd[550]: Reexecuting. machine # [ 94.291076] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.403039] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.409232] systemd[550]: Reload requested from client PID 6934 ('switch-to-confi')... machine # [ 94.412151] systemd[550]: Reloading... machine # [ 94.513848] systemd[550]: Reloading finished in 102 ms. machine # [ 94.528155] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.537071] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 94.539251] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 94.541282] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 94.570096] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 94.574163] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 94.576758] systemd[1]: Stopping Reactivate sysinit units... machine # [ 94.577702] systemd[1]: Reached target Reactivate sysinit units. machine # [ 94.578586] systemd[1]: Reached target Remote File Systems. machine # [ 94.584458] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 94.588100] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 94.602170] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 94.606498] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 94.617283] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 94.618485] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 94.637669] systemd[1]: Starting linger-users.service... machine # [ 94.638512] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 94.639422] systemd[1]: Starting reload-triggers.service... machine # [ 94.664907] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 94.666230] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 94.700964] systemd[1]: Starting simple-reload-service.service... machine # [ 94.702072] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 94.703169] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 94.750737] systemd[1]: Starting no-restart-service.service... machine # [ 94.751673] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 94.785520] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 94.786711] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.834252] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 94.861719] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 94.877028] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 94.892251] systemd[1]: Reached target Local File Systems. machine # [ 94.901137] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 94.911792] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 94.920175] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 94.921571] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 94.923764] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 94.933902] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.935210] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.941542] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 94.942640] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 94.943662] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 94.951725] systemd[1]: Finished reload-triggers.service. machine # [ 94.953670] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 94.954794] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 94.955754] systemd[1]: Finished simple-reload-service.service. machine # [ 94.957151] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 94.959442] systemd[1]: Finished no-restart-service.service. machine # [ 94.961500] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 94.962518] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 94.963669] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 94.966409] systemd[1]: Finished linger-users.service. machine # [ 95.084528] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 95.088380] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 95.091854] systemd[1]: Starting simple-restart-service.service... machine # [ 95.095905] systemd[1]: Starting simple-service.service... machine # [ 95.103743] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 95.146609] systemd[1]: Finished simple-restart-service.service. machine # [ 95.149356] systemd[1]: Finished simple-service.service. machine # [ 95.150179] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 95.403938] nixos[6863]: finished switching to system configuration /nix/store/5b02nzd0pwz2459gd6prmii9rv94fipl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.06 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 95.640191] nixos[7033]: switching to system configuration /nix/store/5b02nzd0pwz2459gd6prmii9rv94fipl-nixos-system-machine-test machine # [ 95.642961] systemd[1]: Stopped target Local File Systems. machine # [ 95.645690] systemd[1]: Stopped target Remote File Systems. machine # [ 95.913336] systemd[1]: Reload requested from client PID 7033 ('.switch-to-conf') (unit backdoor.service)... machine # [ 95.915227] systemd[1]: Reloading... machine # [ 96.227823] systemd[1]: Reloading finished in 311 ms. machine # [ 96.316578] systemd[550]: Reexecution requested from client PID 7104 ('switch-to-confi')... machine # [ 96.318942] systemd[550]: Reexecuting. machine # [ 96.374948] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.481893] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.488572] systemd[550]: Reload requested from client PID 7104 ('switch-to-confi')... machine # [ 96.491889] systemd[550]: Reloading... machine # [ 96.592466] systemd[550]: Reloading finished in 101 ms. machine # [ 96.609513] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.617622] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 96.618648] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 96.621273] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 96.649142] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 96.652944] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 96.655922] systemd[1]: Stopping Reactivate sysinit units... machine # [ 96.659232] systemd[1]: Reached target Reactivate sysinit units. machine # [ 96.661534] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 96.666202] systemd[1]: Reloading reload-triggers.service... machine # [ 96.676076] systemd[1]: Reloading simple-reload-service.service... machine # [ 96.678340] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 96.696412] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 96.703969] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 96.761956] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 96.765016] systemd[1]: Reloaded reload-triggers.service. machine # [ 96.770449] systemd[1]: Reloaded simple-reload-service.service. machine # [ 96.771355] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 96.775098] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 96.780142] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 96.784158] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 96.785348] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 96.786399] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 96.791965] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 96.793275] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 96.794410] systemd[1]: Stopped simple-restart-service.service. machine # [ 96.795255] systemd[1]: Stopping simple-restart-service.service... machine # [ 96.800609] systemd[1]: Starting simple-restart-service.service... machine # [ 96.801555] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 96.802491] systemd[1]: Stopped simple-service.service. machine # [ 96.803237] systemd[1]: Stopping simple-service.service... machine # [ 96.807873] systemd[1]: Starting simple-service.service... machine # [ 96.816684] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 96.818085] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 96.819236] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 96.840250] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 96.841524] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 96.842795] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 96.843820] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 96.866650] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 96.867790] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 96.884503] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 96.893909] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 96.908303] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 96.919932] systemd[1]: Finished simple-service.service. machine # [ 96.927809] systemd[1]: Finished simple-restart-service.service. machine # [ 96.936465] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 96.937668] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 96.938624] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 96.939768] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 96.944406] systemd[1]: Reached target Remote File Systems. machine # [ 96.945230] systemd[1]: Reached target Local File Systems. machine # [ 96.946014] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 96.947477] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 96.957191] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 96.958594] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 96.964785] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 96.966448] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.967727] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.970704] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.974868] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 97.108458] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 97.109562] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 97.111387] systemd[1]: Starting linger-users.service... machine # [ 97.149615] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 97.152639] systemd[1]: Finished linger-users.service. machine # [ 97.406659] nixos[7033]: finished switching to system configuration /nix/store/5b02nzd0pwz2459gd6prmii9rv94fipl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.00 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 97.664578] nixos[7199]: switching to system configuration /nix/store/cwiiny4vcb3j8j82392ss7yzv0qrrdmr-nixos-system-machine-test machine # [ 97.667286] systemd[1]: Stopped target Remote File Systems. machine # [ 97.669455] systemd[1]: Stopped target Local File Systems. machine # [ 97.956627] systemd[1]: Reload requested from client PID 7199 ('.switch-to-conf') (unit backdoor.service)... machine # [ 97.958561] systemd[1]: Reloading... machine # [ 98.283262] systemd[1]: Reloading finished in 323 ms. machine # [ 98.375274] systemd[550]: Reexecution requested from client PID 7270 ('switch-to-confi')... machine # [ 98.378983] systemd[550]: Reexecuting. machine # [ 98.439207] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.549738] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.556345] systemd[550]: Reload requested from client PID 7270 ('switch-to-confi')... machine # [ 98.558676] systemd[550]: Reloading... machine # [ 98.661008] systemd[550]: Reloading finished in 101 ms. machine # [ 98.676141] systemd[550]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.685113] systemd[550]: Stopped Run user-specific NixOS activation. machine # [ 98.687341] systemd[550]: Stopping Run user-specific NixOS activation... machine # [ 98.689373] systemd[550]: Starting Run user-specific NixOS activation... machine # [ 98.718215] systemd[550]: Finished Run user-specific NixOS activation. machine # [ 98.722101] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 98.723020] systemd[1]: Stopping Reactivate sysinit units... machine # [ 98.723816] systemd[1]: Reached target Reactivate sysinit units. machine # [ 98.729615] systemd[1]: Reloading reload-triggers.service... machine # [ 98.738457] systemd[1]: Reloading simple-reload-service.service... machine # [ 98.745711] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 98.755158] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 98.781290] systemd[1]: Reloaded reload-triggers.service. machine # [ 98.805965] systemd[1]: Reloaded simple-reload-service.service. machine # [ 98.808232] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 98.810690] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 98.816348] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 98.817605] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 98.818600] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 98.826755] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 98.827798] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 98.833725] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 98.834692] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 98.835597] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 98.863643] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 98.869845] systemd[1]: Stopped simple-restart-service.service. machine # [ 98.870739] systemd[1]: Stopping simple-restart-service.service... machine # [ 98.871625] systemd[1]: Starting simple-restart-service.service... machine # [ 98.898607] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 98.899617] systemd[1]: Stopped simple-service.service. machine # [ 98.916144] systemd[1]: Stopping simple-service.service... machine # [ 98.929494] systemd[1]: Starting simple-service.service... machine # [ 98.940198] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 98.961190] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 98.971377] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 98.977674] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 98.979038] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 98.988365] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 98.991203] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 98.998308] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 98.999477] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 99.000839] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 99.001880] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 99.002935] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 99.003986] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 99.016925] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 99.017985] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 99.018956] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 99.019932] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 99.027711] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 99.036458] systemd[1]: Finished simple-restart-service.service. machine # [ 99.037364] systemd[1]: Finished simple-service.service. machine # [ 99.041776] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 99.047165] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 99.050950] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 99.053834] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 99.054831] systemd[1]: Reached target Remote File Systems. machine # [ 99.055651] systemd[1]: Starting linger-users.service... machine # [ 99.061222] systemd[1]: Reached target Local File Systems. machine # [ 99.062072] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 99.063520] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 99.068261] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 99.069542] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 99.071700] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 99.084197] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.085504] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.086695] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.087972] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 99.100636] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 99.103240] systemd[1]: Finished linger-users.service. machine # [ 99.226587] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 99.229553] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 99.485881] nixos[7199]: finished switching to system configuration /nix/store/cwiiny4vcb3j8j82392ss7yzv0qrrdmr-nixos-system-machine-test machine: (finished: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.08 seconds) machine: must succeed: /nix/store/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-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/nc0217jsnsvw4l1g4k3hf8pf1h5w86rz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.32 seconds) (finished: subtest: restart and reload by activation script, in 8.13 seconds) (finished: run the VM test script, in 102.16 seconds) test script finished in 102.19s cleanup kill QemuMachine (pid 45) machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14) machine # [2026-10-01T03:47:51Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-01T03:47:51Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-01T03:47:51Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.15 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