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.FUgFmAJtUq', 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: b07657d7-b3f1-4de9-b09f-c8d572bce93b 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-19T02:58:49Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-19T02:58:49Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-19T02:58:49Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-19T02:58:49Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-19T02:58:49Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-19T02:58:49Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-19T02:58:49Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-19T02:58:49Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-19T02:58:49Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-19T02:58:49Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-19T02:58:49Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-19T02:58:49Z INFO virtiofsd] Client connected, servicing requests machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.56 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT @1791725172 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 s186904 r8192 d116200 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/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/init regInfo=/nix/.ro-store/v0fcb43ml6pi7baara71aqhv4yzhip1f-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/v0fcb43ml6pi7baara71aqhv4yzhip1f-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 75049 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=512 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 @44ce0000 (indirect, esz 8, psz 64K, shr 1) machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1) machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000 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.000038] arm-pv: using stolen time PV machine # [ 0.000428] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000594] Console: colour dummy device 80x25 machine # [ 0.000604] printk: legacy console [tty0] enabled machine # [ 0.000805] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000812] pid_max: default: 32768 minimum: 301 machine # [ 0.000888] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.001036] landlock: Up and running. machine # [ 0.001039] Yama: becoming mindful. machine # [ 0.001493] LSM support for eBPF active machine # [ 0.001641] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.001665] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.003776] rcu: Hierarchical SRCU implementation. machine # [ 0.003782] rcu: Max phase no-delay instances is 1000. machine # [ 0.005116] fsl-mc MSI: its@8080000 domain created machine # [ 0.005249] EFI services will not be available. machine # [ 0.005339] smp: Bringing up secondary CPUs ... machine # [ 0.005349] smp: Brought up 1 node, 1 CPU machine # [ 0.005352] SMP: Total of 1 processors activated. machine # [ 0.005355] CPU: All CPU(s) started at EL1 machine # [ 0.005365] CPU features: detected: Branch Target Identification machine # [ 0.005370] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.005373] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.005376] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.005383] CPU features: detected: Common not Private translations machine # [ 0.005387] CPU features: detected: CRC32 instructions machine # [ 0.005389] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.005393] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.005396] CPU features: detected: Data independent timing control (DIT) machine # [ 0.005399] CPU features: detected: E0PD machine # [ 0.005401] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.005404] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.005408] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.005411] CPU features: detected: Fine Grained Traps machine # [ 0.005415] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.005420] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.005423] CPU features: detected: LSE atomic instructions machine # [ 0.005426] CPU features: detected: Privileged Access Never machine # [ 0.005428] CPU features: detected: PMUv3 machine # [ 0.005431] CPU features: detected: RAS Extension Support machine # [ 0.005434] CPU features: detected: RASv1p1 Extension Support machine # [ 0.005437] CPU features: detected: Random Number Generator machine # [ 0.005442] CPU features: detected: Speculation barrier (SB) machine # [ 0.005445] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.005448] CPU features: detected: TLB range maintenance instructions machine # [ 0.005453] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.005490] alternatives: applying system-wide alternatives machine # [ 0.009011] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.009673] Memory: 892688K/1048576K available (24512K kernel code, 7102K rwdata, 26572K rodata, 4736K init, 1184K bss, 114408K reserved, 32768K cma-reserved) machine # [ 0.010110] devtmpfs: initialized machine # [ 0.011944] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.011968] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.012144] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.012149] 0 pages in range for non-PLT usage machine # [ 0.012151] 508192 pages in range for PLT usage machine # [ 0.012272] pinctrl core: initialized pinctrl subsystem machine # [ 0.013192] DMI not present or invalid. machine # [ 0.016891] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.019385] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.019557] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.019717] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.019745] audit: initializing netlink subsys (disabled) machine # [ 0.020533] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.020536] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.020539] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.020542] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.020545] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.020571] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 machine # [ 0.020583] cpuidle: using governor ladder machine # [ 0.020589] cpuidle: using governor menu machine # [ 0.020790] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.020808] ASID allocator initialised with 65536 entries machine # [ 0.022175] Serial: AMBA PL011 UART driver machine # [ 0.028876] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.029044] printk: console [ttyAMA0] enabled machine # [ 0.165356] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.165374] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.165378] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.165380] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.165383] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.165386] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.165389] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.165392] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.167457] fbcon: Taking over console machine # [ 0.167474] ACPI: Interpreter disabled. machine # [ 0.185695] iommu: Default domain type: Translated machine # [ 0.185705] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.186125] SCSI subsystem initialized machine # [ 0.186356] usbcore: registered new interface driver usbfs machine # [ 0.186388] usbcore: registered new interface driver hub machine # [ 0.186412] usbcore: registered new device driver usb machine # [ 0.186706] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.186710] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.186719] PTP clock support registered machine # [ 0.186766] EDAC MC: Ver: 3.0.0 machine # [ 0.186979] scmi_core: SCMI protocol bus registered machine # [ 0.187376] FPGA manager framework machine # [ 0.188018] vgaarb: loaded machine # [ 0.188446] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.200760] VFS: Disk quotas dquot_6.6.0 machine # [ 0.200798] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.203413] netfs: FS-Cache loaded machine # [ 0.203545] pnp: PnP ACPI: disabled machine # [ 0.209440] NET: Registered PF_INET protocol family machine # [ 0.209603] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.243830] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.243880] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.243908] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.243959] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.244032] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.244185] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.244275] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.244333] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.252668] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.252696] NET: Registered PF_XDP protocol family machine # [ 0.252719] PCI: CLS 0 bytes, default 64 machine # [ 0.252995] Trying to unpack rootfs image as initramfs... machine # [ 0.259475] kvm [1]: HYP mode not available machine # [ 0.369140] Initialise system trusted keyrings machine # [ 0.369290] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.369711] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.369802] 9p: Installing v9fs 9p2000 file system support machine # [ 0.398708] Key type asymmetric registered machine # [ 0.398730] Asymmetric key parser 'x509' registered machine # [ 0.398845] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.399157] io scheduler mq-deadline registered machine # [ 0.399167] io scheduler kyber registered machine # [ 0.419418] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.420387] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.423499] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.423518] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.423533] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.423540] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.423569] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.423597] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.423728] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.423746] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.423752] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.423755] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.423758] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.423881] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.444769] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.445012] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.445035] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.445069] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.445084] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.453583] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.456362] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.456377] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.456409] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.469173] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.469378] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.469391] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.469417] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.470017] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.470206] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.470218] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.470244] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.470255] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.470727] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.470920] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.470947] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.471432] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.471623] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.471649] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.472059] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.472246] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.492635] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.492845] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.492872] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.493404] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.493594] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.493620] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.494205] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.494399] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.494425] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.494902] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.495228] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.495240] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.495266] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.495774] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.495970] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.495981] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.496009] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.516781] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.516797] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.516800] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.516853] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.516900] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.516946] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.517000] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.517047] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.517093] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.517139] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.517188] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.517232] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.517354] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.517401] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.517419] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.517436] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.517454] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.517471] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.517489] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.517507] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.517526] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.517545] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.517568] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.517586] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.517604] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.517622] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.517639] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.517657] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned machine # [ 0.517674] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned machine # [ 0.517692] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.517709] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.517738] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.517743] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.517828] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.518741] pci 0000:00:07.0: enabling device (0000 -> 0002) machine # [ 0.581942] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.914500] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.970592] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.973737] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 1.017990] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002) machine # [ 1.028711] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002) machine # [ 1.030772] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 1.034491] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 1.046139] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 1.048020] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 1.052019] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 1.100876] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 1.103221] msm_serial: driver initialized machine # [ 1.103383] SuperH (H)SCI(F) driver initialized machine # [ 1.103444] STM32 USART driver initialized machine # [ 1.144756] loop: module loaded machine # [ 1.144974] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 1.146180] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 1.151652] megasas: 07.734.00.00-rc1 machine # [ 1.153022] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 1.155270] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 1.155296] Intel/Sharp Extended Query Table at 0x0031 machine # [ 1.166051] Using buffer write method machine # [ 1.166108] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 1.167950] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 1.167969] Intel/Sharp Extended Query Table at 0x0031 machine # [ 1.182770] Using buffer write method machine # [ 1.182804] Concatenating MTD devices: machine # [ 1.182807] (0): "0.flash" machine # [ 1.182810] (1): "0.flash" machine # [ 1.182812] into device "0.flash" machine # [ 1.493562] Freeing initrd memory: 27164K machine # [ 1.502081] tun: Universal TUN/TAP device driver, 1.6 machine # [ 1.507308] thunder_xcv, ver 1.0 machine # [ 1.507346] thunder_bgx, ver 1.0 machine # [ 1.507367] nicpf, ver 1.0 machine # [ 1.508098] e1000: Intel(R) PRO/1000 Network Driver machine # [ 1.508103] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 1.508158] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 1.508165] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 1.508195] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 1.508201] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 1.508228] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 1.508235] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 1.508403] sky2: driver version 1.30 machine # [ 1.518301] usbcore: registered new interface driver usb-storage machine # [ 1.518384] usbcore: registered new interface driver usbserial_generic machine # [ 1.518395] usbserial: USB Serial support registered for generic machine # [ 1.519179] hv_vmbus: registering driver hyperv_keyboard machine # [ 1.520715] ehci-pci 0000:00:07.0: EHCI Host Controller machine # [ 1.520748] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1 machine # [ 1.520982] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000 machine # [ 1.527020] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 1.527055] rtc-pl031 9010000.pl031: setting system clock to 2026-10-19T02:58:54 UTC (1792378734) machine # [ 1.527471] i2c_dev: i2c /dev entries driver machine # [ 1.533868] sdhci: Secure Digital Host Controller Interface driver machine # [ 1.533875] sdhci: Copyright(c) Pierre Ossman machine # [ 1.534252] Synopsys Designware Multimedia Card Interface Driver machine # [ 1.534775] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 1.536497] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00 machine # [ 1.536949] hub 1-0:1.0: USB hub found machine # [ 1.537009] hub 1-0:1.0: 6 ports detected machine # [ 1.543262] hid: raw HID events driver (C) Jiri Kosina machine # [ 1.543542] usbcore: registered new interface driver usbhid machine # [ 1.543547] usbhid: USB HID core driver machine # [ 1.547202] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 1.550235] drop_monitor: Initializing network drop monitor service machine # [ 1.550440] NET: Registered PF_INET6 protocol family machine # [ 1.551909] Segment Routing with IPv6 machine # [ 1.551934] In-situ OAM (IOAM) with IPv6 machine # [ 1.551979] NET: Registered PF_PACKET protocol family machine # [ 1.552066] 9pnet: Installing 9P2000 support machine # [ 1.552121] Key type dns_resolver registered machine # [ 1.563752] registered taskstats version 1 machine # [ 1.563989] Loading compiled-in X.509 certificates machine # [ 1.573212] Demotion targets for Node 0: null machine # [ 1.573356] Key type .fscrypt registered machine # [ 1.573361] Key type fscrypt-provisioning registered machine # [ 1.573485] ima: No TPM chip found, activating TPM-bypass! machine # [ 1.573512] ima: Allocated hash algorithm: sha1 machine # [ 1.573535] ima: No architecture policies found machine # [ 1.574573] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 1.600147] clk: Disabling unused clocks machine # [ 1.600170] PM: genpd: Disabling unused power domains machine # [ 1.604632] Freeing unused kernel memory: 4736K machine # [ 1.604837] Run /init as init process machine # [ 1.627398] fuse: init (API version 7.45) machine # [ 1.631282] virtiofs virtio6: discovered new tag: nix-store machine # [ 1.632116] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 1.647071] virtiofs virtio7: discovered new tag: shared machine # [ 1.647839] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 1.651428] virtiofs virtio8: discovered new tag: xchg machine # [ 1.652191] virtiofs virtio8: virtio_fs_setup_dax: No cache capability machine # [ 1.663355] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.663853] systemd[1]: systemd 263-7f4df15 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR) machine # [ 1.663868] systemd[1]: Detected virtualization qemu. machine # [ 1.663889] systemd[1]: Detected architecture arm64. machine # [ 1.663894] systemd[1]: Running in initrd. machine # [ 1.664193] systemd[1]: Initializing machine ID from random generator. machine # [ 1.664310] systemd[1]: Hostname set to . machine # [ 1.761290] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.792599] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.820788] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.830625] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.830816] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.830843] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.830864] systemd[1]: Reached target Path Units. machine # [ 1.830876] systemd[1]: Reached target Slice Units. machine # [ 1.830889] systemd[1]: Reached target Swaps. machine # [ 1.830902] systemd[1]: Reached target Timer Units. machine # [ 1.831031] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.831177] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.831298] systemd[1]: Listening on Journal Sockets. machine # [ 1.831374] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.831387] systemd[1]: Reached target Socket Units. machine # [ 1.841478] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.841550] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.848618] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.859004] systemd[1]: Starting Journal Service... machine # [ 1.888694] systemd[1]: Starting Load Kernel Modules... machine # [ 1.888812] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.928703] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.932354] systemd-journald[71]: Collecting audit messages is disabled. machine # [ 1.938316] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.949600] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.950548] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.964645] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.974409] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.980743] 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.992917] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0 machine # [ 1.993179] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.993182] [drm] features: -context_init machine # [ 1.994226] [drm] number of scanouts: 1 machine # [ 1.994242] [drm] number of cap sets: 0 machine # [ 2.000193] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic machine # [ 2.000204] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0 machine # [ 2.028644] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 2.030559] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 2.052609] Console: switching to colour frame buffer device 160x50 machine # [ 2.053314] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 2.066382] systemd[1]: Finished Load Kernel Modules. machine # [ 2.072823] 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 # [ 2.080683] systemd[1]: Starting Apply Kernel Variables... machine # [ 2.097683] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 2.098102] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 2.098898] systemd[1]: Reached target Local File Systems. machine # [ 2.116862] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 2.124955] systemd-modules-load[73]: Inserted module 'dm_mod' machine # [ 2.126192] systemd-modules-load[73]: Module 'virtio_balloon' is built in machine # [ 2.127369] systemd-modules-load[73]: Module 'virtio_console' is built in machine # [ 2.148979] systemd[1]: Finished Apply Kernel Variables. machine # [ 2.149374] systemd[1]: Started Journal Service. machine # [ 2.133828] systemd-modules-load[73]: Inserted module 'virtio_gpu' machine # [ 2.144440] systemd-modules-load[73]: Module 'virtio_rng' is built in machine # [ 2.157228] systemd[1]: Starting Create System Files and Directories... machine # [ 2.192561] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 2.193095] systemd-udevd[80]: Using default interface naming scheme 'v261'. machine # [ 2.201850] systemd[1]: Finished Create System Files and Directories. machine # [ 2.233499] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 2.355465] 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 # [ 2.360068] 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 # [ 2.381531] systemd[1]: Starting Virtual Console Setup... machine # [ 2.517172] systemd-vconsole-setup[98]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.520841] systemd[1]: Finished Virtual Console Setup. machine # [ 3.288114] (udev-worker)[91]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 3.326033] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line. machine # [ 3.367151] systemd[1]: Finished Coldplug All udev Devices. machine # [ 3.372320] systemd[1]: Reached target System Initialization. machine # [ 3.373212] systemd[1]: Reached target Basic System. machine # [ 3.431577] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 3.432774] systemd[1]: Reached target Initrd Root Device. machine # [ 3.436177] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 3.491860] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 3.502310] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 3.509087] systemd[1]: Mounting /sysroot... machine # [ 3.563645] systemd[1]: Mounted /sysroot.[ 3.581589] EXT4-fs (vda): mounted filesystem b07657d7-b3f1-4de9-b09f-c8d572bce93b r/w with ordered data mode. Quota mode: none. machine # machine # [ 3.567977] systemd[1]: Reached target Initrd Root File System. machine # [ 3.578694] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.589783] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.599925] systemd[1]: Mounting /sysroot/run... machine # [ 3.631430] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.661349] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.691237] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 3.695321] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.731367] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.795958] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.798345] systemd[1]: Mounted /sysroot/run. machine # [ 3.799871] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.812504] systemd-sysroot-fstab-check[124]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 3.828187] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.842145] systemd[1]: Reload requested from client PID 124 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 3.867035] systemd[1]: Reloading... machine # [ 4.093122] systemd[1]: Reloading finished in 242 ms. machine # [ 4.131285] systemd-sysroot-fstab-check[124]: Requesting initrd-fs.target/start/replace... machine # [ 4.137019] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.140822] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.147275] systemd-sysroot-fstab-check[124]: Requesting swap.target/start/replace... machine # [ 4.154527] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 4.158421] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 4.162463] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 4.168669] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.195345] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.198602] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.201218] systemd[1]: Mounting /sysroot/nix/store... machine # [ 4.256901] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.259567] systemd[1]: Reached target Initrd File Systems. machine # [ 4.262034] systemd[1]: Starting Find NixOS closure... machine # [ 4.270970] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.316539] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.318936] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 4.335514] systemd[1]: Finished Find NixOS closure. machine # [ 4.339199] systemd[1]: Reached target Initrd Default Target. machine # [ 4.346141] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.378987] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.381212] systemd[1]: Stopped target Basic System. machine # [ 4.382781] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.383799] systemd[1]: Stopped target Path Units. machine # [ 4.388233] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.391407] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.393851] systemd[1]: Stopped target Slice Units. machine # [ 4.395652] systemd[1]: Stopped target Socket Units. machine # [ 4.398373] systemd[1]: Stopped target System Initialization. machine # [ 4.401506] systemd[1]: Stopped target Swaps. machine # [ 4.403592] systemd[1]: Stopped target Timer Units. machine # [ 4.409982] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.411945] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.414694] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.421649] systemd[1]: Stopped Find NixOS closure. machine # [ 4.422500] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.424597] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.426759] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.429920] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.433218] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.437026] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.441101] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.444243] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.452281] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.453466] systemd[1]: Stopped target Local File Systems. machine # [ 4.454506] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.461467] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.464290] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.467260] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.472443] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.476227] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.477116] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.478166] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.479724] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.481177] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.487280] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.490881] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.497012] systemd[1]: Starting Cleanup udev Database... machine # [ 4.498704] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.499957] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.501460] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.502647] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.503682] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.509911] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.536507] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.540736] systemd[1]: Finished Cleanup udev Database. machine # [ 4.542901] systemd[1]: Reached target Switch Root. machine # [ 4.548275] systemd[1]: Starting NixOS Activation... machine # [ 4.652427] initrd-nixos-activation-start[171]: booting system configuration /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test machine # [ 4.694914] initrd-nixos-activation-start[171]: running activation script... machine # [ 5.023483] initrd-nixos-activation-start[194]: setting up /etc... machine # [ 5.166858] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 5.169998] systemd[1]: Finished NixOS Activation. machine # [ 5.171265] systemd[1]: Starting Switch Root... machine # [ 5.197261] systemd[1]: Switching root. machine # [ 5.385333] systemd-journald[71]: Received SIGTERM from PID 1 (systemd). machine # [ 5.464083] NET: Registered PF_VSOCK protocol family machine # [ 5.545141] systemd[1]: systemd 263-7f4df15 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR) machine # [ 5.546149] systemd[1]: Detected virtualization qemu. machine # [ 5.546235] systemd[1]: Detected architecture arm64. machine # [ 5.546359] systemd[1]: Detected first boot. machine # [ 5.548378] systemd[1]: Initializing machine ID from random generator. machine # [ 5.686185] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 5.933638] systemd[1]: Applying preset policy. machine # [ 6.187450] systemd[1]: Populated /etc with preset unit settings. machine # [ 6.451888] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 6.454925] systemd[1]: Stopped initrd-switch-root.service. machine # [ 6.459790] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 6.465330] systemd[1]: Created slice Slice /system/getty. machine # [ 6.467275] systemd[1]: Created slice User and Session Slice. machine # [ 6.468113] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 6.473107] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 6.473795] systemd[1]: Expecting device /dev/hvc0... machine # [ 6.474550] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 6.475248] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 6.475915] systemd[1]: Stopped target initrd-fs.target. machine # [ 6.482625] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 6.483253] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 6.484087] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 6.488937] systemd[1]: Reached target Path Units. machine # [ 6.489551] systemd[1]: Reached target Remote File Systems. machine # [ 6.490466] systemd[1]: Reached target Slice Units. machine # [ 6.491254] systemd[1]: Reached target Swaps. machine # [ 6.497552] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 6.501781] systemd[1]: Listening on Process Core Dump Socket. machine # [ 6.503527] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 6.507654] systemd[1]: Listening on Factory Reset Management. machine # [ 6.508328] systemd[1]: Listening on Hostname Service Socket. machine # [ 6.514156] systemd[1]: Starting Journal Log Access Socket... machine # [ 6.515969] systemd[1]: Listening on Journal Audit Socket. machine # [ 6.522560] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 6.526007] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 6.526600] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.527387] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 6.536330] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 6.542783] systemd[1]: Listening on udev Varlink Socket. machine # [ 6.547179] systemd[1]: Mounting Huge Pages File System... machine # [ 6.552307] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 6.569331] systemd[1]: Mounting Kernel Debug File System... machine # [ 6.579361] systemd[1]: Mounting Kernel Trace File System... machine # [ 6.597642] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 6.601849] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 6.617386] systemd[1]: Mounting Kernel Configuration File System... machine # [ 6.624749] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 6.625395] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.633939] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 6.657666] systemd[1]: Mounting FUSE Control File System... machine # [ 6.658151] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.697909] systemd[1]: Starting Journal Service... machine # [ 6.722021] systemd[1]: Starting Load Kernel Modules... machine # [ 6.747844] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 6.779378] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 6.779798] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.811784] systemd[1]: Starting Coldplug All udev Devices... machine # [ 6.822617] systemd-journald[266]: Collecting audit messages is enabled. machine # [ 6.839515] systemd[1]: Queued start job for default target Multi-User System. machine # [ 6.840986] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0. machine # [ 6.842530] systemd[1]: Unnecessary job was removed for /sys/devices/platform/9000000.pl011/9000000.pl011:0/9000000.pl011:0.0/tty/ttyAMA0. machine # [ 6.850409] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 6.867538] systemd[1]: Started Journal Service. machine # [ 6.857216] systemd[1]: Listening on Journal Log Access Socket. machine # [ 6.858453] systemd[1]: Mounted Huge Pages File System. machine # [ 6.859393] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 6.876593] systemd[1]: Mounted Kernel Debug File System. machine # [ 6.877585] systemd[1]: Mounted Kernel Trace File System. machine # [ 6.878404] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 6.879274] systemd[1]: Mounted Kernel Configuration File System. machine # [ 6.888600] systemd-modules-load[267]: Module 'atkbd' is built in machine # [ 6.891203] systemd-modules-load[267]: Module 'loop' is built in machine # [ 6.916591] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 6.926802] systemd[1]: Finished Load Kernel Modules. machine # [ 6.936872] systemd[1]: Starting Firewall... machine # [ 6.967152] systemd-oomd[268]: No swap; memory pressure usage will be degraded machine # [ 6.977098] systemd[1]: Starting Apply Kernel Variables... machine # [ 7.000744] EXT4-fs (vda): re-mounted b07657d7-b3f1-4de9-b09f-c8d572bce93b. machine # [ 6.986935] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 7.019489] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 7.024248] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 7.028561] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 7.029783] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 7.048208] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 7.049224] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.050602] systemd[1]: Mounted FUSE Control File System. machine # [ 7.177412] systemd-journald[266]: Received client request to flush runtime journal. machine # [ 7.256479] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 7.257719] systemd[1]: Reached target First Boot Complete. machine # [ 7.258588] systemd[1]: Finished Apply Kernel Variables. machine # [ 7.268318] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 7.274073] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 7.284487] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 7.446030] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 7.447199] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 7.456250] systemd[1]: Mounting /run/wrappers... machine # [ 7.461693] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 7.553056] systemd[1]: Mounted /run/wrappers. machine # [ 7.553954] systemd[1]: Reached target Local File Systems. machine # [ 7.563045] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 7.570774] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 7.571718] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 7.580309] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 7.597809] systemd[1]: Starting Create System Files and Directories... machine # [ 7.743950] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 7.759773] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 7.774470] systemd-udevd[304]: Using default interface naming scheme 'v261'. machine # [ 7.877024] systemd[1]: Finished Create System Files and Directories. machine # [ 7.889392] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 7.902305] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 7.968206] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 8.097464] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 8.154014] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 8.175220] systemd[1]: Starting Update is Completed... machine # [ 8.288941] systemd[1]: Finished Update is Completed. machine # [ 8.757327] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 8.760159] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 9.198110] systemd[1]: Finished Coldplug All udev Devices. machine # [ 9.201428] systemd[1]: Reached target System Initialization. machine # [ 9.202498] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 9.203579] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 9.210955] systemd[1]: Reached target Timer Units. machine # [ 9.211776] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 9.218904] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 9.226137] systemd[1]: Reached target Socket Units. machine # [ 9.227001] systemd[1]: Reached target Basic System. machine # [ 9.227780] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 9.240783] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 9.241985] systemd[1]: Starting Post-Boot Actions... machine # [ 9.255306] systemd[1]: Started Reset console on configuration changes. machine # [ 9.290845] systemd[1]: Starting resolvconf update... machine # [ 9.401955] systemd[1]: Starting D-Bus System Message Bus... machine # [ 9.432362] nsncd[424]: Oct 19 02:59:02.421 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 9.451734] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 9.465138] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 9.466376] systemd[1]: Reached target User and Group Name Lookups. machine # [ 9.529164] systemd[1]: Starting User Login Management... machine # [ 9.535988] systemd[1]: Finished Post-Boot Actions. machine # [ 9.630761] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 9.717089] dbus-broker-launch[435]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 9.733373] dbus-broker-launch[435]: NSS returned no entry for 'systemd-timesync' machine # [ 9.734800] dbus-broker-launch[435]: Invalid user-name in /nix/store/z9jw4jl1zhp2qfzafdw18wrj4h89aqqf-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 9.765776] systemd[1]: Started D-Bus System Message Bus. machine # [ 9.815171] systemd-logind[450]: New seat seat0. machine # [ 9.821031] systemd[1]: Started User Login Management. machine # [ 9.826500] dbus-broker-launch[435]: Ready machine # [ 9.834174] systemd[1]: Starting linger-users.service... machine # [ 9.914325] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 9.922848] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 9.927239] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 9.931977] systemd[1]: Stopping User and Group Name Lookups... machine # [ 9.933123] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 9.934163] systemd[1]: nscd.service: Deactivated successfully. machine # [ 9.942941] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 9.968954] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 10.048627] systemd[1]: Created slice Slice /user/1001. machine # [ 10.063137] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 10.099989] nsncd[512]: Oct 19 02:59:03.073 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 10.117156] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 10.126576] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 10.131721] systemd[1]: Finished linger-users.service. machine # [ 10.138983] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 10.144356] systemd[1]: Reached target User and Group Name Lookups. machine # [ 10.197385] systemd[1]: Finished resolvconf update. machine # [ 10.201761] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 10.222687] systemd[1]: Starting DHCP Client... machine # [ 10.265997] systemd[1]: Starting User Manager for UID 1001... machine # [ 10.471746] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3 machine # [ 10.552719] (systemd)[554]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 10.607765] systemd-logind[450]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 10.720504] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 10.950543] systemd[554]: Queued start job for default target Main User Target. machine # [ 10.972871] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 10.975321] systemd[554]: Created slice User Application Slice. machine # [ 10.998255] systemd[554]: Started Daily Cleanup of User's Temporary Directories. machine # [ 11.023340] systemd[554]: Reached target Paths. machine # [ 11.036236] systemd[554]: Reached target Timers. machine # [ 11.037129] systemd[554]: Starting D-Bus User Message Bus Socket... machine # [ 11.038224] systemd[554]: Starting Create User Files and Directories... machine # [ 11.039287] systemd[554]: Finished Create User Files and Directories. machine # [ 11.095142] systemd[554]: Listening on D-Bus User Message Bus Socket. machine # [ 11.113851] systemd[554]: Reached target Sockets. machine # [ 11.129553] systemd[554]: Reached target Basic System. machine # [ 11.130553] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 11.131700] systemd[1]: Started User Manager for UID 1001. machine # [ 11.165740] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 11.176754] systemd[554]: Reached target Main User Target. machine # [ 11.188689] systemd[554]: Startup finished in 482ms. machine # [ 11.257096] systemd[1]: Finished Firewall. machine # [ 11.282553] systemd[1]: Reached target Preparation for Network. machine # [ 11.298107] systemd[1]: Starting Extra networking commands.... machine # [ 11.360155] systemd[1]: Starting Virtual Console Setup... machine # [ 11.401985] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 11.452800] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 11.493679] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 11.502820] systemd[1]: Stopped Virtual Console Setup. machine # [ 11.524215] dhcpcd[569]: dhcpcd-10.3.2 starting machine # [ 11.538287] systemd[1]: Starting Virtual Console Setup... machine # [ 11.582368] dhcpcd[606]: dev: loaded udev machine # [ 11.597386] dhcpcd[606]: no valid interfaces found machine # [ 11.612569] dhcpcd[606]: no valid interfaces found machine # [ 11.647416] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 11.695903] dhcpcd[606]: libudev: received NULL device machine # [ 11.717347] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 11.739021] dhcpcd[606]: libudev: received NULL device machine # [ 11.760829] systemd[1]: Started backdoor.service. machine # [ 11.878608] 8021q: 802.1Q VLAN Support v1.8 machine # [ 11.932884] (udev-worker)[590]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 12.023103] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 12.029185] (udev-worker)[590]: Network interface NamePolicy= disabled on kernel command line. machine # [ 12.179595] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 12.180200] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 12.183578] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 12.183926] cfg80211: failed to load regulatory.db machine # [ 12.281043] systemd-logind[450]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # [ 12.390439] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 12.419150] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 12.438134] systemd[1]: Starting Address configuration of eth1... machine # connecting to host... machine # [ 12.639097] mousedev: PS/2 mouse device common for all mice machine # [ 12.744136] systemd-logind[450]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 13.23 seconds) machine: (finished: waiting for the VM to finish booting, in 16.88 seconds) machine # [ 12.953918] dhcpcd[643]: /nix/store/92w4pf1lqszlcwfq9ma2y2vaad5dssks-openresolv-3.17.4/sbin/.resolvconf-wrapped: line 1250: kill: (608) - Operation not permitted machine # [ 13.005490] dhcpcd[643]: .resolvconf-wrapped: clearing stale lock pid 608 machine # [ 13.105468] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 13.263710] network-addresses-eth1-start[624]: adding address 192.168.1.1/24... done machine # [ 13.374836] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 13.372318] dhcpcd[606]: eth0: waiting for carrier machine # [ 13.373372] dhcpcd[606]: eth0: carrier acquired machine # [ 13.402123] network-addresses-eth1-start[624]: adding address 2001:db8:1::1/64... done machine # [ 13.502000] dhcpcd[606]: DUID 00:01:00:01:32:68:43:fa:52:54:00:12:34:56 machine # [ 13.503321] dhcpcd[606]: eth0: IAID 00:12:34:56 machine # [ 13.534699] dhcpcd[606]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 13.582059] systemd[1]: Finished Address configuration of eth1. machine # [ 13.698833] systemd-vconsole-setup[604]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 13.727598] systemd[1]: Finished Extra networking commands.. machine # [ 13.737929] systemd[1]: Reached target Network. machine # [ 13.738791] systemd[1]: Starting Permit User Sessions... machine # [ 13.739612] systemd[1]: Finished Virtual Console Setup. machine # [ 13.806595] systemd[1]: Finished Permit User Sessions. machine # [ 13.814654] systemd[1]: Started Getty on tty1. machine # [ 13.815508] systemd[1]: Reached target Login Prompts. machine # [ 14.451678] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 14.465425] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 14.489757] systemd[1]: Stopped Virtual Console Setup. machine # [ 14.490632] systemd[1]: Stopping Virtual Console Setup... machine # [ 14.491419] systemd[1]: Starting Virtual Console Setup... machine # [ 14.517396] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 14.520508] systemd[1]: Stopped Virtual Console Setup. machine # [ 14.529401] systemd-logind[450]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 14.530822] systemd[1]: Starting Virtual Console Setup... machine # [ 14.638192] systemd-vconsole-setup[720]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 14.646345] systemd[1]: Finished Virtual Console Setup. machine # [ 14.878594] dhcpcd[606]: eth0: soliciting a DHCP lease machine # [ 14.880774] dhcpcd[606]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 14.888321] dhcpcd[606]: eth0: probing address 10.0.2.15/24 machine # [ 15.141924] dhcpcd[606]: eth0: soliciting an IPv6 router machine # [ 15.144655] dhcpcd[606]: eth0: Router Advertisement from fe80::2 machine # [ 15.146201] dhcpcd[606]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 15.147826] dhcpcd[606]: eth0: adding route to fec0::/64 machine # [ 15.149256] dhcpcd[606]: eth0: adding default route via fe80::2 machine # [ 20.209027] dhcpcd[606]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 20.211116] dhcpcd[606]: eth0: adding route to 10.0.2.0/24 machine # [ 20.214957] dhcpcd[606]: eth0: adding default route via 10.0.2.2 machine # [ 20.304651] systemd[1]: Started DHCP Client. machine # [ 20.306646] systemd[1]: Reached target Multi-User System. machine # [ 20.307567] systemd[1]: Startup finished in 1.590s (kernel) + 3.834s (initrd) + 14.882s (userspace) = 20.306s. machine: (finished: waiting for unit multi-user.target, in 25.30 seconds) machine: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 21.462205] nixos[845]: switching to system configuration /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test machine # [ 21.464957] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # [ 21.468263] systemd[1]: Stopped target Local File Systems. machine # setting up /etc... machine # [ 21.776357] systemd[1]: Reload requested from client PID 845 ('.switch-to-conf') (unit backdoor.service)... machine # [ 21.778461] systemd[1]: Reloading... machine # [ 22.101981] systemd[1]: Reloading finished in 322 ms. machine # reloading user units for usertest... machine # [ 22.162184] systemd[554]: Created slice User Core Session Slice. machine # [ 22.168697] systemd[554]: Starting D-Bus User Message Bus... machine # [ 22.213908] dbus-broker-launch[915]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/z9jw4jl1zhp2qfzafdw18wrj4h89aqqf-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 22.217272] dbus-broker-launch[915]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/z9jw4jl1zhp2qfzafdw18wrj4h89aqqf-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 22.220292] dbus-broker-launch[915]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/z9jw4jl1zhp2qfzafdw18wrj4h89aqqf-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 22.223282] dbus-broker-launch[915]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/z9jw4jl1zhp2qfzafdw18wrj4h89aqqf-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 22.228165] dbus-broker-launch[915]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 22.230054] dbus-broker-launch[915]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 22.231714] systemd[554]: Started D-Bus User Message Bus. machine # [ 22.237513] dbus-broker-launch[915]: Ready machine # [ 22.284609] systemd[554]: Reexecution requested from client PID 914 ('switch-to-confi')... machine # [ 22.299535] systemd[554]: Reexecuting. machine # [ 22.344530] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.458193] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.465343] systemd[554]: Reload requested from client PID 914 ('switch-to-confi')... machine # [ 22.467899] systemd[554]: Reloading... machine # [ 22.574739] systemd[554]: Reloading finished in 105 ms. machine # [ 22.594271] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 22.603529] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 22.606123] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 22.608324] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 22.642984] systemd[554]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 22.657093] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 22.778500] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 22.784445] systemd[1]: Reached target Reactivate sysinit units. machine # [ 22.795774] systemd[1]: Reached target Local File Systems. machine # [ 22.801721] systemd[1]: Reached target Remote File Systems. machine # [ 22.802768] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.816773] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 22.818391] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 22.821994] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 22.822981] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 22.824608] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 22.827053] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 22.828969] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.830370] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.019793] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 23.023052] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 23.028207] systemd[1]: Starting linger-users.service... machine # [ 23.072927] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 23.075994] systemd[1]: Finished linger-users.service. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 23.350425] nixos[845]: finished switching to system configuration /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/bin/switch-to-configuration test, in 2.11 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.04 seconds) machine: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/sd3ny98qwx01nnzapz0yhjixinx1hajs-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/sd3ny98qwx01nnzapz0yhjixinx1hajs-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 23.874892] nixos[993]: switching to system configuration /nix/store/sd3ny98qwx01nnzapz0yhjixinx1hajs-nixos-system-other-test machine # [ 23.878798] systemd[1]: Stopped target Local File Systems. machine # [ 23.880313] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 24.171347] systemd[1]: Reload requested from client PID 993 ('.switch-to-conf') (unit backdoor.service)... machine # [ 24.173577] systemd[1]: Reloading... machine # [ 24.581356] systemd[1]: Reloading finished in 405 ms. machine # reloading user units for usertest... machine # [ 24.713586] systemd[554]: Reexecution requested from client PID 1064 ('switch-to-confi')... machine # [ 24.719630] systemd[554]: Reexecuting. machine # [ 24.797503] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.947998] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.956914] systemd[554]: Reload requested from client PID 1064 ('switch-to-confi')... machine # [ 24.958462] systemd[554]: Reloading... machine # [ 25.078623] systemd[554]: Reloading finished in 118 ms. machine # [ 25.096204] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 25.109152] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 25.111883] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 25.114541] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 25.151268] systemd[554]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 25.156515] systemd[1]: Stopped target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service machine # [ 25.162877] systemd[1]: Stopping Reactivate sysinit units... machine # [ 25.165485] systemd[1]: Reached target Reactivate sysinit units. machine # [ 25.166835] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 25.168632] dbus-broker-launch[435]: Caught SIGHUP, trigger reload. machine # [ 25.171649] dbus-broker-launch[435]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 25.174134] dbus-broker-launch[435]: NSS returned no entry for 'systemd-timesync' machine # [ 25.175254] dbus-broker-launch[435]: Invalid user-name in /nix/store/hca0rm58yvgb52lj29w020hkxchcm7mp-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 25.193473] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 25.200881] systemd[1]: Stopping Address configuration of eth1... machine # [ 25.234396] network-addresses-eth1-pre-stop[1076]: deleting address 192.168.1.1/24... done machine # [ 25.242179] network-addresses-eth1-pre-stop[1076]: deleting address 2001:db8:1::1/64... done machine # [ 25.250605] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 25.253043] systemd[1]: Stopped Address configuration of eth1. machine # [ 25.258708] systemd[1]: Starting Address configuration of eth1... machine # [ 25.321948] network-addresses-eth1-start[1081]: adding address 192.168.1.2/24... done machine # [ 25.339115] network-addresses-eth1-start[1081]: adding address 2001:db8:1::2/64... done machine # [ 25.361059] systemd[1]: Finished Address configuration of eth1. machine # [ 25.372499] systemd[1]: Reached target Local File Systems. machine # [ 25.373618] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 25.379962] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 25.382630] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 25.383986] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 25.407950] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 25.410486] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.411841] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.417409] systemd[1]: Reached target Remote File Systems. machine # [ 25.419513] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.422213] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 25.671161] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 25.673690] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 25.690177] systemd[1]: Starting linger-users.service... machine # [ 25.727628] linger-users-start[1154]: id: ‘usertest’: no such user machine # [ 25.730239] linger-users-start[1152]: Removing linger for missing user usertest machine # [ 25.738708] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 25.740735] systemd[1]: Finished linger-users.service. machine # [ 25.998347] nixos[993]: finished switching to system configuration /nix/store/sd3ny98qwx01nnzapz0yhjixinx1hajs-nixos-system-other-test machine: (finished: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/sd3ny98qwx01nnzapz0yhjixinx1hajs-nixos-system-other-test/bin/switch-to-configuration test, in 2.61 seconds) subtest: services machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 26.271432] nixos[1160]: switching to system configuration /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test machine # [ 26.274743] systemd[1]: Stopped target Remote File Systems. machine # [ 26.277225] systemd[1]: Stopped target Local File Systems. machine # [ 26.587732] systemd[1]: Reload requested from client PID 1160 ('.switch-to-conf') (unit backdoor.service)... machine # [ 26.590201] systemd[1]: Reloading... machine # [ 26.948326] systemd[1]: Reloading finished in 356 ms. machine # [ 27.041629] systemd[554]: Reexecution requested from client PID 1229 ('switch-to-confi')... machine # [ 27.046334] systemd[554]: Reexecuting. machine # [ 27.105253] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.225333] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.232613] systemd[554]: Reload requested from client PID 1229 ('switch-to-confi')... machine # [ 27.236099] systemd[554]: Reloading... machine # [ 27.346846] systemd[554]: Reloading finished in 111 ms. machine # [ 27.364419] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.374726] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 27.377547] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 27.379877] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 27.415852] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 27.422309] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 27.426852] systemd[1]: Stopping Reactivate sysinit units... machine # [ 27.427838] systemd[1]: Reached target Reactivate sysinit units. machine # [ 27.430596] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 27.432830] dbus-broker-launch[435]: Caught SIGHUP, trigger reload. machine # [ 27.435591] dbus-broker-launch[435]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 27.438142] dbus-broker-launch[435]: NSS returned no entry for 'systemd-timesync' machine # [ 27.439278] dbus-broker-launch[435]: Invalid user-name in /nix/store/z9jw4jl1zhp2qfzafdw18wrj4h89aqqf-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 27.460318] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 27.467583] systemd[1]: Stopping Address configuration of eth1... machine # [ 27.505442] network-addresses-eth1-pre-stop[1241]: deleting address 192.168.1.2/24... done machine # [ 27.514961] network-addresses-eth1-pre-stop[1241]: deleting address 2001:db8:1::2/64... done machine # [ 27.524182] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 27.527555] systemd[1]: Stopped Address configuration of eth1. machine # [ 27.533848] systemd[1]: Starting Address configuration of eth1... machine # [ 27.587698] network-addresses-eth1-start[1246]: adding address 192.168.1.1/24... done machine # [ 27.598027] network-addresses-eth1-start[1246]: adding address 2001:db8:1::1/64... done machine # [ 27.610349] systemd[1]: Finished Address configuration of eth1. machine # [ 27.617237] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.622103] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 27.627206] systemd[1]: Reached target Remote File Systems. machine # [ 27.634093] systemd[1]: Starting linger-users.service... machine # [ 27.644374] systemd[1]: Reached target Local File Systems. machine # [ 27.645509] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 27.658144] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 27.659272] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 27.667018] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 27.673939] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 27.680794] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.687192] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.727872] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 27.730991] systemd[1]: Finished linger-users.service. machine # [ 27.896705] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 27.898737] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 28.156342] nixos[1160]: finished switching to system configuration /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.16 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 28.397209] nixos[1315]: switching to system configuration /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test machine # [ 28.402499] systemd[1]: Stopped target Remote File Systems. machine # [ 28.404890] systemd[1]: Stopped target Local File Systems. machine # [ 28.754967] systemd[1]: Reload requested from client PID 1315 ('.switch-to-conf') (unit backdoor.service)... machine # [ 28.757258] systemd[1]: Reloading... machine # [ 29.079757] systemd[1]: Reloading finished in 321 ms. machine # [ 29.175706] systemd[554]: Reexecution requested from client PID 1385 ('switch-to-confi')... machine # [ 29.180445] systemd[554]: Reexecuting. machine # [ 29.227377] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.343473] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.351376] systemd[554]: Reload requested from client PID 1385 ('switch-to-confi')... machine # [ 29.355325] systemd[554]: Reloading... machine # [ 29.474170] systemd[554]: Reloading finished in 119 ms. machine # [ 29.488238] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.499234] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 29.501780] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 29.504544] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 29.540552] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 29.546053] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 29.547341] systemd[1]: Stopping Reactivate sysinit units... machine # [ 29.550184] systemd[1]: Reached target Reactivate sysinit units. machine # [ 29.554134] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.555569] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 29.559846] systemd[1]: Reached target Remote File Systems. machine # [ 29.564567] systemd[1]: Starting linger-users.service... machine # [ 29.570140] systemd[1]: Reached target Local File Systems. machine # [ 29.571084] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 29.586308] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 29.587305] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 29.592665] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 29.595196] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 29.597044] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.598361] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.662281] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 29.665725] systemd[1]: Finished linger-users.service. machine # [ 29.796992] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 29.800785] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 30.056240] nixos[1315]: finished switching to system configuration /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.90 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 30.292214] nixos[1456]: switching to system configuration /nix/store/gg9p0ll87anwvbajf3w0dwfi9ld5sflx-nixos-system-machine-test machine # [ 30.294808] systemd[1]: Stopped target Remote File Systems. machine # [ 30.296979] systemd[1]: Stopped target Local File Systems. machine # [ 30.599673] systemd[1]: Reload requested from client PID 1456 ('.switch-to-conf') (unit backdoor.service)... machine # [ 30.602001] systemd[1]: Reloading... machine # [ 30.961467] systemd[1]: Reloading finished in 357 ms. machine # [ 31.048741] systemd[554]: Reexecution requested from client PID 1525 ('switch-to-confi')... machine # [ 31.052809] systemd[554]: Reexecuting. machine # [ 31.115919] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.232650] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.239480] systemd[554]: Reload requested from client PID 1525 ('switch-to-confi')... machine # [ 31.243132] systemd[554]: Reloading... machine # [ 31.345652] systemd[554]: Reloading finished in 103 ms. machine # [ 31.360200] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.371230] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 31.373888] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 31.376132] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 31.409355] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 31.413561] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 31.415964] systemd[1]: Stopping Reactivate sysinit units... machine # [ 31.421278] systemd[1]: Reached target Reactivate sysinit units. machine # [ 31.422214] systemd[1]: Reached target Local File Systems. machine # [ 31.423027] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 31.432768] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 31.433921] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 31.435211] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 31.446161] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 31.447941] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.451788] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.454318] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.456241] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 31.458211] systemd[1]: Reached target Remote File Systems. machine # [ 31.614296] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 31.618972] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 31.622491] systemd[1]: Starting linger-users.service... machine # [ 31.625997] systemd[1]: Starting test.service... machine # [ 31.663415] systemd[1]: Finished test.service. machine # [ 31.683561] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 31.685638] systemd[1]: Finished linger-users.service. machine # [ 31.943551] nixos[1456]: finished switching to system configuration /nix/store/gg9p0ll87anwvbajf3w0dwfi9ld5sflx-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.89 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 32.217638] nixos[1598]: switching to system configuration /nix/store/gg9p0ll87anwvbajf3w0dwfi9ld5sflx-nixos-system-machine-test machine # [ 32.220883] systemd[1]: Stopped target Local File Systems. machine # [ 32.222630] systemd[1]: Stopped target Remote File Systems. machine # [ 32.503166] systemd[1]: Reload requested from client PID 1598 ('.switch-to-conf') (unit backdoor.service)... machine # [ 32.505340] systemd[1]: Reloading... machine # [ 32.822380] systemd[1]: Reloading finished in 315 ms. machine # [ 32.910713] systemd[554]: Reexecution requested from client PID 1668 ('switch-to-confi')... machine # [ 32.914595] systemd[554]: Reexecuting. machine # [ 32.976175] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.094824] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.101655] systemd[554]: Reload requested from client PID 1668 ('switch-to-confi')... machine # [ 33.105620] systemd[554]: Reloading... machine # [ 33.211534] systemd[554]: Reloading finished in 106 ms. machine # [ 33.228287] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.238461] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 33.241260] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 33.243750] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 33.278012] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 33.282913] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 33.284948] systemd[1]: Stopping Reactivate sysinit units... machine # [ 33.285971] systemd[1]: Reached target Reactivate sysinit units. machine # [ 33.287930] systemd[1]: Reached target Local File Systems. machine # [ 33.297179] systemd[1]: Reached target Remote File Systems. machine # [ 33.301903] systemd[1]: Starting linger-users.service... machine # [ 33.304879] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 33.317932] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 33.318898] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 33.325282] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 33.327612] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 33.332783] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.334283] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.335501] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.336872] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 33.404896] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 33.408552] systemd[1]: Finished linger-users.service. machine # [ 33.547039] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 33.550332] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 33.806225] nixos[1598]: finished switching to system configuration /nix/store/gg9p0ll87anwvbajf3w0dwfi9ld5sflx-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.86 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 34.039371] nixos[1739]: switching to system configuration /nix/store/px626nyfhqf9bn841jf17mgj4lqjvviv-nixos-system-machine-test machine # [ 34.045210] systemd[1]: Stopped target Local File Systems. machine # [ 34.046193] systemd[1]: Stopped target Remote File Systems. machine # [ 34.430161] systemd[1]: Reload requested from client PID 1739 ('.switch-to-conf') (unit backdoor.service)... machine # [ 34.431761] systemd[1]: Reloading... machine # [ 34.819685] systemd[1]: Reloading finished in 386 ms. machine # [ 34.907356] systemd[554]: Reexecution requested from client PID 1808 ('switch-to-confi')... machine # [ 34.909658] systemd[554]: Reexecuting. machine # [ 34.967368] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.080128] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.087186] systemd[554]: Reload requested from client PID 1808 ('switch-to-confi')... machine # [ 35.091334] systemd[554]: Reloading... machine # [ 35.198488] systemd[554]: Reloading finished in 108 ms. machine # [ 35.216202] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.227512] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 35.228682] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 35.231256] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 35.266400] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 35.271420] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 35.273872] systemd[1]: Stopping Reactivate sysinit units... machine # [ 35.274775] systemd[1]: Reached target Reactivate sysinit units. machine # [ 35.277679] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.279113] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 35.288763] systemd[1]: Reached target Local File Systems. machine # [ 35.295918] systemd[1]: Reached target Remote File Systems. machine # [ 35.301981] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 35.303604] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 35.313701] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 35.315078] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 35.323440] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 35.326129] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.331073] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.541159] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 35.546329] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 35.548944] systemd[1]: Starting linger-users.service... machine # [ 35.591758] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 35.594792] systemd[1]: Finished linger-users.service. machine # [ 35.850622] nixos[1739]: finished switching to system configuration /nix/store/px626nyfhqf9bn841jf17mgj4lqjvviv-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 2.04 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 36.076522] nixos[1880]: switching to system configuration /nix/store/8v11lymvmzlav6rvrcz02sn4b0zi3f50-nixos-system-machine-test machine # [ 36.079676] systemd[1]: test.service: Deactivated successfully. machine # [ 36.083663] systemd[1]: Stopped Test unit. machine # [ 36.085463] systemd[1]: Stopped target Local File Systems. machine # [ 36.086365] systemd[1]: Stopped target Remote File Systems. machine # [ 36.389420] systemd[1]: Reload requested from client PID 1880 ('.switch-to-conf') (unit backdoor.service)... machine # [ 36.391494] systemd[1]: Reloading... machine # [ 37.090984] systemd[1]: Reloading finished in 697 ms. machine # [ 37.182291] systemd[554]: Reexecution requested from client PID 1949 ('switch-to-confi')... machine # [ 37.183748] systemd[554]: Reexecuting. machine # [ 37.243743] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.360969] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.368651] systemd[554]: Reload requested from client PID 1949 ('switch-to-confi')... machine # [ 37.371534] systemd[554]: Reloading... machine # [ 37.488958] systemd[554]: Reloading finished in 116 ms. machine # [ 37.504202] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.515724] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 37.518509] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 37.520839] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 37.554604] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 37.559318] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 37.561720] systemd[1]: Stopping Reactivate sysinit units... machine # [ 37.562642] systemd[1]: Reached target Reactivate sysinit units. machine # [ 37.568320] systemd[1]: Reached target Local File Systems. machine # [ 37.572668] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 37.576560] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 37.577678] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 37.579001] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 37.598360] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 37.600865] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.602403] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.603732] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.605246] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 37.606596] systemd[1]: Reached target Remote File Systems. machine # [ 37.815671] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 37.817782] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 37.823519] systemd[1]: Starting linger-users.service... machine # [ 37.829421] systemd[1]: Starting test.service... machine # [ 37.876909] systemd[1]: Finished test.service. machine # [ 37.899315] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 37.901751] systemd[1]: Finished linger-users.service. machine # [ 38.159174] nixos[1880]: finished switching to system configuration /nix/store/8v11lymvmzlav6rvrcz02sn4b0zi3f50-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 2.31 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 38.415749] nixos[2022]: switching to system configuration /nix/store/adgb23x1g1pq20zxrzap2daywmhgcsab-nixos-system-machine-test machine # [ 38.422357] systemd[1]: Stopped target Local File Systems. machine # [ 38.423470] systemd[1]: Stopped target Remote File Systems. machine # [ 38.801374] systemd[1]: Reload requested from client PID 2022 ('.switch-to-conf') (unit backdoor.service)... machine # [ 38.803502] systemd[1]: Reloading... machine # [ 39.188169] systemd[1]: Reloading finished in 382 ms. machine # [ 39.280169] systemd[554]: Reexecution requested from client PID 2092 ('switch-to-confi')... machine # [ 39.284171] systemd[554]: Reexecuting. machine # [ 39.344497] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.474314] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.482284] systemd[554]: Reload requested from client PID 2092 ('switch-to-confi')... machine # [ 39.486535] systemd[554]: Reloading... machine # [ 39.602309] systemd[554]: Reloading finished in 116 ms. machine # [ 39.620247] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.633122] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 39.635964] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 39.638575] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 39.675881] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 39.682146] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 39.685649] systemd[1]: Stopping Reactivate sysinit units... machine # [ 39.686679] systemd[1]: Reached target Reactivate sysinit units. machine # [ 39.690671] systemd[1]: test.service: Deactivated successfully. machine # [ 39.691831] systemd[1]: Stopped test.service. machine # [ 39.696302] systemd[1]: Stopping test.service... machine # [ 39.697251] systemd[1]: Starting test.service... machine # [ 39.725072] systemd[1]: Finished test.service. machine # [ 39.733013] systemd[1]: Reached target Local File Systems. machine # [ 39.737333] systemd[1]: Reached target Remote File Systems. machine # [ 39.738323] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 39.742911] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 39.743926] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 39.752818] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 39.762902] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 39.765909] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.767315] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.770078] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.771463] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 39.940169] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 39.944607] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 39.947706] systemd[1]: Starting linger-users.service... machine # [ 39.992492] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 39.995965] systemd[1]: Finished linger-users.service. machine # [ 40.250359] nixos[2022]: finished switching to system configuration /nix/store/adgb23x1g1pq20zxrzap2daywmhgcsab-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.09 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 40.531753] nixos[2165]: switching to system configuration /nix/store/69h3k06hnx5h4q6k3p8ax3sqzncsdy6z-nixos-system-machine-test machine # [ 40.535052] systemd[1]: Stopped target Remote File Systems. machine # [ 40.538342] systemd[1]: Stopped target Local File Systems. machine # [ 40.871631] systemd[1]: Reload requested from client PID 2165 ('.switch-to-conf') (unit backdoor.service)... machine # [ 40.874050] systemd[1]: Reloading... machine # [ 41.227737] systemd[1]: Reloading finished in 352 ms. machine # [ 41.320570] systemd[554]: Reexecution requested from client PID 2234 ('switch-to-confi')... machine # [ 41.323645] systemd[554]: Reexecuting. machine # [ 41.371443] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.486638] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.493902] systemd[554]: Reload requested from client PID 2234 ('switch-to-confi')... machine # [ 41.496556] systemd[554]: Reloading... machine # [ 41.611656] systemd[554]: Reloading finished in 114 ms. machine # [ 41.628211] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.639788] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 41.641209] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 41.643691] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 41.678310] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 41.684357] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 41.686366] systemd[1]: Stopping Reactivate sysinit units... machine # [ 41.687310] systemd[1]: Reached target Reactivate sysinit units. machine # [ 41.693165] systemd[1]: Reloading test.service... machine # [ 41.718503] systemd[1]: Reloaded test.service. machine # [ 41.725249] systemd[1]: Reached target Remote File Systems. machine # [ 41.730263] systemd[1]: Starting linger-users.service... machine # [ 41.736304] systemd[1]: Reached target Local File Systems. machine # [ 41.737439] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 41.752833] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 41.754042] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 41.755376] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 41.764539] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 41.766350] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.767721] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.774455] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.775944] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 41.831406] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 41.835324] systemd[1]: Finished linger-users.service. machine # [ 42.003422] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 42.007791] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 42.262574] nixos[2165]: finished switching to system configuration /nix/store/69h3k06hnx5h4q6k3p8ax3sqzncsdy6z-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 2.01 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 42.519538] nixos[2308]: switching to system configuration /nix/store/i0zlzq14q5qgifkff98aq2hxazw3kfl6-nixos-system-machine-test machine # [ 42.522654] systemd[1]: Stopped target Local File Systems. machine # [ 42.525340] systemd[1]: Stopped target Remote File Systems. machine # [ 42.838421] systemd[1]: Reload requested from client PID 2308 ('.switch-to-conf') (unit backdoor.service)... machine # [ 42.840792] systemd[1]: Reloading... machine # [ 43.188882] systemd[1]: Reloading finished in 346 ms. machine # [ 43.283857] systemd[554]: Reexecution requested from client PID 2377 ('switch-to-confi')... machine # [ 43.286325] systemd[554]: Reexecuting. machine # [ 43.339432] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.453575] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.461423] systemd[554]: Reload requested from client PID 2377 ('switch-to-confi')... machine # [ 43.465667] systemd[554]: Reloading... machine # [ 43.578046] systemd[554]: Reloading finished in 113 ms. machine # [ 43.594310] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.602985] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 43.605670] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 43.608001] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 43.643389] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 43.648607] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 43.649811] systemd[1]: Stopping Reactivate sysinit units... machine # [ 43.650677] systemd[1]: Reached target Reactivate sysinit units. machine # [ 43.654054] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.658863] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 43.662535] systemd[1]: Reached target Remote File Systems. machine # [ 43.668700] systemd[1]: Reached target Local File Systems. machine # [ 43.673100] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 43.676459] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 43.677483] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 43.678811] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 43.691098] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 43.693186] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.694569] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.888511] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 43.890824] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 43.896835] systemd[1]: Starting linger-users.service... machine # [ 43.946838] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 43.949560] systemd[1]: Finished linger-users.service. machine # [ 44.208139] nixos[2308]: finished switching to system configuration /nix/store/i0zlzq14q5qgifkff98aq2hxazw3kfl6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.94 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.31 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 44.707343] nixos[2458]: switching to system configuration /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test machine # [ 44.710447] systemd[1]: test.service: Deactivated successfully. machine # [ 44.714816] systemd[1]: Stopped test.service. machine # [ 44.715647] systemd[1]: Stopped target Remote File Systems. machine # [ 44.718587] systemd[1]: Stopped target Local File Systems. machine # [ 45.003737] systemd[1]: Reload requested from client PID 2458 ('.switch-to-conf') (unit backdoor.service)... machine # [ 45.006090] systemd[1]: Reloading... machine # [ 45.334104] systemd[1]: Reloading finished in 327 ms. machine # [ 45.464340] systemd[554]: Reexecution requested from client PID 2527 ('switch-to-confi')... machine # [ 45.465943] systemd[554]: Reexecuting. machine # [ 45.528222] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.647443] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.654366] systemd[554]: Reload requested from client PID 2527 ('switch-to-confi')... machine # [ 45.658398] systemd[554]: Reloading... machine # [ 45.767677] systemd[554]: Reloading finished in 110 ms. machine # [ 45.780198] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.789960] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 45.792490] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 45.794826] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 45.824109] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 45.828829] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 45.829872] systemd[1]: Stopping Reactivate sysinit units... machine # [ 45.830681] systemd[1]: Reached target Reactivate sysinit units. machine # [ 45.835631] systemd[1]: Reached target Remote File Systems. machine # [ 45.839881] systemd[1]: Starting linger-users.service... machine # [ 45.845095] systemd[1]: Reached target Local File Systems. machine # [ 45.855410] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 45.864366] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 45.865444] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 45.866756] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 45.879460] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 45.885168] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.891070] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.897375] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.898795] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 45.939941] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 45.944570] systemd[1]: Finished linger-users.service. machine # [ 46.085109] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 46.088292] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 46.344111] nixos[2458]: finished switching to system configuration /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.83 seconds) machine: must succeed: /nix/store/d6ahk2cgvvz750dp0n4qmcjc8k25i9s6-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 46.556596] nixos[2599]: switching to system configuration /nix/store/5inj2j7hadi7jzzcnqjn7fl23k5hdr3a-nixos-system-machine-test machine # [ 46.559355] systemd[1]: Stopped target Remote File Systems. machine # [ 46.562291] systemd[1]: Stopped target Local File Systems. machine # [ 46.882992] systemd[1]: Reload requested from client PID 2599 ('.switch-to-conf') (unit backdoor.service)... machine # [ 46.885211] systemd[1]: Reloading... machine # [ 47.214255] systemd[1]: Reloading finished in 327 ms. machine # [ 47.308734] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 47.312538] systemd[554]: Reexecution requested from client PID 2668 ('switch-to-confi')... machine # [ 47.315932] systemd[554]: Reexecuting. machine # [ 47.363575] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.476248] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.483804] systemd[554]: Reload requested from client PID 2668 ('switch-to-confi')... machine # [ 47.486245] systemd[554]: Reloading... machine # [ 47.594316] systemd[554]: Reloading finished in 107 ms. machine # [ 47.612208] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.624640] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 47.625711] systemd[1]: Stopping Reactivate sysinit units... machine # [ 47.626539] systemd[1]: Reached target Reactivate sysinit units. machine # [ 47.629232] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.634238] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 47.637901] systemd[1]: Reached target Remote File Systems. machine # [ 47.643241] systemd[1]: Starting linger-users.service... machine # [ 47.647759] systemd[1]: Starting test.service... machine # [ 47.656105] systemd[1]: Reached target Local File Systems. machine # [ 47.657179] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 47.675856] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 47.677053] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 47.678443] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 47.681250] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 47.682904] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.694350] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.722917] systemd[1]: Finished test.service. machine # [ 47.753052] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 47.757742] systemd[1]: Finished linger-users.service. machine # [ 47.890735] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 47.894228] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 48.149534] nixos[2599]: finished switching to system configuration /nix/store/5inj2j7hadi7jzzcnqjn7fl23k5hdr3a-nixos-system-machine-test machine: (finished: must succeed: /nix/store/d6ahk2cgvvz750dp0n4qmcjc8k25i9s6-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.81 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/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 48.432364] nixos[2747]: switching to system configuration /nix/store/l71bf1nvnvrgllrpw0gx5hm3pa2n1p1v-nixos-system-machine-test machine # [ 48.435243] systemd[1]: Stopped target Remote File Systems. machine # [ 48.438919] systemd[1]: test.service: Deactivated successfully. machine # [ 48.439875] systemd[1]: Stopped test.service. machine # [ 48.440645] systemd[1]: Stopped target Local File Systems. machine # [ 48.770809] systemd[1]: Reload requested from client PID 2747 ('.switch-to-conf') (unit backdoor.service)... machine # [ 48.772964] systemd[1]: Reloading... machine # [ 49.105899] systemd[1]: Reloading finished in 331 ms. machine # [ 49.192442] systemd[554]: Reexecution requested from client PID 2815 ('switch-to-confi')... machine # [ 49.195514] systemd[554]: Reexecuting. machine # [ 49.251957] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.364295] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.370890] systemd[554]: Reload requested from client PID 2815 ('switch-to-confi')... machine # [ 49.374675] systemd[554]: Reloading... machine # [ 49.479749] systemd[554]: Reloading finished in 106 ms. machine # [ 49.496237] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.506819] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 49.540214] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 49.544341] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 49.552360] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 49.553524] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 49.557214] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 49.558221] systemd[1]: Stopping Reactivate sysinit units... machine # [ 49.559022] systemd[1]: Reached target Reactivate sysinit units. machine # [ 49.562858] systemd[1]: Reached target Remote File Systems. machine # [ 49.577187] systemd[1]: Starting linger-users.service... machine # [ 49.598727] systemd[1]: Started test.service. machine # [ 49.615128] systemd[1]: Reached target Local File Systems. machine # [ 49.632542] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 49.634273] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 49.635240] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 49.647576] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 49.654329] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 49.666986] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 49.675251] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.683249] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.690090] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.691559] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 49.699760] systemd[1]: test.service: Deactivated successfully. machine # [ 49.719640] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 49.722917] systemd[1]: Finished linger-users.service. machine # [ 49.868184] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 49.871492] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 50.125444] nixos[2747]: finished switching to system configuration /nix/store/l71bf1nvnvrgllrpw0gx5hm3pa2n1p1v-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.92 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 50.366501] nixos[2892]: switching to system configuration /nix/store/82snayivr13p27izlr6b4wxbdx1n4609-nixos-system-machine-test machine # [ 50.369500] systemd[1]: Stopped target Local File Systems. machine # [ 50.371181] systemd[1]: Stopped target Remote File Systems. machine # [ 50.659571] systemd[1]: Reload requested from client PID 2892 ('.switch-to-conf') (unit backdoor.service)... machine # [ 50.661916] systemd[1]: Reloading... machine # [ 50.978403] systemd[1]: Reloading finished in 315 ms. machine # [ 51.069500] systemd[554]: Reexecution requested from client PID 2961 ('switch-to-confi')... machine # [ 51.073979] systemd[554]: Reexecuting. machine # [ 51.115079] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.223473] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.230844] systemd[554]: Reload requested from client PID 2961 ('switch-to-confi')... machine # [ 51.233667] systemd[554]: Reloading... machine # [ 51.343068] systemd[554]: Reloading finished in 108 ms. machine # [ 51.362041] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.370449] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 51.372177] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 51.375489] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 51.409401] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 51.414357] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 51.417221] systemd[1]: Stopping Reactivate sysinit units... machine # [ 51.418143] systemd[1]: Reached target Reactivate sysinit units. machine # [ 51.422083] systemd[1]: Reached target Local File Systems. machine # [ 51.427322] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.430257] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 51.434798] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 51.441150] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 51.442117] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 51.443428] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 51.454592] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 51.456562] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.458084] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.459405] systemd[1]: Reached target Remote File Systems. machine # [ 51.631205] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 51.635820] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 51.639565] systemd[1]: Starting escaped\x2ddash.service... machine # [ 51.643382] systemd[1]: Starting linger-users.service... machine # [ 51.678559] systemd[1]: Finished escaped\x2ddash.service. machine # [ 51.702334] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 51.705707] systemd[1]: Finished linger-users.service. machine # [ 51.963399] nixos[2892]: finished switching to system configuration /nix/store/82snayivr13p27izlr6b4wxbdx1n4609-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 1.84 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 52.213979] nixos[3034]: switching to system configuration /nix/store/gzgkix6khkln89s4wzqx80rq8gaj7djk-nixos-system-machine-test machine # [ 52.216928] systemd[1]: Stopped target Local File Systems. machine # [ 52.219728] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 52.222934] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 52.223830] systemd[1]: Stopped target Remote File Systems. machine # [ 52.540801] systemd[1]: Reload requested from client PID 3034 ('.switch-to-conf') (unit backdoor.service)... machine # [ 52.542999] systemd[1]: Reloading... machine # [ 52.889539] systemd[1]: Reloading finished in 344 ms. machine # [ 52.980892] systemd[554]: Reexecution requested from client PID 3103 ('switch-to-confi')... machine # [ 52.985509] systemd[554]: Reexecuting. machine # [ 53.043892] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.161551] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.169169] systemd[554]: Reload requested from client PID 3103 ('switch-to-confi')... machine # [ 53.173227] systemd[554]: Reloading... machine # [ 53.280157] systemd[554]: Reloading finished in 108 ms. machine # [ 53.296308] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.307384] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 53.310319] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 53.313048] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 53.346911] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 53.351402] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 53.354807] systemd[1]: Stopping Reactivate sysinit units... machine # [ 53.355666] systemd[1]: Reached target Reactivate sysinit units. machine # [ 53.359567] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.362033] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 53.366740] systemd[1]: Reached target Local File Systems. machine # [ 53.367675] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 53.377506] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 53.378454] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 53.379709] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 53.393451] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 53.395201] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.396667] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.397930] systemd[1]: Reached target Remote File Systems. machine # [ 53.565531] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 53.570358] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 53.574177] systemd[1]: Starting escaped\x2ddash.service... machine # [ 53.577816] systemd[1]: Starting linger-users.service... machine # [ 53.615591] systemd[1]: Finished escaped\x2ddash.service. machine # [ 53.639846] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 53.642083] systemd[1]: Finished linger-users.service. machine # [ 53.899762] nixos[3034]: finished switching to system configuration /nix/store/gzgkix6khkln89s4wzqx80rq8gaj7djk-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 1.94 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 54.253881] nixos[3176]: switching to system configuration /nix/store/dly5rlw5yvidmc8ympa8c977mq8h5glq-nixos-system-machine-test machine # [ 54.257939] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 54.261100] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 54.262049] systemd[1]: Stopped target Local File Systems. machine # [ 54.263493] systemd[1]: Stopped target Remote File Systems. machine # [ 54.561557] systemd[1]: Reload requested from client PID 3176 ('.switch-to-conf') (unit backdoor.service)... machine # [ 54.563574] systemd[1]: Reloading... machine # [ 54.898784] systemd[1]: Reloading finished in 333 ms. machine # [ 54.992124] systemd[554]: Reexecution requested from client PID 3245 ('switch-to-confi')... machine # [ 54.996261] systemd[554]: Reexecuting. machine # [ 55.051360] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.167418] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.176152] systemd[554]: Reload requested from client PID 3245 ('switch-to-confi')... machine # [ 55.177731] systemd[554]: Reloading... machine # [ 55.282308] systemd[554]: Reloading finished in 103 ms. machine # [ 55.296190] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.306342] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 55.308783] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 55.311020] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 55.345406] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 55.349855] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 55.352943] systemd[1]: Stopping Reactivate sysinit units... machine # [ 55.353876] systemd[1]: Reached target Reactivate sysinit units. machine # [ 55.357835] systemd[1]: Reached target Remote File Systems. machine # [ 55.361845] systemd[1]: Starting -.service... machine # [ 55.364774] systemd[1]: Starting linger-users.service... machine # [ 55.372812] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.374368] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 55.386486] systemd[1]: Reached target Local File Systems. machine # [ 55.395492] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 55.407054] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 55.414393] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 55.420003] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 55.429626] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 55.431379] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.447537] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.452745] systemd[1]: Finished -.service. machine # [ 55.487201] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 55.491553] systemd[1]: Finished linger-users.service. machine # [ 55.642191] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 55.645652] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 55.902929] nixos[3176]: finished switching to system configuration /nix/store/dly5rlw5yvidmc8ympa8c977mq8h5glq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 2.00 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 56.140002] nixos[3318]: switching to system configuration /nix/store/dlpwx72n6dvfycx4wvh0bvwqbmyy19y0-nixos-system-machine-test machine # [ 56.145605] systemd[1]: Stopped target Local File Systems. machine # [ 56.146514] systemd[1]: Stopped target Remote File Systems. machine # [ 56.444267] systemd[1]: Reload requested from client PID 3318 ('.switch-to-conf') (unit backdoor.service)... machine # [ 56.446244] systemd[1]: Reloading... machine # [ 56.760618] systemd[1]: Reloading finished in 312 ms. machine # [ 56.850025] systemd[554]: Reexecution requested from client PID 3387 ('switch-to-confi')... machine # [ 56.851482] systemd[554]: Reexecuting. machine # [ 56.902951] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.010812] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.017517] systemd[554]: Reload requested from client PID 3387 ('switch-to-confi')... machine # [ 57.019955] systemd[554]: Reloading... machine # [ 57.124079] systemd[554]: Reloading finished in 103 ms. machine # [ 57.140168] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.149684] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 57.152157] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 57.154439] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 57.189080] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 57.193683] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 57.198235] systemd[1]: Stopping Reactivate sysinit units... machine # [ 57.199149] systemd[1]: Reached target Reactivate sysinit units. machine # [ 57.201326] systemd[1]: Reloading -.service... machine # [ 57.225465] systemd[1]: Reloaded -.service. machine # [ 57.230826] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.234889] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 57.238385] systemd[1]: Reached target Local File Systems. machine # [ 57.242238] systemd[1]: Reached target Remote File Systems. machine # [ 57.245142] systemd[1]: Starting linger-users.service... machine # [ 57.250940] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 57.260967] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 57.261869] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 57.263117] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 57.271899] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 57.273879] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.275173] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.330775] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 57.332798] systemd[1]: Finished linger-users.service. machine # [ 57.466134] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 57.469124] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 57.724688] nixos[3318]: finished switching to system configuration /nix/store/dlpwx72n6dvfycx4wvh0bvwqbmyy19y0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.82 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 57.952299] nixos[3460]: switching to system configuration /nix/store/3za7p8d06nn7h2dkz2xm56jkkcvdyg9m-nixos-system-machine-test machine # [ 57.954911] systemd[1]: Stopped target Local File Systems. machine # [ 57.958209] systemd[1]: -.service: Deactivated successfully. machine # [ 57.959239] systemd[1]: Stopped -.service. machine # [ 57.959858] systemd[1]: Stopped target Remote File Systems. machine # [ 58.246961] systemd[1]: Reload requested from client PID 3460 ('.switch-to-conf') (unit backdoor.service)... machine # [ 58.249209] systemd[1]: Reloading... machine # [ 58.963466] systemd[1]: Reloading finished in 712 ms. machine # [ 59.059869] systemd[554]: Reexecution requested from client PID 3529 ('switch-to-confi')... machine # [ 59.062337] systemd[554]: Reexecuting. machine # [ 59.119380] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.233488] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.240091] systemd[554]: Reload requested from client PID 3529 ('switch-to-confi')... machine # [ 59.241491] systemd[554]: Reloading... machine # [ 59.347825] systemd[554]: Reloading finished in 104 ms. machine # [ 59.364188] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.375235] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 59.376369] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 59.378763] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 59.411571] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 59.415922] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 59.420984] systemd[1]: Stopping Reactivate sysinit units... machine # [ 59.421897] systemd[1]: Reached target Reactivate sysinit units. machine # [ 59.422741] systemd[1]: Reached target Remote File Systems. machine # [ 59.426761] systemd[1]: Starting linger-users.service... machine # [ 59.432248] systemd[1]: Starting required-service.service... machine # [ 59.433256] systemd[1]: Starting test-service.service... machine # [ 59.448454] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.449986] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 59.451310] systemd[1]: Reached target Local File Systems. machine # [ 59.467303] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 59.481017] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 59.486197] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 59.495026] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 59.509768] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 59.523943] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.528445] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.529882] systemd[1]: Finished required-service.service. machine # [ 59.530676] systemd[1]: Finished test-service.service. machine # [ 59.563665] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 59.565829] systemd[1]: Finished linger-users.service. machine # [ 59.703973] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 59.707664] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 59.962807] nixos[3460]: finished switching to system configuration /nix/store/3za7p8d06nn7h2dkz2xm56jkkcvdyg9m-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 2.24 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 60.197552] nixos[3604]: switching to system configuration /nix/store/hfhfa8nirj77w3icx8rbf7qk1bm1rc8s-nixos-system-machine-test machine # [ 60.200336] systemd[1]: required-service.service: Deactivated successfully. machine # [ 60.205299] systemd[1]: Stopped required-service.service. machine # [ 60.206189] systemd[1]: test-service.service: Deactivated successfully. machine # [ 60.207153] systemd[1]: Stopped test-service.service. machine # [ 60.207890] systemd[1]: Stopped target Remote File Systems. machine # [ 60.209193] systemd[1]: Stopped target Local File Systems. machine # [ 60.510306] systemd[1]: Reload requested from client PID 3604 ('.switch-to-conf') (unit backdoor.service)... machine # [ 60.512464] systemd[1]: Reloading... machine # [ 60.829563] systemd[1]: Reloading finished in 315 ms. machine # [ 60.912464] systemd[554]: Reexecution requested from client PID 3673 ('switch-to-confi')... machine # [ 60.916348] systemd[554]: Reexecuting. machine # [ 60.971913] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.087040] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.093760] systemd[554]: Reload requested from client PID 3673 ('switch-to-confi')... machine # [ 61.097678] systemd[554]: Reloading... machine # [ 61.204875] systemd[554]: Reloading finished in 108 ms. machine # [ 61.220204] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.230920] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 61.233707] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 61.236062] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 61.269579] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 61.274265] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 61.276519] systemd[1]: Stopping Reactivate sysinit units... machine # [ 61.277587] systemd[1]: Reached target Reactivate sysinit units. machine # [ 61.282381] systemd[1]: Reached target Local File Systems. machine # [ 61.285977] systemd[1]: Reached target Remote File Systems. machine # [ 61.289610] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 61.294178] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 61.295116] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 61.306811] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 61.315975] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 61.317801] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.319151] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.322107] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.323520] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 61.485136] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 61.488417] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 61.494357] systemd[1]: Starting linger-users.service... machine # [ 61.498988] systemd[1]: Starting required-service.service... machine # [ 61.512462] systemd[1]: Starting test-service.service... machine # [ 61.555123] systemd[1]: Finished required-service.service. machine # [ 61.558570] systemd[1]: Finished test-service.service. machine # [ 61.577527] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 61.581149] systemd[1]: Finished linger-users.service. machine # [ 61.836395] nixos[3604]: finished switching to system configuration /nix/store/hfhfa8nirj77w3icx8rbf7qk1bm1rc8s-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.87 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 62.065088] nixos[3748]: switching to system configuration /nix/store/n85f2190njnpynxxy16b5h12lhbqryx5-nixos-system-machine-test machine # [ 62.067874] systemd[1]: required-service.service: Deactivated successfully. machine # [ 62.072892] systemd[1]: Stopped required-service.service. machine # [ 62.073756] systemd[1]: test-service.service: Deactivated successfully. machine # [ 62.077231] systemd[1]: Stopped test-service.service. machine # [ 62.078026] systemd[1]: Stopped target Local File Systems. machine # [ 62.078850] systemd[1]: Stopped target Remote File Systems. machine # [ 62.364563] systemd[1]: Reload requested from client PID 3748 ('.switch-to-conf') (unit backdoor.service)... machine # [ 62.366527] systemd[1]: Reloading... machine # [ 62.696568] systemd[1]: Reloading finished in 328 ms. machine # [ 62.782454] systemd[554]: Reexecution requested from client PID 3817 ('switch-to-confi')... machine # [ 62.786956] systemd[554]: Reexecuting. machine # [ 62.843648] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.956005] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.962669] systemd[554]: Reload requested from client PID 3817 ('switch-to-confi')... machine # [ 62.966370] systemd[554]: Reloading... machine # [ 63.071729] systemd[554]: Reloading finished in 106 ms. machine # [ 63.088212] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.098700] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 63.101307] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 63.103528] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 63.136716] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 63.141542] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 63.142533] systemd[1]: Stopping Reactivate sysinit units... machine # [ 63.143361] systemd[1]: Reached target Reactivate sysinit units. machine # [ 63.146208] systemd[1]: Reached target Remote File Systems. machine # [ 63.149532] systemd[1]: Reached target Local File Systems. machine # [ 63.154417] systemd[1]: Starting required-service.service... machine # [ 63.160584] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.162130] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 63.184320] systemd[1]: Starting linger-users.service... machine # [ 63.192169] systemd[1]: Starting test-service.service... machine # [ 63.193181] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 63.212809] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 63.213818] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 63.215114] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 63.219918] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 63.228656] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.230124] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.258991] systemd[1]: Finished required-service.service. machine # [ 63.277787] systemd[1]: Finished test-service.service. machine # [ 63.304690] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 63.307369] systemd[1]: Finished linger-users.service. machine # [ 63.439535] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 63.441833] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 63.698333] nixos[3748]: finished switching to system configuration /nix/store/n85f2190njnpynxxy16b5h12lhbqryx5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.86 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 63.927996] nixos[3892]: switching to system configuration /nix/store/2ml4mr8v886q5nwl0vlk8vzjiyqmvi36-nixos-system-machine-test machine # [ 63.931408] systemd[1]: test-service.service: Deactivated successfully. machine # [ 63.935538] systemd[1]: Stopped test-service.service. machine # [ 63.937322] systemd[1]: Stopped target Remote File Systems. machine # [ 63.938168] systemd[1]: Stopped target Local File Systems. machine # [ 63.938956] systemd[1]: required-service.service: Deactivated successfully. machine # [ 63.939926] systemd[1]: Stopped required-service.service. machine # [ 64.227721] systemd[1]: Reload requested from client PID 3892 ('.switch-to-conf') (unit backdoor.service)... machine # [ 64.229984] systemd[1]: Reloading... machine # [ 64.560838] systemd[1]: Reloading finished in 329 ms. machine # [ 64.646763] systemd[554]: Reexecution requested from client PID 3961 ('switch-to-confi')... machine # [ 64.650353] systemd[554]: Reexecuting. machine # [ 64.707521] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.820284] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.827499] systemd[554]: Reload requested from client PID 3961 ('switch-to-confi')... machine # [ 64.830124] systemd[554]: Reloading... machine # [ 64.937279] systemd[554]: Reloading finished in 106 ms. machine # [ 64.952262] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.963307] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 64.965801] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 64.967973] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 65.001256] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 65.005759] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 65.007095] systemd[1]: Stopping Reactivate sysinit units... machine # [ 65.009189] systemd[1]: Reached target Reactivate sysinit units. machine # [ 65.012153] systemd[1]: Reached target Local File Systems. machine # [ 65.016327] systemd[1]: Created slice Slice /system/instantiated. machine # [ 65.019368] systemd[1]: Reached target Remote File Systems. machine # [ 65.023003] systemd[1]: Starting instantiated@one.service... machine # [ 65.028693] systemd[1]: Starting instantiated@two.service... machine # [ 65.029697] systemd[1]: Starting linger-users.service... machine # [ 65.051101] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 65.060535] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 65.061501] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 65.062937] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 65.090267] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 65.101412] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.110322] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.120235] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.121882] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 65.123229] systemd[1]: Finished instantiated@two.service. machine # [ 65.131560] systemd[1]: Finished instantiated@one.service. machine # [ 65.163734] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 65.167275] systemd[1]: Finished linger-users.service. machine # [ 65.297577] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 65.301496] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 65.556598] nixos[3892]: finished switching to system configuration /nix/store/2ml4mr8v886q5nwl0vlk8vzjiyqmvi36-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.86 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 65.799086] nixos[4036]: switching to system configuration /nix/store/0sqp6z9c9cjlq1lj8lx2i5wlr1f1b0ar-nixos-system-machine-test machine # [ 65.802198] systemd[1]: Stopped target Local File Systems. machine # [ 65.804129] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 65.805850] systemd[1]: Stopped instantiated@two.service. machine # [ 65.809589] systemd[1]: Stopped target Remote File Systems. machine # [ 65.810499] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 65.811484] systemd[1]: Stopped instantiated@one.service. machine # [ 66.098195] systemd[1]: Reload requested from client PID 4036 ('.switch-to-conf') (unit backdoor.service)... machine # [ 66.100258] systemd[1]: Reloading... machine # [ 66.416168] systemd[1]: Reloading finished in 314 ms. machine # [ 66.503015] systemd[554]: Reexecution requested from client PID 4105 ('switch-to-confi')... machine # [ 66.506066] systemd[554]: Reexecuting. machine # [ 66.563746] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.675385] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.682371] systemd[554]: Reload requested from client PID 4105 ('switch-to-confi')... machine # [ 66.686270] systemd[554]: Reloading... machine # [ 66.790864] systemd[554]: Reloading finished in 105 ms. machine # [ 66.808180] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.818580] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 66.820977] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 66.823017] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 66.855186] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 66.859180] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 66.860968] systemd[1]: Stopping Reactivate sysinit units... machine # [ 66.861812] systemd[1]: Reached target Reactivate sysinit units. machine # [ 66.866879] systemd[1]: Reached target Local File Systems. machine # [ 66.867791] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 66.879017] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 66.879907] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 66.889761] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 66.892931] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 66.894616] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.895897] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.898708] systemd[1]: Reached target Remote File Systems. machine # [ 66.899542] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.901807] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 67.049982] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 67.054849] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 67.058114] systemd[1]: Starting instantiated@one.service... machine # [ 67.061958] systemd[1]: Starting instantiated@two.service... machine # [ 67.071846] systemd[1]: Starting linger-users.service... machine # [ 67.117831] systemd[1]: Finished instantiated@two.service. machine # [ 67.124856] systemd[1]: Finished instantiated@one.service. machine # [ 67.141246] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 67.143540] systemd[1]: Finished linger-users.service. machine # [ 67.399518] nixos[4036]: finished switching to system configuration /nix/store/0sqp6z9c9cjlq1lj8lx2i5wlr1f1b0ar-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.84 seconds) (finished: subtest: services, in 41.40 seconds) subtest: failing units machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 67.615677] nixos[4180]: switching to system configuration /nix/store/8v11lymvmzlav6rvrcz02sn4b0zi3f50-nixos-system-machine-test machine # [ 67.618892] systemd[1]: Stopped target Local File Systems. machine # [ 67.621054] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 67.622100] systemd[1]: Stopped instantiated@one.service. machine # [ 67.626070] systemd[1]: Stopped target Remote File Systems. machine # [ 67.627627] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 67.630680] systemd[1]: Stopped instantiated@two.service. machine # [ 67.894051] systemd[1]: Reload requested from client PID 4180 ('.switch-to-conf') (unit backdoor.service)... machine # [ 67.896326] systemd[1]: Reloading... machine # [ 68.196440] systemd[1]: Reloading finished in 298 ms. machine # [ 68.280376] systemd[554]: Reexecution requested from client PID 4249 ('switch-to-confi')... machine # [ 68.284253] systemd[554]: Reexecuting. machine # [ 68.343447] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.455154] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.462428] systemd[554]: Reload requested from client PID 4249 ('switch-to-confi')... machine # [ 68.464571] systemd[554]: Reloading... machine # [ 68.569650] systemd[554]: Reloading finished in 103 ms. machine # [ 68.584215] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.593752] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 68.595978] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 68.598184] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 68.627408] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 68.631456] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 68.634288] systemd[1]: Stopping Reactivate sysinit units... machine # [ 68.635164] systemd[1]: Reached target Reactivate sysinit units. machine # [ 68.638885] systemd[1]: Reached target Remote File Systems. machine # [ 68.644080] systemd[1]: Starting linger-users.service... machine # [ 68.648277] systemd[1]: Starting test.service... machine # [ 68.663351] systemd[1]: Reached target Local File Systems. machine # [ 68.670316] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 68.671912] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 68.682436] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 68.683830] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 68.698414] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 68.708816] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.710328] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.711548] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.722638] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 68.727984] systemd[1]: Finished test.service. machine # [ 68.761179] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 68.762969] systemd[1]: Finished linger-users.service. machine # [ 68.891654] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 68.894741] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 69.152430] nixos[4180]: finished switching to system configuration /nix/store/8v11lymvmzlav6rvrcz02sn4b0zi3f50-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.75 seconds) machine: must fail: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 69.383770] nixos[4322]: switching to system configuration /nix/store/sk7jzn204xaiskw107img5xh5s7wx8xl-nixos-system-machine-test machine # [ 69.386963] systemd[1]: Stopped target Remote File Systems. machine # [ 69.390715] systemd[1]: Stopped target Local File Systems. machine # [ 69.392192] systemd[1]: test.service: Deactivated successfully. machine # [ 69.393226] systemd[1]: Stopped test.service. machine # [ 69.677040] systemd[1]: Reload requested from client PID 4322 ('.switch-to-conf') (unit backdoor.service)... machine # [ 69.679036] systemd[1]: Reloading... machine # [ 69.996501] systemd[1]: Reloading finished in 315 ms. machine # [ 70.082967] systemd[554]: Reexecution requested from client PID 4391 ('switch-to-confi')... machine # [ 70.086813] systemd[554]: Reexecuting. machine # [ 70.147317] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.260840] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.267725] systemd[554]: Reload requested from client PID 4391 ('switch-to-confi')... machine # [ 70.270063] systemd[554]: Reloading... machine # [ 70.374345] systemd[554]: Reloading finished in 103 ms. machine # [ 70.388164] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.398641] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 70.401166] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 70.403298] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 70.435654] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 70.440836] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 70.441872] systemd[1]: Stopping Reactivate sysinit units... machine # [ 70.442733] systemd[1]: Reached target Reactivate sysinit units. machine # [ 70.446904] systemd[1]: Reached target Remote File Systems. machine # [ 70.450725] systemd[1]: Reached target Local File Systems. machine # [ 70.454079] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 70.458447] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 70.459401] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 70.468638] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 70.471008] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 70.478247] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.479608] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.481110] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.482452] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 70.636760] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 70.640383] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.644279] systemd[1]: Starting linger-users.service... machine # [ 70.649329] systemd[1]: Starting test.service... machine # [ 70.689384] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 70.690917] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 70.695657] systemd[1]: Failed to start test.service. machine # [ 70.712961] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 70.715996] systemd[1]: Finished linger-users.service. machine # [ 70.990567] nixos[4322]: switching to system configuration /nix/store/sk7jzn204xaiskw107img5xh5s7wx8xl-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.84 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 71.220150] nixos[4465]: switching to system configuration /nix/store/zsqxwgz0avljjpgmmryyr670fzbac87l-nixos-system-machine-test machine # [ 71.222822] systemd[1]: Stopped target Remote File Systems. machine # [ 71.225025] systemd[1]: Stopped target Local File Systems. machine # [ 71.516724] systemd[1]: Reload requested from client PID 4465 ('.switch-to-conf') (unit backdoor.service)... machine # [ 71.518715] systemd[1]: Reloading... machine # [ 71.839218] systemd[1]: Reloading finished in 319 ms. machine # [ 71.928424] systemd[554]: Reexecution requested from client PID 4534 ('switch-to-confi')... machine # [ 71.931597] systemd[554]: Reexecuting. machine # [ 71.987333] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.099625] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.106318] systemd[554]: Reload requested from client PID 4534 ('switch-to-confi')... machine # [ 72.110048] systemd[554]: Reloading... machine # [ 72.213955] systemd[554]: Reloading finished in 104 ms. machine # [ 72.228190] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.237596] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 72.239940] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 72.243097] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 72.276277] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 72.280486] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 72.282869] systemd[1]: Stopping Reactivate sysinit units... machine # [ 72.283749] systemd[1]: Reached target Reactivate sysinit units. machine # [ 72.287905] systemd[1]: Reached target Remote File Systems. machine # [ 72.291874] systemd[1]: Started autorestart.service. machine # [ 72.295305] systemd[1]: Starting linger-users.service... machine # [ 72.305857] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.307230] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 72.313935] systemd[1]: Reached target Local File Systems. machine # [ 72.318858] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 72.330748] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 72.331687] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 72.343046] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 72.353683] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 72.355381] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.364903] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.375224] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 72.410771] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 72.415255] systemd[1]: Finished linger-users.service. machine # [ 72.550506] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 72.553923] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 72.810346] nixos[4465]: finished switching to system configuration /nix/store/zsqxwgz0avljjpgmmryyr670fzbac87l-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.82 seconds) machine # [ 72.852109] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 73.067626] nixos[4612]: switching to system configuration /nix/store/zsqxwgz0avljjpgmmryyr670fzbac87l-nixos-system-machine-test machine # [ 73.073037] systemd[1]: Stopped target Remote File Systems. machine # [ 73.073978] systemd[1]: Stopped target Local File Systems. machine # [ 73.348579] systemd[1]: Reload requested from client PID 4612 ('.switch-to-conf') (unit backdoor.service)... machine # [ 73.350271] systemd[1]: Reloading... machine # [ 73.655822] systemd[1]: Reloading finished in 303 ms. machine # [ 73.745473] systemd[554]: Reexecution requested from client PID 4681 ('switch-to-confi')... machine # [ 73.749439] systemd[554]: Reexecuting. machine # [ 73.791245] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.898095] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.904806] systemd[554]: Reload requested from client PID 4681 ('switch-to-confi')... machine # [ 73.908188] systemd[554]: Reloading... machine # [ 74.014257] systemd[554]: Reloading finished in 106 ms. machine # [ 74.029811] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.038717] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 74.041257] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 74.043355] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 74.075846] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 74.080102] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 74.084775] systemd[1]: Stopping Reactivate sysinit units... machine # [ 74.085687] systemd[1]: Reached target Reactivate sysinit units. machine # [ 74.086545] systemd[1]: Reached target Remote File Systems. machine # [ 74.090942] systemd[1]: Started autorestart.service. machine # [ 74.093690] systemd[1]: Starting linger-users.service... machine # [ 74.100780] systemd[1]: Reached target Local File Systems. machine # [ 74.101704] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 74.116217] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 74.117271] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 74.118523] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 74.132355] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 74.133990] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.135258] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.141656] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.143064] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 74.175676] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 74.206400] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 74.210106] systemd[1]: Finished linger-users.service. machine # [ 74.337428] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 74.340267] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 74.597382] nixos[4612]: finished switching to system configuration /nix/store/zsqxwgz0avljjpgmmryyr670fzbac87l-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.74 seconds) machine # [ 74.637954] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 74.858275] nixos[4759]: switching to system configuration /nix/store/h997785777cn3fay11xv83fdjx97sg6p-nixos-system-machine-test machine # [ 74.861050] systemd[1]: Stopped target Remote File Systems. machine # [ 74.863354] systemd[1]: Stopped target Local File Systems. machine # [ 75.147553] systemd[1]: Reload requested from client PID 4759 ('.switch-to-conf') (unit backdoor.service)... machine # [ 75.149719] systemd[1]: Reloading... machine # [ 75.458120] systemd[1]: Reloading finished in 307 ms. machine # [ 75.547311] systemd[554]: Reexecution requested from client PID 4828 ('switch-to-confi')... machine # [ 75.550215] systemd[554]: Reexecuting. machine # [ 75.607641] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.719541] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.727299] systemd[554]: Reload requested from client PID 4828 ('switch-to-confi')... machine # [ 75.730471] systemd[554]: Reloading... machine # [ 75.834008] systemd[554]: Reloading finished in 103 ms. machine # [ 75.848168] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.857924] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 75.860297] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 75.862365] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 75.895011] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 75.899326] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 75.901054] systemd[1]: Stopping Reactivate sysinit units... machine # [ 75.901884] systemd[1]: Reached target Reactivate sysinit units. machine # [ 75.904370] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.905791] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 75.909444] systemd[1]: Reached target Local File Systems. machine # [ 75.916149] systemd[1]: Reached target Remote File Systems. machine # [ 75.920264] systemd[1]: Started autorestart.service. machine # [ 75.928390] systemd[1]: Starting linger-users.service... machine # [ 75.929331] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 75.930831] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 75.931630] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 75.949032] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 75.951333] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 75.953382] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.954698] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.990176] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 75.991657] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 76.026760] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 76.028086] systemd[1]: Finished linger-users.service. machine # [ 76.158657] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 76.161773] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 76.439902] nixos[4759]: switching to system configuration /nix/store/h997785777cn3fay11xv83fdjx97sg6p-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.80 seconds) (finished: subtest: failing units, in 9.04 seconds) subtest: unit file parser machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 76.638678] nixos[4902]: switching to system configuration /nix/store/adgb23x1g1pq20zxrzap2daywmhgcsab-nixos-system-machine-test machine # [ 76.641399] systemd[1]: Stopped autorestart.service. machine # [ 76.644790] systemd[1]: Stopped target Local File Systems. machine # [ 76.645666] systemd[1]: Stopped target Remote File Systems. machine # [ 76.901213] systemd[1]: Reload requested from client PID 4902 ('.switch-to-conf') (unit backdoor.service)... machine # [ 76.903175] systemd[1]: Reloading... machine # [ 77.198930] systemd[1]: Reloading finished in 294 ms. machine # [ 77.287100] systemd[554]: Reexecution requested from client PID 4971 ('switch-to-confi')... machine # [ 77.289357] systemd[554]: Reexecuting. machine # [ 77.347278] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.458143] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.464349] systemd[554]: Reload requested from client PID 4971 ('switch-to-confi')... machine # [ 77.466633] systemd[554]: Reloading... machine # [ 77.568855] systemd[554]: Reloading finished in 101 ms. machine # [ 77.584151] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.593153] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 77.595410] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 77.597505] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 77.626255] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 77.629633] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 77.631646] systemd[1]: Stopping Reactivate sysinit units... machine # [ 77.633148] systemd[1]: Reached target Reactivate sysinit units. machine # [ 77.634771] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.637079] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 77.641810] systemd[1]: Reached target Local File Systems. machine # [ 77.644729] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 77.648827] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 77.649692] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 77.650938] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 77.663032] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 77.666535] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.667816] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.669186] systemd[1]: Reached target Remote File Systems. machine # [ 77.816901] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 77.820437] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 77.824479] systemd[1]: Starting linger-users.service... machine # [ 77.832277] systemd[1]: Starting test.service... machine # [ 77.866270] systemd[1]: Finished test.service. machine # [ 77.882552] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 77.885454] systemd[1]: Finished linger-users.service. machine # [ 78.140573] nixos[4902]: finished switching to system configuration /nix/store/adgb23x1g1pq20zxrzap2daywmhgcsab-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.70 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 78.361420] nixos[5044]: switching to system configuration /nix/store/x49qymmf7yknyqvd4sfc14nv2cgp1xv5-nixos-system-machine-test machine # [ 78.366698] systemd[1]: Stopped target Remote File Systems. machine # [ 78.367601] systemd[1]: Stopped target Local File Systems. machine # [ 78.635240] systemd[1]: Reload requested from client PID 5044 ('.switch-to-conf') (unit backdoor.service)... machine # [ 78.637325] systemd[1]: Reloading... machine # [ 78.939878] systemd[1]: Reloading finished in 301 ms. machine # [ 79.031502] systemd[554]: Reexecution requested from client PID 5113 ('switch-to-confi')... machine # [ 79.033841] systemd[554]: Reexecuting. machine # [ 79.091727] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.206531] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.213002] systemd[554]: Reload requested from client PID 5113 ('switch-to-confi')... machine # [ 79.216074] systemd[554]: Reloading... machine # [ 79.318909] systemd[554]: Reloading finished in 103 ms. machine # [ 79.336210] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.345414] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 79.347744] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 79.349893] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 79.379499] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 79.383349] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 79.387936] systemd[1]: Stopping Reactivate sysinit units... machine # [ 79.389301] systemd[1]: Reached target Reactivate sysinit units. machine # [ 79.390182] systemd[1]: test.service: Deactivated successfully. machine # [ 79.391014] systemd[1]: Stopped test.service. machine # [ 79.391651] systemd[1]: Stopping test.service... machine # [ 79.396533] systemd[1]: Starting test.service... machine # [ 79.416605] systemd[1]: Finished test.service. machine # [ 79.420701] systemd[1]: Reached target Local File Systems. machine # [ 79.422763] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.427755] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 79.437014] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 79.438634] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 79.439470] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 79.446730] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 79.450872] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 79.452985] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.454302] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.456442] systemd[1]: Reached target Remote File Systems. machine # [ 79.605891] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 79.608126] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 79.613183] systemd[1]: Starting linger-users.service... machine # [ 79.652535] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 79.654193] systemd[1]: Finished linger-users.service. machine # [ 79.910797] nixos[5044]: finished switching to system configuration /nix/store/x49qymmf7yknyqvd4sfc14nv2cgp1xv5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.77 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 80.149235] nixos[5186]: switching to system configuration /nix/store/5x4sv35mh0jf3bkg14rj16nhm6jcszr5-nixos-system-machine-test machine # [ 80.151830] systemd[1]: Stopped target Local File Systems. machine # [ 80.154353] systemd[1]: Stopped target Remote File Systems. machine # [ 80.973901] systemd[1]: Reload requested from client PID 5186 ('.switch-to-conf') (unit backdoor.service)... machine # [ 80.977057] systemd[1]: Reloading... machine # [ 81.305496] systemd[1]: Reloading finished in 326 ms. machine # [ 81.395924] systemd[554]: Reexecution requested from client PID 5255 ('switch-to-confi')... machine # [ 81.400518] systemd[554]: Reexecuting. machine # [ 81.455451] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.572579] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.580129] systemd[554]: Reload requested from client PID 5255 ('switch-to-confi')... machine # [ 81.581547] systemd[554]: Reloading... machine # [ 81.686686] systemd[554]: Reloading finished in 103 ms. machine # [ 81.704195] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.715192] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 81.717639] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 81.719785] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 81.752250] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 81.756515] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 81.758517] systemd[1]: Stopping Reactivate sysinit units... machine # [ 81.759415] systemd[1]: Reached target Reactivate sysinit units. machine # [ 81.763409] systemd[1]: test.service: Deactivated successfully. machine # [ 81.764466] systemd[1]: Stopped test.service. machine # [ 81.765126] systemd[1]: Stopping test.service... machine # [ 81.766880] systemd[1]: Starting test.service... machine # [ 81.794288] systemd[1]: Finished test.service. machine # [ 81.798847] systemd[1]: Reached target Remote File Systems. machine # [ 81.802925] systemd[1]: Starting linger-users.service... machine # [ 81.813630] systemd[1]: Reached target Local File Systems. machine # [ 81.817484] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 81.823636] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 81.829071] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 81.830401] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 81.846627] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 81.850591] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.851957] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.855239] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.858499] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 81.895472] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 81.900202] systemd[1]: Finished linger-users.service. machine # [ 82.041544] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 82.044560] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 82.300652] nixos[5186]: finished switching to system configuration /nix/store/5x4sv35mh0jf3bkg14rj16nhm6jcszr5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 2.39 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 82.531544] nixos[5328]: switching to system configuration /nix/store/adgb23x1g1pq20zxrzap2daywmhgcsab-nixos-system-machine-test machine # [ 82.537013] systemd[1]: Stopped target Remote File Systems. machine # [ 82.537957] systemd[1]: Stopped target Local File Systems. machine # [ 82.821333] systemd[1]: Reload requested from client PID 5328 ('.switch-to-conf') (unit backdoor.service)... machine # [ 82.823273] systemd[1]: Reloading... machine # [ 83.158475] systemd[1]: Reloading finished in 333 ms. machine # [ 83.246544] systemd[554]: Reexecution requested from client PID 5397 ('switch-to-confi')... machine # [ 83.247950] systemd[554]: Reexecuting. machine # [ 83.311474] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.426813] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.433443] systemd[554]: Reload requested from client PID 5397 ('switch-to-confi')... machine # [ 83.435675] systemd[554]: Reloading... machine # [ 83.540174] systemd[554]: Reloading finished in 103 ms. machine # [ 83.556179] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.566388] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 83.568806] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 83.571031] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 83.603709] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 83.607792] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 83.610018] systemd[1]: Stopping Reactivate sysinit units... machine # [ 83.610884] systemd[1]: Reached target Reactivate sysinit units. machine # [ 83.614793] systemd[1]: test.service: Deactivated successfully. machine # [ 83.615719] systemd[1]: Stopped test.service. machine # [ 83.620136] systemd[1]: Stopping test.service... machine # [ 83.620932] systemd[1]: Starting test.service... machine # [ 83.645033] systemd[1]: Finished test.service. machine # [ 83.653017] systemd[1]: Reached target Local File Systems. machine # [ 83.659944] systemd[1]: Reached target Remote File Systems. machine # [ 83.664350] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 83.666017] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 83.666861] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 83.672924] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 83.675216] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 83.679315] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.682441] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.685304] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.689870] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 83.850670] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 83.853551] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 83.858524] systemd[1]: Starting linger-users.service... machine # [ 83.901409] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 83.904410] systemd[1]: Finished linger-users.service. machine # [ 84.160219] nixos[5328]: finished switching to system configuration /nix/store/adgb23x1g1pq20zxrzap2daywmhgcsab-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.86 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 84.446655] nixos[5470]: switching to system configuration /nix/store/glwfga1vycga2574ldvirpdgfj3xxjh9-nixos-system-machine-test machine # [ 84.449880] systemd[1]: Stopped target Remote File Systems. machine # [ 84.452429] systemd[1]: Stopped target Local File Systems. machine # [ 84.801854] systemd[1]: Reload requested from client PID 5470 ('.switch-to-conf') (unit backdoor.service)... machine # [ 84.806856] systemd[1]: Reloading... machine # [ 85.310750] systemd[1]: Reloading finished in 501 ms. machine # [ 85.410538] systemd[554]: Reexecution requested from client PID 5539 ('switch-to-confi')... machine # [ 85.415198] systemd[554]: Reexecuting. machine # [ 85.459746] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.591178] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.598395] systemd[554]: Reload requested from client PID 5539 ('switch-to-confi')... machine # [ 85.602600] systemd[554]: Reloading... machine # [ 85.707224] systemd[554]: Reloading finished in 105 ms. machine # [ 85.724168] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.733976] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 85.736420] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 85.738587] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 85.772128] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 85.776664] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 85.777688] systemd[1]: Stopping Reactivate sysinit units... machine # [ 85.778503] systemd[1]: Reached target Reactivate sysinit units. machine # [ 85.781930] systemd[1]: Reached target Local File Systems. machine # [ 85.784918] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 85.790142] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 85.791052] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 85.801046] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 85.803313] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 85.809630] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.811225] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.814060] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.815390] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 85.817900] systemd[1]: Reached target Remote File Systems. machine # [ 85.968880] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 85.972447] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 85.976222] systemd[1]: Starting linger-users.service... machine # [ 86.016679] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 86.019070] systemd[1]: Finished linger-users.service. machine # [ 86.274760] nixos[5470]: finished switching to system configuration /nix/store/glwfga1vycga2574ldvirpdgfj3xxjh9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 2.11 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 86.506391] nixos[5610]: switching to system configuration /nix/store/4zjv79a0624l73szcas99icxhlbfi526-nixos-system-machine-test machine # [ 86.509183] systemd[1]: Stopped target Local File Systems. machine # [ 86.511568] systemd[1]: Stopped target Remote File Systems. machine # [ 86.813031] systemd[1]: Reload requested from client PID 5610 ('.switch-to-conf') (unit backdoor.service)... machine # [ 86.815219] systemd[1]: Reloading... machine # [ 87.124963] systemd[1]: Reloading finished in 308 ms. machine # [ 87.212599] systemd[554]: Reexecution requested from client PID 5679 ('switch-to-confi')... machine # [ 87.214064] systemd[554]: Reexecuting. machine # [ 87.275477] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.387609] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.394434] systemd[554]: Reload requested from client PID 5679 ('switch-to-confi')... machine # [ 87.397700] systemd[554]: Reloading... machine # [ 87.497512] systemd[554]: Reloading finished in 100 ms. machine # [ 87.512154] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.521876] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 87.524125] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 87.526361] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 87.554554] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 87.558564] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 87.561050] systemd[1]: Stopping Reactivate sysinit units... machine # [ 87.561933] systemd[1]: Reached target Reactivate sysinit units. machine # [ 87.565329] systemd[1]: test.service: Deactivated successfully. machine # [ 87.566260] systemd[1]: Stopped test.service. machine # [ 87.566904] systemd[1]: Stopping test.service... machine # [ 87.569700] systemd[1]: Starting test.service... machine # [ 87.592438] systemd[1]: Finished test.service. machine # [ 87.597658] systemd[1]: Reached target Local File Systems. machine # [ 87.600989] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 87.605418] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 87.606336] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 87.607552] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 87.616321] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 87.618086] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.619359] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.625453] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.626827] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 87.635127] systemd[1]: Reached target Remote File Systems. machine # [ 87.781325] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 87.783040] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 87.787623] systemd[1]: Starting linger-users.service... machine # [ 87.828288] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 87.831236] systemd[1]: Finished linger-users.service. machine # [ 88.086324] nixos[5610]: finished switching to system configuration /nix/store/4zjv79a0624l73szcas99icxhlbfi526-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 88.314889] nixos[5752]: switching to system configuration /nix/store/ryh6k4y10h1pjf0ax3z8m53y7rxlrmyl-nixos-system-machine-test machine # [ 88.317421] systemd[1]: Stopped target Remote File Systems. machine # [ 88.319933] systemd[1]: Stopped target Local File Systems. machine # [ 88.608250] systemd[1]: Reload requested from client PID 5752 ('.switch-to-conf') (unit backdoor.service)... machine # [ 88.610273] systemd[1]: Reloading... machine # [ 88.912734] systemd[1]: Reloading finished in 300 ms. machine # [ 88.998082] systemd[554]: Reexecution requested from client PID 5821 ('switch-to-confi')... machine # [ 88.999525] systemd[554]: Reexecuting. machine # [ 89.059509] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.169288] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.175492] systemd[554]: Reload requested from client PID 5821 ('switch-to-confi')... machine # [ 89.179043] systemd[554]: Reloading... machine # [ 89.278825] systemd[554]: Reloading finished in 100 ms. machine # [ 89.296158] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.305754] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 89.308075] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 89.310270] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 89.345034] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 89.348959] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 89.350810] systemd[1]: Stopping Reactivate sysinit units... machine # [ 89.351659] systemd[1]: Reached target Reactivate sysinit units. machine # [ 89.355969] systemd[1]: test.service: Deactivated successfully. machine # [ 89.360211] systemd[1]: Stopped test.service. machine # [ 89.360982] systemd[1]: Stopping test.service... machine # [ 89.361654] systemd[1]: Starting test.service... machine # [ 89.384151] systemd[1]: Finished test.service. machine # [ 89.390143] systemd[1]: Reached target Local File Systems. machine # [ 89.393859] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 89.397234] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 89.398105] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 89.399365] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 89.408153] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 89.409893] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.411171] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.419096] systemd[1]: Reached target Remote File Systems. machine # [ 89.419969] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.424431] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 89.568344] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 89.572592] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 89.575001] systemd[1]: Starting linger-users.service... machine # [ 89.615621] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 89.618745] systemd[1]: Finished linger-users.service. machine # [ 89.872332] nixos[5752]: finished switching to system configuration /nix/store/ryh6k4y10h1pjf0ax3z8m53y7rxlrmyl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.79 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 90.106257] nixos[5894]: switching to system configuration /nix/store/2zis3vc2p8qxw8g52iysnvq3k7yn9xl9-nixos-system-machine-test machine # [ 90.111670] systemd[1]: Stopped target Local File Systems. machine # [ 90.114045] systemd[1]: Stopped target Remote File Systems. machine # [ 90.382037] systemd[1]: Reload requested from client PID 5894 ('.switch-to-conf') (unit backdoor.service)... machine # [ 90.383927] systemd[1]: Reloading... machine # [ 90.684857] systemd[1]: Reloading finished in 299 ms. machine # [ 90.768274] systemd[554]: Reexecution requested from client PID 5963 ('switch-to-confi')... machine # [ 90.769793] systemd[554]: Reexecuting. machine # [ 90.827506] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 90.936892] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 90.943438] systemd[554]: Reload requested from client PID 5963 ('switch-to-confi')... machine # [ 90.945796] systemd[554]: Reloading... machine # [ 91.045930] systemd[554]: Reloading finished in 99 ms. machine # [ 91.060150] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.071366] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 91.072489] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 91.074799] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 91.106419] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 91.110556] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 91.115172] systemd[1]: Stopping Reactivate sysinit units... machine # [ 91.117236] systemd[1]: Reached target Reactivate sysinit units. machine # [ 91.118138] systemd[1]: test.service: Deactivated successfully. machine # [ 91.118972] systemd[1]: Stopped test.service. machine # [ 91.119609] systemd[1]: Stopping test.service... machine # [ 91.124239] systemd[1]: Starting test.service... machine # [ 91.144439] systemd[1]: Finished test.service. machine # [ 91.149859] systemd[1]: Reached target Local File Systems. machine # [ 91.153063] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 91.157540] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 91.158444] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 91.159747] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 91.175755] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 91.179942] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.181392] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.182587] systemd[1]: Reached target Remote File Systems. machine # [ 91.183365] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.185842] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 91.336259] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 91.338563] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 91.343020] systemd[1]: Starting linger-users.service... machine # [ 91.383547] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 91.386760] systemd[1]: Finished linger-users.service. machine # [ 91.641009] nixos[5894]: finished switching to system configuration /nix/store/2zis3vc2p8qxw8g52iysnvq3k7yn9xl9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 1.77 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 91.866980] nixos[6036]: switching to system configuration /nix/store/adgb23x1g1pq20zxrzap2daywmhgcsab-nixos-system-machine-test machine # [ 91.872854] systemd[1]: Stopped target Local File Systems. machine # [ 91.873759] systemd[1]: Stopped target Remote File Systems. machine # [ 92.170343] systemd[1]: Reload requested from client PID 6036 ('.switch-to-conf') (unit backdoor.service)... machine # [ 92.172447] systemd[1]: Reloading... machine # [ 92.473545] systemd[1]: Reloading finished in 299 ms. machine # [ 92.557654] systemd[554]: Reexecution requested from client PID 6105 ('switch-to-confi')... machine # [ 92.561885] systemd[554]: Reexecuting. machine # [ 92.615179] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.725505] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.732631] systemd[554]: Reload requested from client PID 6105 ('switch-to-confi')... machine # [ 92.736226] systemd[554]: Reloading... machine # [ 92.839773] systemd[554]: Reloading finished in 104 ms. machine # [ 92.856165] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.865581] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 92.867789] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 92.869964] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 92.898602] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 92.902494] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 92.907184] systemd[1]: Stopping Reactivate sysinit units... machine # [ 92.908327] systemd[1]: Reached target Reactivate sysinit units. machine # [ 92.909188] systemd[1]: test.service: Deactivated successfully. machine # [ 92.910018] systemd[1]: Stopped test.service. machine # [ 92.910682] systemd[1]: Stopping test.service... machine # [ 92.912087] systemd[1]: Starting test.service... machine # [ 92.936325] systemd[1]: Finished test.service. machine # [ 92.941552] systemd[1]: Reached target Remote File Systems. machine # [ 92.945689] systemd[1]: Starting linger-users.service... machine # [ 92.955802] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 92.962826] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 92.964260] systemd[1]: Reached target Local File Systems. machine # [ 92.965068] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 92.969936] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 92.970856] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 92.978116] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 92.984692] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 92.988111] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 92.989431] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.030233] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 93.033130] systemd[1]: Finished linger-users.service. machine # [ 93.164350] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 93.167787] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 93.421864] nixos[6036]: finished switching to system configuration /nix/store/adgb23x1g1pq20zxrzap2daywmhgcsab-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.78 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 93.664448] nixos[6178]: switching to system configuration /nix/store/hhl4pbhfrwh31nlxkpig79zywi6bfsvi-nixos-system-machine-test machine # [ 93.667273] systemd[1]: Stopped target Local File Systems. machine # [ 93.669946] systemd[1]: Stopped target Remote File Systems. machine # [ 93.946084] systemd[1]: Reload requested from client PID 6178 ('.switch-to-conf') (unit backdoor.service)... machine # [ 93.948319] systemd[1]: Reloading... machine # [ 94.252123] systemd[1]: Reloading finished in 302 ms. machine # [ 94.336771] systemd[554]: Reexecution requested from client PID 6247 ('switch-to-confi')... machine # [ 94.340087] systemd[554]: Reexecuting. machine # [ 94.395158] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.502717] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.509267] systemd[554]: Reload requested from client PID 6247 ('switch-to-confi')... machine # [ 94.511511] systemd[554]: Reloading... machine # [ 94.614358] systemd[554]: Reloading finished in 101 ms. machine # [ 94.628159] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.638200] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 94.640404] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 94.642493] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 94.674713] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 94.678907] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 94.683048] systemd[1]: Stopping Reactivate sysinit units... machine # [ 94.683935] systemd[1]: Reached target Reactivate sysinit units. machine # [ 94.686149] systemd[1]: Reloading test.service... machine # [ 94.707938] systemd[1]: Reloaded test.service. machine # [ 94.712606] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.716673] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 94.719200] systemd[1]: Reached target Local File Systems. machine # [ 94.721572] systemd[1]: Reached target Remote File Systems. machine # [ 94.725435] systemd[1]: Starting linger-users.service... machine # [ 94.735664] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 94.744609] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 94.745512] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 94.746762] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 94.756752] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 94.761245] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.762562] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.803831] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 94.808128] systemd[1]: Finished linger-users.service. machine # [ 94.936915] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 94.939872] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 95.195576] nixos[6178]: finished switching to system configuration /nix/store/hhl4pbhfrwh31nlxkpig79zywi6bfsvi-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.77 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 95.416826] nixos[6320]: switching to system configuration /nix/store/jb60wmrhqcmqqj8q15bc8gbw5a3alcjy-nixos-system-machine-test machine # [ 95.420507] systemd[1]: Stopped target Local File Systems. machine # [ 95.422887] systemd[1]: Stopped target Remote File Systems. machine # [ 95.693726] systemd[1]: Reload requested from client PID 6320 ('.switch-to-conf') (unit backdoor.service)... machine # [ 95.695600] systemd[1]: Reloading... machine # [ 95.998486] systemd[1]: Reloading finished in 301 ms. machine # [ 96.084406] systemd[554]: Reexecution requested from client PID 6389 ('switch-to-confi')... machine # [ 96.087822] systemd[554]: Reexecuting. machine # [ 96.139411] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.245492] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.252222] systemd[554]: Reload requested from client PID 6389 ('switch-to-confi')... machine # [ 96.254299] systemd[554]: Reloading... machine # [ 96.357429] systemd[554]: Reloading finished in 102 ms. machine # [ 96.372165] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.381372] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 96.383720] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 96.386053] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 96.414731] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 96.419039] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 96.420385] systemd[1]: Stopping Reactivate sysinit units... machine # [ 96.421274] systemd[1]: Reached target Reactivate sysinit units. machine # [ 96.426076] systemd[1]: Reloading test.service... machine # [ 96.448166] systemd[1]: Reloaded test.service. machine # [ 96.453703] systemd[1]: Reached target Local File Systems. machine # [ 96.457096] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 96.461386] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 96.462269] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 96.463535] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 96.472848] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 96.474469] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.475763] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.479761] systemd[1]: Reached target Remote File Systems. machine # [ 96.485190] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.486593] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 96.634554] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 96.639799] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 96.642525] systemd[1]: Starting linger-users.service... machine # [ 96.680426] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 96.683000] systemd[1]: Finished linger-users.service. machine # [ 96.938985] nixos[6320]: finished switching to system configuration /nix/store/jb60wmrhqcmqqj8q15bc8gbw5a3alcjy-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.74 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 97.163144] nixos[6462]: switching to system configuration /nix/store/nv8ydnrw61w938wk821lxhknridqbh3s-nixos-system-machine-test machine # [ 97.165983] systemd[1]: Stopped target Local File Systems. machine # [ 97.168299] systemd[1]: Stopped target Remote File Systems. machine # [ 97.445896] systemd[1]: Reload requested from client PID 6462 ('.switch-to-conf') (unit backdoor.service)... machine # [ 97.448139] systemd[1]: Reloading... machine # [ 97.755562] systemd[1]: Reloading finished in 306 ms. machine # [ 97.843146] systemd[554]: Reexecution requested from client PID 6531 ('switch-to-confi')... machine # [ 97.845987] systemd[554]: Reexecuting. machine # [ 97.903969] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.015163] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.022463] systemd[554]: Reload requested from client PID 6531 ('switch-to-confi')... machine # [ 98.028149] systemd[554]: Reloading... machine # [ 98.128530] systemd[554]: Reloading finished in 103 ms. machine # [ 98.144176] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.154586] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 98.157077] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 98.159275] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 98.191859] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 98.196489] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 98.200613] systemd[1]: Stopping Reactivate sysinit units... machine # [ 98.201525] systemd[1]: Reached target Reactivate sysinit units. machine # [ 98.202367] systemd[1]: test.service: Deactivated successfully. machine # [ 98.203190] systemd[1]: Stopped test.service. machine # [ 98.203820] systemd[1]: Stopping test.service... machine # [ 98.206825] systemd[1]: Starting test.service... machine # [ 98.233486] systemd[1]: Finished test.service. machine # [ 98.236779] systemd[1]: Reached target Local File Systems. machine # [ 98.240313] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.241781] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 98.244793] systemd[1]: Reached target Remote File Systems. machine # [ 98.250658] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 98.257520] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 98.258408] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 98.259679] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 98.269890] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 98.271543] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.273087] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.426960] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 98.430070] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 98.434137] systemd[1]: Starting linger-users.service... machine # [ 98.471047] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 98.473919] systemd[1]: Finished linger-users.service. machine # [ 98.730136] nixos[6462]: finished switching to system configuration /nix/store/nv8ydnrw61w938wk821lxhknridqbh3s-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.79 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 98.933706] nixos[6604]: switching to system configuration /nix/store/4zjv79a0624l73szcas99icxhlbfi526-nixos-system-machine-test machine # [ 98.936800] systemd[1]: Stopped target Local File Systems. machine # [ 98.939095] systemd[1]: Stopped target Remote File Systems. machine # [ 99.202439] systemd[1]: Reload requested from client PID 6604 ('.switch-to-conf') (unit backdoor.service)... machine # [ 99.204473] systemd[1]: Reloading... machine # [ 99.494935] systemd[1]: Reloading finished in 289 ms. machine # [ 99.584247] systemd[554]: Reexecution requested from client PID 6673 ('switch-to-confi')... machine # [ 99.585758] systemd[554]: Reexecuting. machine # [ 99.643211] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.753762] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.760023] systemd[554]: Reload requested from client PID 6673 ('switch-to-confi')... machine # [ 99.762327] systemd[554]: Reloading... machine # [ 99.865568] systemd[554]: Reloading finished in 102 ms. machine # [ 99.880162] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.889554] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 99.891814] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 99.893947] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 99.922118] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 99.925852] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 99.929358] systemd[1]: Stopping Reactivate sysinit units... machine # [ 99.930251] systemd[1]: Reached target Reactivate sysinit units. machine # [ 99.931816] systemd[1]: Reached target Local File Systems. machine # [ 99.936118] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 99.941949] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 99.942863] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 99.951463] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 99.955963] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 99.960336] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.961761] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.962972] systemd[1]: Reached target Remote File Systems. machine # [ 99.963777] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.965196] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 100.111265] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 100.116214] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 100.118242] systemd[1]: Starting linger-users.service... machine # [ 100.154945] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 100.158006] systemd[1]: Finished linger-users.service. machine # [ 100.411987] nixos[6604]: finished switching to system configuration /nix/store/4zjv79a0624l73szcas99icxhlbfi526-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.68 seconds) (finished: subtest: unit file parser, in 23.97 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 100.623083] nixos[6744]: switching to system configuration /nix/store/i0zlzq14q5qgifkff98aq2hxazw3kfl6-nixos-system-machine-test machine # [ 100.628515] systemd[1]: Stopped target Remote File Systems. machine # [ 100.629395] systemd[1]: Stopped target Local File Systems. machine # [ 100.888992] systemd[1]: Reload requested from client PID 6744 ('.switch-to-conf') (unit backdoor.service)... machine # [ 100.891033] systemd[1]: Reloading... machine # [ 101.196135] systemd[1]: Reloading finished in 303 ms. machine # [ 101.289180] systemd[554]: Reexecution requested from client PID 6813 ('switch-to-confi')... machine # [ 101.293522] systemd[554]: Reexecuting. machine # [ 101.347689] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.467155] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.474397] systemd[554]: Reload requested from client PID 6813 ('switch-to-confi')... machine # [ 101.476866] systemd[554]: Reloading... machine # [ 101.590736] systemd[554]: Reloading finished in 112 ms. machine # [ 101.608175] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.620246] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 101.623784] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 101.626129] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 101.657851] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 101.662033] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 101.665068] systemd[1]: Stopping Reactivate sysinit units... machine # [ 101.666021] systemd[1]: Reached target Reactivate sysinit units. machine # [ 101.666882] systemd[1]: Reached target Local File Systems. machine # [ 101.671316] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.674715] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 101.679514] systemd[1]: Reached target Remote File Systems. machine # [ 101.682500] systemd[1]: Starting linger-users.service... machine # [ 101.696823] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 101.708743] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 101.709787] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 101.712605] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 101.718990] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 101.723057] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.728004] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.772914] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 101.778340] systemd[1]: Finished linger-users.service. machine # [ 101.926831] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 101.930078] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 102.185696] nixos[6744]: finished switching to system configuration /nix/store/i0zlzq14q5qgifkff98aq2hxazw3kfl6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.77 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 102.408392] nixos[6884]: switching to system configuration /nix/store/jxsfk8vkv4idiwhcd89dnagy80x5b7pn-nixos-system-machine-test machine # [ 102.411007] systemd[1]: Stopped target Local File Systems. machine # [ 102.414115] systemd[1]: test.service: Deactivated successfully. machine # [ 102.415060] systemd[1]: Stopped test.service. machine # [ 102.415713] systemd[1]: Stopped target Remote File Systems. machine # [ 102.714993] systemd[1]: Reload requested from client PID 6884 ('.switch-to-conf') (unit backdoor.service)... machine # [ 102.717561] systemd[1]: Reloading... machine # [ 103.034959] systemd[1]: Reloading finished in 316 ms. machine # [ 103.122941] systemd[554]: Reexecution requested from client PID 6955 ('switch-to-confi')... machine # [ 103.125301] systemd[554]: Reexecuting. machine # [ 103.187703] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.299734] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.306221] systemd[554]: Reload requested from client PID 6955 ('switch-to-confi')... machine # [ 103.308373] systemd[554]: Reloading... machine # [ 103.409291] systemd[554]: Reloading finished in 99 ms. machine # [ 103.424164] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.434114] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 103.436449] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 103.438526] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 103.470275] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 103.474171] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 103.476775] systemd[1]: Stopping Reactivate sysinit units... machine # [ 103.477634] systemd[1]: Reached target Reactivate sysinit units. machine # [ 103.482816] systemd[1]: Starting simple-service.service... machine # [ 103.491124] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.492894] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 103.503910] systemd[1]: Starting simple-restart-service.service... machine # [ 103.513356] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 103.523261] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 103.531444] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 103.543444] systemd[1]: Starting no-restart-service.service... machine # [ 103.548245] systemd[1]: Reached target Local File Systems. machine # [ 103.562058] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 103.563213] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 103.586492] systemd[1]: Reached target Remote File Systems. machine # [ 103.587399] systemd[1]: Starting linger-users.service... machine # [ 103.617639] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 103.618696] systemd[1]: Starting reload-triggers.service... machine # [ 103.659416] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 103.687059] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 103.710049] systemd[1]: Finished simple-service.service. machine # [ 103.711005] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 103.749326] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 103.768559] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 103.788753] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 103.806207] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 103.819567] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 103.831534] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 103.839864] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 103.847103] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 103.853360] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.854704] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.855899] systemd[1]: Finished simple-restart-service.service. machine # [ 103.862366] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 103.863374] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 103.869902] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 103.871075] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 103.875546] systemd[1]: Finished no-restart-service.service. machine # [ 103.877092] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 103.877989] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 103.879074] systemd[1]: Finished reload-triggers.service. machine # [ 103.879856] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 103.882617] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 103.885051] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 103.886748] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 103.887667] systemd[1]: Finished linger-users.service. machine # [ 104.007771] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 104.010837] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 104.015909] systemd[1]: Starting simple-reload-service.service... machine # [ 104.020448] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 104.032130] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 104.070936] systemd[1]: Finished simple-reload-service.service. machine # [ 104.073599] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 104.076151] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 104.332631] nixos[6884]: finished switching to system configuration /nix/store/jxsfk8vkv4idiwhcd89dnagy80x5b7pn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.15 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 104.576830] nixos[7054]: switching to system configuration /nix/store/jxsfk8vkv4idiwhcd89dnagy80x5b7pn-nixos-system-machine-test machine # [ 104.579255] systemd[1]: Stopped target Remote File Systems. machine # [ 104.581666] systemd[1]: Stopped target Local File Systems. machine # [ 104.856594] systemd[1]: Reload requested from client PID 7054 ('.switch-to-conf') (unit backdoor.service)... machine # [ 104.858476] systemd[1]: Reloading... machine # [ 105.170606] systemd[1]: Reloading finished in 310 ms. machine # [ 105.260666] systemd[554]: Reexecution requested from client PID 7125 ('switch-to-confi')... machine # [ 105.265944] systemd[554]: Reexecuting. machine # [ 105.319377] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.427372] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.434313] systemd[554]: Reload requested from client PID 7125 ('switch-to-confi')... machine # [ 105.437805] systemd[554]: Reloading... machine # [ 105.538374] systemd[554]: Reloading finished in 101 ms. machine # [ 105.552146] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.561192] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 105.563507] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 105.565822] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 105.594562] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 105.597987] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 105.600902] systemd[1]: Stopping Reactivate sysinit units... machine # [ 105.601752] systemd[1]: Reached target Reactivate sysinit units. machine # [ 105.606899] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 105.614667] systemd[1]: Reloading reload-triggers.service... machine # [ 105.627107] systemd[1]: Reloading simple-reload-service.service... machine # [ 105.635365] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 105.642671] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 105.652098] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 105.716904] systemd[1]: Reloaded simple-reload-service.service. machine # [ 105.725211] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 105.726532] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 105.727525] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 105.731590] systemd[1]: Reloaded reload-triggers.service. machine # [ 105.735363] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 105.737735] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 105.738960] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 105.739903] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 105.759801] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 105.769578] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 105.770678] systemd[1]: Stopped simple-restart-service.service. machine # [ 105.771533] systemd[1]: Stopping simple-restart-service.service... machine # [ 105.781242] systemd[1]: Starting simple-restart-service.service... machine # [ 105.782191] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 105.783108] systemd[1]: Stopped simple-service.service. machine # [ 105.783892] systemd[1]: Stopping simple-service.service... machine # [ 105.810205] systemd[1]: Starting simple-service.service... machine # [ 105.811100] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 105.827754] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 105.839664] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 105.856682] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 105.861725] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 105.864777] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 105.866008] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 105.867072] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 105.873088] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 105.874618] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 105.876275] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 105.877302] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 105.878280] systemd[1]: Finished simple-restart-service.service. machine # [ 105.879125] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 105.884830] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 105.886141] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 105.887182] systemd[1]: Finished simple-service.service. machine # [ 105.887945] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 105.893058] systemd[1]: Reached target Local File Systems. machine # [ 105.893915] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 105.895186] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 105.902803] systemd[1]: Reached target Remote File Systems. machine # [ 105.908060] systemd[1]: Starting linger-users.service... machine # [ 105.908925] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 105.922402] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 105.923327] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 105.925407] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 105.927627] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 105.929595] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 105.930849] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 105.980804] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 105.984575] systemd[1]: Finished linger-users.service. machine # [ 106.106240] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 106.108182] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 106.364688] nixos[7054]: finished switching to system configuration /nix/store/jxsfk8vkv4idiwhcd89dnagy80x5b7pn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.03 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 106.630963] nixos[7220]: switching to system configuration /nix/store/an9lzc849l4k32b0fndjr7ajr0mc11wv-nixos-system-machine-test machine # [ 106.633513] systemd[1]: Stopped target Local File Systems. machine # [ 106.635670] systemd[1]: Stopped target Remote File Systems. machine # [ 106.925858] systemd[1]: Reload requested from client PID 7220 ('.switch-to-conf') (unit backdoor.service)... machine # [ 106.927764] systemd[1]: Reloading... machine # [ 107.245766] systemd[1]: Reloading finished in 316 ms. machine # [ 107.333150] systemd[554]: Reexecution requested from client PID 7291 ('switch-to-confi')... machine # [ 107.337358] systemd[554]: Reexecuting. machine # [ 107.382778] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.486393] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.493249] systemd[554]: Reload requested from client PID 7291 ('switch-to-confi')... machine # [ 107.496775] systemd[554]: Reloading... machine # [ 107.597293] systemd[554]: Reloading finished in 101 ms. machine # [ 107.612149] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.621437] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 107.623695] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 107.625959] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 107.654370] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 107.658237] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 107.663094] systemd[1]: Stopping Reactivate sysinit units... machine # [ 107.663989] systemd[1]: Reached target Reactivate sysinit units. machine # [ 107.672706] systemd[1]: Reloading reload-triggers.service... machine # [ 107.673573] systemd[1]: Reloading simple-reload-service.service... machine # [ 107.689370] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 107.692233] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 107.740794] systemd[1]: Reloaded reload-triggers.service. machine # [ 107.743758] systemd[1]: Reloaded simple-reload-service.service. machine # [ 107.746252] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 107.751352] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 107.756588] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 107.759943] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 107.761322] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 107.763414] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 107.773347] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 107.774485] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 107.775369] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 107.788654] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 107.789660] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 107.790680] systemd[1]: Stopped simple-restart-service.service. machine # [ 107.791543] systemd[1]: Stopping simple-restart-service.service... machine # [ 107.819182] systemd[1]: Starting simple-restart-service.service... machine # [ 107.834848] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 107.853389] systemd[1]: Stopped simple-service.service. machine # [ 107.856574] systemd[1]: Stopping simple-service.service... machine # [ 107.864810] systemd[1]: Starting simple-service.service... machine # [ 107.865720] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 107.893010] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 107.910892] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 107.921642] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 107.934246] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 107.948813] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 107.950168] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 107.951306] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 107.957401] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 107.958799] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 107.959838] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 107.964707] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 107.965854] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 107.966985] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 107.967922] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 107.972410] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 107.973508] systemd[1]: Finished simple-restart-service.service. machine # [ 107.974366] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 107.975249] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 107.988640] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 107.989827] systemd[1]: Finished simple-service.service. machine # [ 107.990578] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 107.991746] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 107.997337] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 107.998370] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 107.999693] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 108.001200] systemd[1]: Reached target Local File Systems. machine # [ 108.002000] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 108.003471] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 108.005617] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 108.008075] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 108.010910] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 108.013510] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.017089] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.018384] systemd[1]: Reached target Remote File Systems. machine # [ 108.158531] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 108.163556] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 108.168277] systemd[1]: Starting linger-users.service... machine # [ 108.204833] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 108.207984] systemd[1]: Finished linger-users.service. machine # [ 108.462359] nixos[7220]: finished switching to system configuration /nix/store/an9lzc849l4k32b0fndjr7ajr0mc11wv-nixos-system-machine-test machine: (finished: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.10 seconds) machine: must succeed: /nix/store/q90jk00yvb205rbm43jfmwrk33ainags-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/q90jk00yvb205rbm43jfmwrk33ainags-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.35 seconds) (finished: subtest: restart and reload by activation script, in 8.40 seconds) (finished: run the VM test script, in 112.87 seconds) test script finished in 112.91s 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-19T03:00:41Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-19T03:00:41Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-19T03:00:41Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.19 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