tribuchet: building on eliza Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script machine: waiting for unit multi-user.target machine: waiting for the VM to finish booting machine: starting vm machine: QEMU running (pid 45) machine # Disk image does not exist, creating the virtualisation disk image... machine # Formatting '/build/vm-state-machine/tmp.FyzlCCPgzi', 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: b4c47f7d-d06d-44d0-869e-9653bb4ea2ea 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-03T03:25:55Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-03T03:25:55Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-03T03:25:55Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-03T03:25:55Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-03T03:25:55Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-03T03:25:55Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-03T03:25:55Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-03T03:25:55Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-03T03:25:55Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-03T03:25:55Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-03T03:25:55Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-03T03:25:55Z INFO virtiofsd] Client connected, servicing requests machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 2026 machine # [ 0.000000] KASLR enabled machine # [ 0.000000] random: crng init done machine # [ 0.000000] Machine model: linux,dummy-virt machine # [ 0.000000] efi: UEFI not found. machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f] machine # [ 0.000000] Zone ranges: machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] DMA32 empty machine # [ 0.000000] Normal empty machine # [ 0.000000] Device empty machine # [ 0.000000] Movable zone start for each node machine # [ 0.000000] Early memory node ranges machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000 machine # [ 0.000000] psci: probing for conduit method from DT. machine # [ 0.000000] psci: PSCIv1.3 detected in firmware. machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs machine # [ 0.000000] psci: Trusted OS migration not required machine # [ 0.000000] psci: SMC Calling Convention v1.1 machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186776 r8192 d116328 u311296 machine # [ 0.000000] Detected PIPT I-cache on CPU0 machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) machine # [ 0.000000] CPU features: detected: GICv3 CPU interface machine # [ 0.000000] CPU features: detected: Spectre-v4 machine # [ 0.000000] CPU features: detected: Spectre-BHB machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 machine # [ 0.000000] alternatives: applying boot alternatives machine # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/init regInfo=/nix/.ro-store/maih5mmwk1lmfnnh5kcy2dfhxjv2grvx-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/maih5mmwk1lmfnnh5kcy2dfhxjv2grvx-closure-info/registration", will be passed to user space. machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB machine # [ 0.000000] software IO TLB: area num 1. machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB) machine # [ 0.000000] Fallback order for Node 0: 0 machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 machine # [ 0.000000] Policy zone: DMA machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.000000] allocated 2097152 bytes of page_ext machine # [ 0.000000] ftrace: allocating 75026 entries in 294 pages machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups machine # [ 0.000000] rcu: Hierarchical RCU implementation. machine # [ 0.000000] rcu: RCU event tracing is enabled. machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. machine # [ 0.000000] Rude variant of Tasks RCU enabled. machine # [ 0.000000] Tracing variant of Tasks RCU enabled. machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 machine # [ 0.000000] GICv3: 256 SPIs implemented machine # [ 0.000000] GICv3: 0 Extended SPIs implemented machine # [ 0.000000] Root IRQ handler: gic_handle_irq machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1) machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1) machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000 machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns machine # [ 0.000034] arm-pv: using stolen time PV machine # [ 0.000447] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000655] Console: colour dummy device 80x25 machine # [ 0.000664] printk: legacy console [tty0] enabled machine # [ 0.000854] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000861] pid_max: default: 32768 minimum: 301 machine # [ 0.000963] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.001093] landlock: Up and running. machine # [ 0.001096] Yama: becoming mindful. machine # [ 0.001558] LSM support for eBPF active machine # [ 0.001683] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.001709] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.003646] rcu: Hierarchical SRCU implementation. machine # [ 0.003652] rcu: Max phase no-delay instances is 1000. machine # [ 0.005031] fsl-mc MSI: its@8080000 domain created machine # [ 0.005155] EFI services will not be available. machine # [ 0.005245] smp: Bringing up secondary CPUs ... machine # [ 0.005256] smp: Brought up 1 node, 1 CPU machine # [ 0.005259] SMP: Total of 1 processors activated. machine # [ 0.005262] CPU: All CPU(s) started at EL1 machine # [ 0.005273] CPU features: detected: Branch Target Identification machine # [ 0.005280] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.005284] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.005288] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.005291] CPU features: detected: Common not Private translations machine # [ 0.005295] CPU features: detected: CRC32 instructions machine # [ 0.005298] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.005301] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.005305] CPU features: detected: Data independent timing control (DIT) machine # [ 0.005307] CPU features: detected: E0PD machine # [ 0.005310] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.005313] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.005317] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.005320] CPU features: detected: Fine Grained Traps machine # [ 0.005323] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.005327] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.005330] CPU features: detected: LSE atomic instructions machine # [ 0.005333] CPU features: detected: Privileged Access Never machine # [ 0.005335] CPU features: detected: PMUv3 machine # [ 0.005338] CPU features: detected: RAS Extension Support machine # [ 0.005341] CPU features: detected: RASv1p1 Extension Support machine # [ 0.005344] CPU features: detected: Random Number Generator machine # [ 0.005346] CPU features: detected: Speculation barrier (SB) machine # [ 0.005349] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.005351] CPU features: detected: TLB range maintenance instructions machine # [ 0.005356] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.005395] alternatives: applying system-wide alternatives machine # [ 0.008444] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.008601] Memory: 893664K/1048576K available (24512K kernel code, 7094K rwdata, 26568K rodata, 4736K init, 1106K bss, 113588K reserved, 32768K cma-reserved) machine # [ 0.008953] devtmpfs: initialized machine # [ 0.010749] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.010773] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.010954] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.010959] 0 pages in range for non-PLT usage machine # [ 0.010960] 508208 pages in range for PLT usage machine # [ 0.011054] pinctrl core: initialized pinctrl subsystem machine # [ 0.011923] DMI not present or invalid. machine # [ 0.015223] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.017543] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.017700] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.017865] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.017889] audit: initializing netlink subsys (disabled) machine # [ 0.018491] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.018494] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.018497] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.018500] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.018503] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.018531] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 machine # [ 0.018540] cpuidle: using governor ladder machine # [ 0.018547] cpuidle: using governor menu machine # [ 0.018773] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.018791] ASID allocator initialised with 65536 entries machine # [ 0.020017] Serial: AMBA PL011 UART driver machine # [ 0.026018] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.026186] printk: console [ttyAMA0] enabled machine # [ 0.155616] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.155625] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.155628] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.155631] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.155634] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.155637] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.155640] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.155643] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.156991] fbcon: Taking over console machine # [ 0.157002] ACPI: Interpreter disabled. machine # [ 0.157984] iommu: Default domain type: Translated machine # [ 0.157989] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.158356] SCSI subsystem initialized machine # [ 0.158533] usbcore: registered new interface driver usbfs machine # [ 0.158562] usbcore: registered new interface driver hub machine # [ 0.158578] usbcore: registered new device driver usb machine # [ 0.170364] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.170369] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.170376] PTP clock support registered machine # [ 0.170446] EDAC MC: Ver: 3.0.0 machine # [ 0.170625] scmi_core: SCMI protocol bus registered machine # [ 0.179113] FPGA manager framework machine # [ 0.179618] vgaarb: loaded machine # [ 0.179915] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.185592] VFS: Disk quotas dquot_6.6.0 machine # [ 0.185625] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.185947] netfs: FS-Cache loaded machine # [ 0.186066] pnp: PnP ACPI: disabled machine # [ 0.193985] NET: Registered PF_INET protocol family machine # [ 0.194135] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.224901] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.224943] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.224969] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.225016] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.225088] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.225213] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.225269] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.225316] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.225428] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.225498] NET: Registered PF_XDP protocol family machine # [ 0.225516] PCI: CLS 0 bytes, default 64 machine # [ 0.225801] Trying to unpack rootfs image as initramfs... machine # [ 0.243948] kvm [1]: HYP mode not available machine # [ 0.348499] Initialise system trusted keyrings machine # [ 0.348709] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.349090] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.349140] 9p: Installing v9fs 9p2000 file system support machine # [ 0.372027] Key type asymmetric registered machine # [ 0.372043] Asymmetric key parser 'x509' registered machine # [ 0.372117] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.372277] io scheduler mq-deadline registered machine # [ 0.372281] io scheduler kyber registered machine # [ 0.384633] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.385229] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.385593] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.385606] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.385617] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.385622] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.385647] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.385667] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.385737] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.385744] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.385747] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.385750] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.385754] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.385811] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.386246] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.386429] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.386441] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.386467] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.386478] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.386940] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.387122] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.387133] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.387158] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.387634] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.387815] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.387826] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.387851] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.416441] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.416655] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.416667] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.416692] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.416706] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.417171] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.417358] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.417383] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.417834] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.418019] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.418044] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.418467] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.418648] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.418894] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.419080] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.419105] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.419560] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.419743] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.419768] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.444381] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.444639] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.444666] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.445146] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.445416] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.445428] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.445453] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.445910] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.446090] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.446101] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.446126] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.446749] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.446755] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.446758] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.446803] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.446848] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.446891] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.446935] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.446985] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.447030] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.447075] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.447119] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.447162] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.447227] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.447269] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.447287] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.447304] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.447321] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.447339] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.447356] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.447373] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.447392] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.447409] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.447430] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.447448] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.447466] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.447483] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.447500] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.447517] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned machine # [ 0.447534] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned machine # [ 0.447552] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.447569] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.447591] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.447596] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.447599] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.488313] pci 0000:00:07.0: enabling device (0000 -> 0002) machine # [ 0.511662] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.521462] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.523769] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.533317] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.536925] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002) machine # [ 0.538911] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002) machine # [ 0.548507] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.550479] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.560133] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.562016] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.566054] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.578924] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.580817] msm_serial: driver initialized machine # [ 0.580949] SuperH (H)SCI(F) driver initialized machine # [ 0.581008] STM32 USART driver initialized machine # [ 0.612952] loop: module loaded machine # [ 0.613115] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 0.613908] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.620499] megasas: 07.734.00.00-rc1 machine # [ 0.621306] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.623197] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.623211] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.637079] Using buffer write method machine # [ 0.637115] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.638875] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.638888] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.643817] Using buffer write method machine # [ 0.643831] Concatenating MTD devices: machine # [ 0.643833] (0): "0.flash" machine # [ 0.643836] (1): "0.flash" machine # [ 0.643838] into device "0.flash" machine # [ 0.910700] Freeing initrd memory: 26408K machine # [ 0.917082] tun: Universal TUN/TAP device driver, 1.6 machine # [ 0.920846] thunder_xcv, ver 1.0 machine # [ 0.920875] thunder_bgx, ver 1.0 machine # [ 0.920897] nicpf, ver 1.0 machine # [ 0.921451] e1000: Intel(R) PRO/1000 Network Driver machine # [ 0.921456] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 0.921481] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 0.921490] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 0.921517] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 0.921520] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 0.921539] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 0.921543] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 0.921679] sky2: driver version 1.30 machine # [ 0.923360] usbcore: registered new interface driver usb-storage machine # [ 0.923482] usbcore: registered new interface driver usbserial_generic machine # [ 0.923494] usbserial: USB Serial support registered for generic machine # [ 0.924697] ehci-pci 0000:00:07.0: EHCI Host Controller machine # [ 0.924721] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1 machine # [ 0.924935] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000 machine # [ 0.936845] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00 machine # [ 0.937164] hub 1-0:1.0: USB hub found machine # [ 0.937181] hub 1-0:1.0: 6 ports detected machine # [ 0.937818] hv_vmbus: registering driver hyperv_keyboard machine # [ 0.938694] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 0.938714] rtc-pl031 9010000.pl031: setting system clock to 2026-10-03T03:25:57 UTC (1790997957) machine # [ 0.939020] i2c_dev: i2c /dev entries driver machine # [ 0.946950] sdhci: Secure Digital Host Controller Interface driver machine # [ 0.946956] sdhci: Copyright(c) Pierre Ossman machine # [ 0.947237] Synopsys Designware Multimedia Card Interface Driver machine # [ 0.947620] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 0.952061] hid: raw HID events driver (C) Jiri Kosina machine # [ 0.952290] usbcore: registered new interface driver usbhid machine # [ 0.952294] usbhid: USB HID core driver machine # [ 0.953461] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 0.955031] drop_monitor: Initializing network drop monitor service machine # [ 0.955158] NET: Registered PF_INET6 protocol family machine # [ 0.955684] Segment Routing with IPv6 machine # [ 0.955707] In-situ OAM (IOAM) with IPv6 machine # [ 0.955754] NET: Registered PF_PACKET protocol family machine # [ 0.955806] 9pnet: Installing 9P2000 support machine # [ 0.955842] Key type dns_resolver registered machine # [ 0.969028] registered taskstats version 1 machine # [ 0.969165] Loading compiled-in X.509 certificates machine # [ 0.977931] Demotion targets for Node 0: null machine # [ 0.978032] Key type .fscrypt registered machine # [ 0.978035] Key type fscrypt-provisioning registered machine # [ 0.978136] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.978153] ima: Allocated hash algorithm: sha1 machine # [ 0.978173] ima: No architecture policies found machine # [ 0.978752] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 1.001070] clk: Disabling unused clocks machine # [ 1.001087] PM: genpd: Disabling unused power domains machine # [ 1.005330] Freeing unused kernel memory: 4736K machine # [ 1.005541] Run /init as init process machine # [ 1.022323] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.022739] systemd[1]: systemd 263-0794ba0 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 1.022752] systemd[1]: Detected virtualization qemu. machine # [ 1.022787] systemd[1]: Detected architecture arm64. machine # [ 1.022793] systemd[1]: Running in initrd. machine # [ 1.023058] systemd[1]: Initializing machine ID from random generator. machine # [ 1.023151] systemd[1]: Hostname set to . machine # [ 1.121799] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.174329] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.181876] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.182039] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.182067] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.182086] systemd[1]: Reached target Path Units. machine # [ 1.182099] systemd[1]: Reached target Slice Units. machine # [ 1.182111] systemd[1]: Reached target Swaps. machine # [ 1.182124] systemd[1]: Reached target Timer Units. machine # [ 1.182242] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.182359] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.182497] systemd[1]: Listening on Journal Sockets. machine # [ 1.182564] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.182576] systemd[1]: Reached target Socket Units. machine # [ 1.183806] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.183860] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.183991] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.204117] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.212113] systemd[1]: Starting Journal Service... machine # [ 1.240073] systemd[1]: Starting Load Kernel Modules... machine # [ 1.240177] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.241555] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.255505] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.257639] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.258670] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.266130] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.269407] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.289663] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0 machine # [ 1.289888] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.289892] [drm] features: -context_init machine # [ 1.290628] [drm] number of scanouts: 1 machine # [ 1.290640] [drm] number of cap sets: 0 machine # [ 1.307870] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic machine # [ 1.307884] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0 machine # [ 1.317192] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.324302] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.331606] systemd-journald[71]: Collecting audit messages is disabled. machine # [ 1.336862] Console: switching to colour frame buffer device 160x50 machine # [ 1.354473] 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.358410] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.368504] systemd[1]: Finished Load Kernel Modules. machine # [ 1.373156] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.392162] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.392410] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.392441] systemd[1]: Reached target Local File Systems. machine # [ 1.394896] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.436147] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0 machine # [ 1.440378] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.474849] systemd-modules-load[72]: Inserted module 'dm_mod' machine # [ 1.488242] systemd[1]: Started Journal Service. machine # [ 1.476943] systemd-modules-load[72]: Module 'virtio_balloon' is built in machine # [ 1.484383] systemd-modules-load[72]: Module 'virtio_console' is built in machine # [ 1.490776] systemd-modules-load[72]: Inserted module 'virtio_gpu' machine # [ 1.491894] systemd-modules-load[72]: Module 'virtio_rng' is built in machine # [ 1.500330] systemd[1]: Starting Create System Files and Directories... machine # [ 1.501939] systemd-udevd[80]: Using default interface naming scheme 'v261'. machine # [ 1.537205] systemd[1]: Finished Create System Files and Directories. machine # [ 1.560020] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.550842] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.636975] systemd[1]: Starting Virtual Console Setup... machine # [ 1.720543] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 machine # [ 1.720811] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0 machine # [ 1.725260] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 1.730966] systemd[1]: Finished Virtual Console Setup. machine # [ 2.424498] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.428098] systemd[1]: Reached target System Initialization. machine # [ 2.429916] systemd[1]: Reached target Basic System. machine # [ 2.575898] (udev-worker)[94]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.612551] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.692963] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.699177] systemd[1]: Reached target Initrd Root Device. machine # [ 2.708150] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 2.748245] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 2.772228] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.776256] systemd[1]: Mounting /sysroot... machine # [ 2.830080] EXT4-fs (vda): mounted filesystem b4c47f7d-d06d-44d0-869e-9653bb4ea2ea r/w with ordered data mode. Quota mode: none. machine # [ 2.822559] systemd[1]: Mounted /sysroot. machine # [ 2.825083] systemd[1]: Reached target Initrd Root File System. machine # [ 2.832147] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.859355] systemd-sysroot-fstab-check[119]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.865518] systemd[1]: Reload requested from client PID 119 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.871244] systemd[1]: Reloading... machine # [ 3.072153] systemd[1]: Reloading finished in 202 ms. machine # [ 3.099216] systemd-sysroot-fstab-check[119]: Requesting initrd-fs.target/start/replace... machine # [ 3.105203] systemd-sysroot-fstab-check[119]: Requesting swap.target/start/replace... machine # [ 3.111391] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.114115] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.117483] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.232442] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.251489] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.259454] systemd[1]: Mounting /sysroot/run... machine # [ 3.274590] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.306498] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.378576] fuse: init (API version 7.45) machine # [ 3.386982] virtiofs virtio6: discovered new tag: nix-store machine # [ 3.387798] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 3.402798] virtiofs virtio7: discovered new tag: shared machine # [ 3.403581] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 3.410607] virtiofs virtio8: discovered new tag: xchg machine # [ 3.411369] virtiofs virtio8: virtio_fs_setup_dax: No cache capability machine # [ 3.403511] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.405512] systemd[1]: Mounted /sysroot/run. machine # [ 3.410367] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.416134] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.432379] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.434686] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.459794] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.461817] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.058169] (udev-worker)[94]: mtd0ro: Failed to find and pin callout binary "/nix/store/plb3zx1vfhpj0f04399z23ccfg9nlzfb-systemd-263-0794ba0/lib/udev/mtd_probe": No such file or directory machine # [ 4.068229] (udev-worker)[94]: mtd0ro: /etc/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory machine # [ 4.104565] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.106260] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.107556] systemd[1]: Stopping Virtual Console Setup... machine # [ 4.112347] systemd[1]: Starting Virtual Console Setup... machine # [ 4.138178] systemd-vconsole-setup[151]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 4.141773] systemd[1]: Finished Virtual Console Setup. machine # [ 4.231601] systemd[1]: Mounting /sysroot/nix/store... machine # [ 4.274621] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.277054] systemd[1]: Reached target Initrd File Systems. machine # [ 4.280983] systemd[1]: Starting Find NixOS closure... machine # [ 4.292310] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.332167] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.334795] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 4.343071] systemd[1]: Finished Find NixOS closure. machine # [ 4.344091] systemd[1]: Reached target Initrd Default Target. machine # [ 4.348350] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.371976] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.373731] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.377176] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.380317] systemd[1]: Stopped target Basic System. machine # [ 4.383718] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.388305] systemd[1]: Stopped target Path Units. machine # [ 4.389210] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.390397] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.391602] systemd[1]: Stopped target Slice Units. machine # [ 4.400290] systemd[1]: Stopped target Socket Units. machine # [ 4.402526] systemd[1]: Stopped target System Initialization. machine # [ 4.403523] systemd[1]: Stopped target Swaps. machine # [ 4.405826] systemd[1]: Stopped target Timer Units. machine # [ 4.406586] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.407431] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.412242] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.416277] systemd[1]: Stopped Find NixOS closure. machine # [ 4.420448] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.423716] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.428613] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.429496] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.430525] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.431264] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.434043] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.436329] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.437599] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.438531] systemd[1]: Stopped target Local File Systems. machine # [ 4.439347] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.440411] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.441445] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.442252] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.443323] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.448300] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.449965] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.452293] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.456478] systemd[1]: systemd-udevd.service: Consumed 1.613s CPU time over 3.036s wall clock time, 25.3M memory peak. machine # [ 4.458062] systemd[1]: Starting Cleanup udev Database... machine # [ 4.460203] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.464141] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.465093] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.466273] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.472310] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.473454] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.474368] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.475419] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.501390] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.504496] systemd[1]: Finished Cleanup udev Database. machine # [ 4.505373] systemd[1]: Reached target Switch Root. machine # [ 4.506858] systemd[1]: Starting NixOS Activation... machine # [ 4.590530] initrd-nixos-activation-start[174]: booting system configuration /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test machine # [ 4.623994] initrd-nixos-activation-start[174]: running activation script... machine # [ 4.865366] initrd-nixos-activation-start[197]: setting up /etc... machine # [ 4.988427] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 4.991453] systemd[1]: Finished NixOS Activation. machine # [ 4.996283] systemd[1]: Starting Switch Root... machine # [ 5.016385] systemd[1]: Switching root. machine # [ 5.197718] systemd-journald[71]: Received SIGTERM from PID 1 (systemd). machine # [ 5.359090] systemd[1]: systemd 263-0794ba0 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 5.367615] systemd[1]: Detected virtualization qemu. machine # [ 5.370095] systemd[1]: Detected architecture arm64. machine # [ 5.370796] systemd[1]: Detected first boot. machine # [ 5.374683] systemd[1]: Initializing machine ID from random generator. machine # [ 5.486728] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 5.631163] systemd[1]: Applying preset policy. machine # [ 5.824871] systemd[1]: Populated /etc with preset unit settings. machine # [ 6.021349] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 6.022140] systemd[1]: Stopped initrd-switch-root.service. machine # [ 6.026534] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 6.030512] systemd[1]: Created slice Slice /system/getty. machine # [ 6.031745] systemd[1]: Created slice User and Session Slice. machine # [ 6.034578] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 6.035081] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 6.035673] systemd[1]: Expecting device /dev/hvc0... machine # [ 6.039594] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 6.041401] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 6.041818] systemd[1]: Stopped target initrd-fs.target. machine # [ 6.042427] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 6.043027] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 6.043638] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 6.048813] systemd[1]: Reached target Path Units. machine # [ 6.049220] systemd[1]: Reached target Remote File Systems. machine # [ 6.049847] systemd[1]: Reached target Slice Units. machine # [ 6.050457] systemd[1]: Reached target Swaps. machine # [ 6.054932] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 6.057816] systemd[1]: Listening on Process Core Dump Socket. machine # [ 6.059131] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 6.062267] systemd[1]: Listening on Factory Reset Management. machine # [ 6.062789] systemd[1]: Listening on Hostname Service Socket. machine # [ 6.067304] systemd[1]: Starting Journal Log Access Socket... machine # [ 6.069918] systemd[1]: Listening on Journal Audit Socket. machine # [ 6.071732] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 6.074064] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 6.074540] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.075193] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 6.084396] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 6.085070] systemd[1]: Listening on udev Varlink Socket. machine # [ 6.087595] systemd[1]: Mounting Huge Pages File System... machine # [ 6.096314] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 6.102099] systemd[1]: Mounting Kernel Debug File System... machine # [ 6.119759] systemd[1]: Mounting Kernel Trace File System... machine # [ 6.126069] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 6.132086] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 6.143821] systemd[1]: Mounting Kernel Configuration File System... machine # [ 6.147540] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 6.156412] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.156979] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 6.190756] systemd[1]: Mounting FUSE Control File System... machine # [ 6.191174] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.221679] systemd[1]: Starting Journal Service... machine # [ 6.239057] systemd[1]: Starting Load Kernel Modules... machine # [ 6.269880] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 6.283442] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 6.283811] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.298628] systemd-journald[268]: Collecting audit messages is enabled. machine # [ 6.293732] systemd[1]: Queued start job for default target Multi-User System. machine # [ 6.295254] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 6.312721] systemd[1]: Starting Coldplug All udev Devices... machine # [ 6.315454] systemd[1]: Started Journal Service. machine # [ 6.326576] systemd-modules-load[269]: Module 'atkbd' is built in machine # [ 6.334369] systemd-modules-load[269]: Module 'loop' is built in machine # [ 6.340193] systemd[1]: Listening on Journal Log Access Socket. machine # [ 6.341219] systemd[1]: Mounted Huge Pages File System. machine # [ 6.342003] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 6.342884] systemd[1]: Mounted Kernel Debug File System. machine # [ 6.343665] systemd[1]: Mounted Kernel Trace File System. machine # [ 6.357240] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 6.358229] systemd[1]: Mounted Kernel Configuration File System. machine # [ 6.359133] systemd[1]: Finished Load Kernel Modules. machine # [ 6.369218] systemd[1]: Mounted FUSE Control File System. machine # [ 6.382576] systemd[1]: Starting Firewall... machine # [ 6.398309] systemd[1]: Starting Apply Kernel Variables... machine # [ 6.402322] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 6.444027] EXT4-fs (vda): re-mounted b4c47f7d-d06d-44d0-869e-9653bb4ea2ea. machine # [ 6.436957] systemd-oomd[271]: No swap; memory pressure usage will be degraded machine # [ 6.449350] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 6.467275] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 6.472432] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 6.488172] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 6.489363] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 6.504185] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 6.505109] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.591015] systemd-journald[268]: Received client request to flush runtime journal. machine # [ 6.652775] systemd[1]: Finished Apply Kernel Variables. machine # [ 6.653680] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 6.654495] systemd[1]: Reached target First Boot Complete. machine # [ 6.655298] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 6.662986] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 6.671757] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 6.760285] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 6.761732] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 6.772926] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 6.914779] systemd-udevd[308]: Using default interface naming scheme 'v261'. machine # [ 7.016254] systemd[1]: Mounting /run/wrappers... machine # [ 7.052393] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 7.090401] systemd[1]: Mounted /run/wrappers. machine # [ 7.091229] systemd[1]: Reached target Local File Systems. machine # [ 7.100176] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 7.103435] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 7.106754] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 7.114657] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 7.120232] systemd[1]: Starting Create System Files and Directories... machine # [ 7.267697] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 7.279541] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 7.293683] systemd[1]: Finished Create System Files and Directories. machine # [ 7.308361] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 7.312916] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 7.432620] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 7.453962] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 7.456685] systemd[1]: Starting Update is Completed... machine # [ 7.513633] systemd[1]: Finished Update is Completed. machine # [ 8.025118] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 8.026997] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 8.066174] systemd[1]: Finished Coldplug All udev Devices. machine # [ 8.067231] systemd[1]: Reached target System Initialization. machine # [ 8.074537] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 8.075660] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 8.080530] systemd[1]: Reached target Timer Units. machine # [ 8.081368] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 8.082321] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 8.083527] systemd[1]: Reached target Socket Units. machine # [ 8.096392] systemd[1]: Reached target Basic System. machine # [ 8.097253] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 8.098311] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 8.107488] systemd[1]: Starting Post-Boot Actions... machine # [ 8.119980] systemd[1]: Started Reset console on configuration changes. machine # [ 8.153721] systemd[1]: Starting resolvconf update... machine # [ 8.226743] systemd[1]: Starting D-Bus System Message Bus... machine # [ 8.247271] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 8.258875] nsncd[433]: Oct 03 03:26:04.826 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 8.288943] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 8.290051] systemd[1]: Reached target User and Group Name Lookups. machine # [ 8.290975] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 8.345576] systemd[1]: Starting User Login Management... machine # [ 8.353295] systemd[1]: Finished Post-Boot Actions. machine # [ 8.367026] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 8.425742] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 8.495804] dbus-broker-launch[439]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 8.504788] dbus-broker-launch[439]: NSS returned no entry for 'systemd-timesync' machine # [ 8.505894] dbus-broker-launch[439]: Invalid user-name in /nix/store/70ml5x6zqqm9y1j08hmvlag83cmbxsa6-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 8.560508] systemd[1]: Started D-Bus System Message Bus. machine # [ 8.605119] systemd-logind[456]: New seat seat0. machine # [ 8.616252] systemd[1]: Started User Login Management. machine # [ 8.617491] dbus-broker-launch[439]: Ready machine # [ 8.623389] systemd[1]: Starting linger-users.service... machine # [ 8.674585] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 8.679151] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 8.686146] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 8.687125] systemd[1]: Stopping User and Group Name Lookups... machine # [ 8.688000] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 8.699661] systemd[1]: nscd.service: Deactivated successfully. machine # [ 8.706863] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 8.739656] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 8.808332] systemd[1]: Created slice Slice /user/1001. machine # [ 8.820458] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 8.877654] nsncd[525]: Oct 03 03:26:05.451 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 8.894219] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 8.895254] systemd[1]: Finished resolvconf update. machine # [ 8.895987] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 8.908222] systemd[1]: Finished linger-users.service. machine # [ 8.926909] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 8.939616] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 8.945430] systemd[1]: Reached target User and Group Name Lookups. machine # [ 8.952645] systemd[1]: Starting DHCP Client... machine # [ 9.017915] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 9.035402] systemd[1]: Started backdoor.service. machine # [ 9.056175] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 9.119191] systemd[1]: Starting User Manager for UID 1001... machine # [ 9.151128] systemd[1]: Finished Firewall. machine # [ 9.163922] systemd[1]: Reached target Preparation for Network. machine # [ 9.193348] systemd[1]: Starting Extra networking commands.... machine # [ 9.232105] (udev-worker)[407]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 9.270355] (udev-worker)[407]: Network interface NamePolicy= disabled on kernel command line. machine # [ 9.309209] (systemd)[572]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 9.348436] systemd-logind[456]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 9.421306] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # connecting to host... machine # [ 9.903600] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 9.933335] systemd[1]: Starting Address configuration of eth1... machine # [ 9.945126] systemd-logind[456]: Watching system buttons on /dev/input/event0 (gpio-keys) machine: Guest shell says: b'Spawning backdoor root shell...\n' machine # [ 9.971588] mousedev: PS/2 mouse device common for all mice machine: connected to guest root shell machine # [ 9.961022] systemd[572]: Queued start job for default target Main User Target. machine: (connecting took 10.23 seconds) machine: (finished: waiting for the VM to finish booting, in 10.63 seconds) machine # [ 9.981406] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 9.995437] systemd[572]: Created slice User Application Slice. machine # [ 10.004921] systemd[572]: Started Daily Cleanup of User's Temporary Directories. machine # [ 10.006053] systemd[572]: Reached target Paths. machine # [ 10.006756] systemd[572]: Reached target Timers. machine # [ 10.007440] systemd[572]: Starting D-Bus User Message Bus Socket... machine # [ 10.029111] systemd[572]: Starting Create User Files and Directories... machine # [ 10.030146] systemd[572]: Finished Create User Files and Directories. machine # [ 10.031062] systemd[572]: Listening on D-Bus User Message Bus Socket. machine # [ 10.031973] systemd[572]: Reached target Sockets. machine # [ 10.059036] systemd[572]: Reached target Basic System. machine # [ 10.059901] systemd[1]: Started User Manager for UID 1001. machine # [ 10.069556] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 10.070763] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 10.071749] systemd[572]: Reached target Main User Target. machine # [ 10.079716] systemd[572]: Startup finished in 553ms. machine # [ 10.131098] dhcpcd[574]: dhcpcd-10.3.2 starting machine # [ 10.158938] dhcpcd[614]: dev: loaded udev machine # [ 10.213441] 8021q: 802.1Q VLAN Support v1.8 machine # [ 10.213852] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 10.206175] network-addresses-eth1-start[591]: adding address 192.168.1.1/24... done machine # [ 10.285062] network-addresses-eth1-start[591]: adding address 2001:db8:1::1/64... done machine # [ 10.327081] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 10.370328] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 10.370878] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 10.374814] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 10.375164] cfg80211: failed to load regulatory.db machine # [ 10.397692] systemd[1]: Finished Address configuration of eth1. machine # [ 10.480500] systemd-logind[456]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 10.531771] dhcpcd[679]: /nix/store/92w4pf1lqszlcwfq9ma2y2vaad5dssks-openresolv-3.17.4/sbin/.resolvconf-wrapped: line 1250: kill: (596) - Operation not permitted machine # [ 10.541849] dhcpcd[679]: .resolvconf-wrapped: clearing stale lock pid 596 machine # [ 10.558141] systemd[1]: Finished Extra networking commands.. machine # [ 10.559134] systemd[1]: Reached target Network. machine # [ 10.580540] systemd[1]: Starting Permit User Sessions... machine # [ 10.757856] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 10.753169] dhcpcd[614]: eth0: waiting for carrier machine # [ 10.754051] dhcpcd[614]: eth0: carrier acquired machine # [ 10.842325] systemd[1]: Finished Permit User Sessions. machine # [ 10.843254] dhcpcd[614]: DUID 00:01:00:01:32:53:32:4f:52:54:00:12:34:56 machine # [ 10.869562] dhcpcd[614]: eth0: IAID 00:12:34:56 machine # [ 10.870330] systemd[1]: Started Getty on tty1. machine # [ 10.871001] dhcpcd[614]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 10.871916] systemd[1]: Reached target Login Prompts. machine # [ 11.495618] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3 machine # [ 11.937549] systemd[1]: Starting Virtual Console Setup... machine # [ 12.010498] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 12.037565] systemd-logind[456]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 12.038949] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 12.039998] systemd[1]: Stopped Virtual Console Setup. machine # [ 12.049173] systemd[1]: Starting Virtual Console Setup... machine # [ 12.158892] dhcpcd[614]: eth0: soliciting a DHCP lease machine # [ 12.160801] dhcpcd[614]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 12.168230] dhcpcd[614]: eth0: probing address 10.0.2.15/24 machine # [ 12.175002] systemd-vconsole-setup[711]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 12.179824] systemd[1]: Finished Virtual Console Setup. machine # [ 12.645572] dhcpcd[614]: eth0: soliciting an IPv6 router machine # [ 12.647839] dhcpcd[614]: eth0: Router Advertisement from fe80::2 machine # [ 12.649561] dhcpcd[614]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 12.651024] dhcpcd[614]: eth0: adding route to fec0::/64 machine # [ 12.652226] dhcpcd[614]: eth0: adding default route via fe80::2 machine # [ 17.148812] dhcpcd[614]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 17.151338] dhcpcd[614]: eth0: adding route to 10.0.2.0/24 machine # [ 17.155502] dhcpcd[614]: eth0: adding default route via 10.0.2.2 machine # [ 17.264277] systemd[1]: Started DHCP Client. machine # [ 17.266763] systemd[1]: Reached target Multi-User System. machine # [ 17.267712] systemd[1]: Startup finished in 994ms (kernel) + 4.264s (initrd) + 12.007s (userspace) = 17.266s. machine: (finished: waiting for unit multi-user.target, in 18.10 seconds) machine: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 17.657743] nixos[820]: switching to system configuration /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test machine # activating the configuration... machine # [ 17.661835] systemd[1]: Stopped target Remote File Systems. machine # [ 17.662705] systemd[1]: Stopped target Local File Systems. machine # setting up /etc... machine # [ 17.951710] systemd[1]: Reload requested from client PID 820 ('.switch-to-conf') (unit backdoor.service)... machine # [ 17.954112] systemd[1]: Reloading... machine # [ 18.263255] systemd[1]: Reloading finished in 307 ms. machine # reloading user units for usertest... machine # [ 18.314467] systemd[572]: Created slice User Core Session Slice. machine # [ 18.317866] systemd[572]: Starting D-Bus User Message Bus... machine # [ 18.346785] dbus-broker-launch[890]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/70ml5x6zqqm9y1j08hmvlag83cmbxsa6-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 18.350126] dbus-broker-launch[890]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/70ml5x6zqqm9y1j08hmvlag83cmbxsa6-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 18.353078] dbus-broker-launch[890]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/70ml5x6zqqm9y1j08hmvlag83cmbxsa6-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 18.355943] dbus-broker-launch[890]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/70ml5x6zqqm9y1j08hmvlag83cmbxsa6-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 18.360637] dbus-broker-launch[890]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 18.362405] dbus-broker-launch[890]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 18.365341] systemd[572]: Started D-Bus User Message Bus. machine # [ 18.367954] dbus-broker-launch[890]: Ready machine # [ 18.410879] systemd[572]: Reexecution requested from client PID 889 ('switch-to-confi')... machine # [ 18.413448] systemd[572]: Reexecuting. machine # [ 18.475301] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 18.585306] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 18.592124] systemd[572]: Reload requested from client PID 889 ('switch-to-confi')... machine # [ 18.595956] systemd[572]: Reloading... machine # [ 18.706063] systemd[572]: Reloading finished in 109 ms. machine # [ 18.720173] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 18.730100] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 18.732073] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 18.734656] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 18.768877] systemd[572]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 18.780379] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 18.864530] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 18.869639] systemd[1]: Reached target Reactivate sysinit units. machine # [ 18.874161] systemd[1]: Reached target Local File Systems. machine # [ 18.877599] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 18.884266] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 18.885332] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 18.886582] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 18.900257] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 18.902108] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.903389] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.905200] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.906498] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 18.907765] systemd[1]: Reached target Remote File Systems. machine # [ 19.065154] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 19.070320] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 19.072813] systemd[1]: Starting linger-users.service... machine # [ 19.114513] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 19.117765] systemd[1]: Finished linger-users.service. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 19.374889] nixos[820]: finished switching to system configuration /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/bin/switch-to-configuration test, in 1.95 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.03 seconds) machine: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/wh5qqqbp3b23ml7159n8jrhpqgjhm6dy-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/wh5qqqbp3b23ml7159n8jrhpqgjhm6dy-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 19.633531] nixos[967]: switching to system configuration /nix/store/wh5qqqbp3b23ml7159n8jrhpqgjhm6dy-nixos-system-other-test machine # [ 19.636189] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # [ 19.639068] systemd[1]: Stopped target Local File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 19.906271] systemd[1]: Reload requested from client PID 967 ('.switch-to-conf') (unit backdoor.service)... machine # [ 19.908253] systemd[1]: Reloading... machine # [ 20.234223] systemd[1]: Reloading finished in 324 ms. machine # reloading user units for usertest... machine # [ 20.344658] systemd[572]: Reexecution requested from client PID 1037 ('switch-to-confi')... machine # [ 20.348910] systemd[572]: Reexecuting. machine # [ 20.407910] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.527074] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.534130] systemd[572]: Reload requested from client PID 1037 ('switch-to-confi')... machine # [ 20.535466] systemd[572]: Reloading... machine # [ 20.648472] systemd[572]: Reloading finished in 111 ms. machine # [ 20.664197] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 20.675270] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 20.677780] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 20.679935] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 20.712132] systemd[572]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 20.716636] systemd[1]: Stopped target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service machine # [ 20.721400] systemd[1]: Stopping Reactivate sysinit units... machine # [ 20.722279] systemd[1]: Reached target Reactivate sysinit units. machine # [ 20.723133] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 20.725423] dbus-broker-launch[439]: Caught SIGHUP, trigger reload. machine # [ 20.730310] dbus-broker-launch[439]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 20.732599] dbus-broker-launch[439]: NSS returned no entry for 'systemd-timesync' machine # [ 20.733665] dbus-broker-launch[439]: Invalid user-name in /nix/store/5qzk76cs2kmi40f4hd7bis4dyzgn88hd-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 20.749043] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 20.754816] systemd[1]: Stopping Address configuration of eth1... machine # [ 20.786533] network-addresses-eth1-pre-stop[1051]: deleting address 192.168.1.1/24... done machine # [ 20.793195] network-addresses-eth1-pre-stop[1051]: deleting address 2001:db8:1::1/64... done machine # [ 20.799953] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 20.804606] systemd[1]: Stopped Address configuration of eth1. machine # [ 20.806622] systemd[1]: Starting Address configuration of eth1... machine # [ 20.848936] network-addresses-eth1-start[1056]: adding address 192.168.1.2/24... done machine # [ 20.855572] network-addresses-eth1-start[1056]: adding address 2001:db8:1::2/64... done machine # [ 20.864617] systemd[1]: Finished Address configuration of eth1. machine # [ 20.868263] systemd[1]: Reached target Local File Systems. machine # [ 20.871154] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.876798] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 20.878147] systemd[1]: Reached target Remote File Systems. machine # [ 20.881035] systemd[1]: Starting linger-users.service... machine # [ 20.893962] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 20.899801] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 20.904136] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 20.905474] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 20.907904] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 20.916426] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.924236] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.944639] linger-users-start[1070]: id: ‘usertest’: no such user machine # [ 20.947298] linger-users-start[1067]: Removing linger for missing user usertest machine # [ 20.956458] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 20.959709] systemd[1]: Finished linger-users.service. machine # [ 21.120679] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 21.123866] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 21.379732] nixos[967]: finished switching to system configuration /nix/store/wh5qqqbp3b23ml7159n8jrhpqgjhm6dy-nixos-system-other-test machine: (finished: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/wh5qqqbp3b23ml7159n8jrhpqgjhm6dy-nixos-system-other-test/bin/switch-to-configuration test, in 1.98 seconds) subtest: services machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 21.597545] nixos[1134]: switching to system configuration /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test machine # [ 21.600079] systemd[1]: Stopped target Local File Systems. machine # [ 21.602853] systemd[1]: Stopped target Remote File Systems. machine # [ 21.870260] systemd[1]: Reload requested from client PID 1134 ('.switch-to-conf') (unit backdoor.service)... machine # [ 21.872304] systemd[1]: Reloading... machine # [ 22.175515] systemd[1]: Reloading finished in 301 ms. machine # [ 22.260440] systemd[572]: Reexecution requested from client PID 1202 ('switch-to-confi')... machine # [ 22.261921] systemd[572]: Reexecuting. machine # [ 22.319799] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.433776] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.440521] systemd[572]: Reload requested from client PID 1202 ('switch-to-confi')... machine # [ 22.442678] systemd[572]: Reloading... machine # [ 22.552590] systemd[572]: Reloading finished in 108 ms. machine # [ 22.568174] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.579324] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 22.581803] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 22.583945] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 22.615525] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 22.619371] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 22.623435] systemd[1]: Stopping Reactivate sysinit units... machine # [ 22.625608] systemd[1]: Reached target Reactivate sysinit units. machine # [ 22.627138] dbus-broker-launch[439]: Caught SIGHUP, trigger reload. machine # [ 22.628983] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 22.631710] dbus-broker-launch[439]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 22.633900] dbus-broker-launch[439]: NSS returned no entry for 'systemd-timesync' machine # [ 22.634954] dbus-broker-launch[439]: Invalid user-name in /nix/store/70ml5x6zqqm9y1j08hmvlag83cmbxsa6-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 22.647747] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 22.653407] systemd[1]: Stopping Address configuration of eth1... machine # [ 22.682177] network-addresses-eth1-pre-stop[1215]: deleting address 192.168.1.2/24... done machine # [ 22.688754] network-addresses-eth1-pre-stop[1215]: deleting address 2001:db8:1::2/64... done machine # [ 22.696170] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 22.698692] systemd[1]: Stopped Address configuration of eth1. machine # [ 22.703713] systemd[1]: Starting Address configuration of eth1... machine # [ 22.751834] network-addresses-eth1-start[1220]: adding address 192.168.1.1/24... done machine # [ 22.759652] network-addresses-eth1-start[1220]: adding address 2001:db8:1::1/64... done machine # [ 22.770965] systemd[1]: Finished Address configuration of eth1. machine # [ 22.776664] systemd[1]: Reached target Remote File Systems. machine # [ 22.782039] systemd[1]: Starting linger-users.service... machine # [ 22.797355] systemd[1]: Reached target Local File Systems. machine # [ 22.798328] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 22.813108] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 22.814175] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 22.815692] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 22.830401] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 22.834886] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.840192] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.845248] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.846593] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 22.865474] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 22.869158] systemd[1]: Finished linger-users.service. machine # [ 23.011338] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 23.014836] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 23.279835] nixos[1134]: finished switching to system configuration /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.91 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 23.519222] nixos[1289]: switching to system configuration /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test machine # [ 23.523327] systemd[1]: Stopped target Local File Systems. machine # [ 23.528389] systemd[1]: Stopped target Remote File Systems. machine # [ 23.867649] systemd[1]: Reload requested from client PID 1289 ('.switch-to-conf') (unit backdoor.service)... machine # [ 23.870138] systemd[1]: Reloading... machine # [ 24.193120] systemd[1]: Reloading finished in 322 ms. machine # [ 24.278772] systemd[572]: Reexecution requested from client PID 1359 ('switch-to-confi')... machine # [ 24.283024] systemd[572]: Reexecuting. machine # [ 24.339483] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.460982] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.468139] systemd[572]: Reload requested from client PID 1359 ('switch-to-confi')... machine # [ 24.469589] systemd[572]: Reloading... machine # [ 24.575525] systemd[572]: Reloading finished in 104 ms. machine # [ 24.592222] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.603406] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 24.606142] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 24.608677] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 24.642480] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 24.647288] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 24.649676] systemd[1]: Stopping Reactivate sysinit units... machine # [ 24.650558] systemd[1]: Reached target Reactivate sysinit units. machine # [ 24.655041] systemd[1]: Reached target Remote File Systems. machine # [ 24.659143] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.665136] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 24.666536] systemd[1]: Reached target Local File Systems. machine # [ 24.667396] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 24.683576] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 24.684752] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 24.685997] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 24.688384] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 24.690003] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.691267] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.871284] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 24.874738] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 24.879124] systemd[1]: Starting linger-users.service... machine # [ 24.924831] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 24.928158] systemd[1]: Finished linger-users.service. machine # [ 25.183873] nixos[1289]: finished switching to system configuration /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.89 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 25.413224] nixos[1430]: switching to system configuration /nix/store/qj6rllzng194h73cd9j0libalvnmpgwf-nixos-system-machine-test machine # [ 25.415906] systemd[1]: Stopped target Local File Systems. machine # [ 25.417889] systemd[1]: Stopped target Remote File Systems. machine # [ 25.703657] systemd[1]: Reload requested from client PID 1430 ('.switch-to-conf') (unit backdoor.service)... machine # [ 25.705884] systemd[1]: Reloading... machine # [ 26.069689] systemd[1]: Reloading finished in 361 ms. machine # [ 26.158766] systemd[572]: Reexecution requested from client PID 1499 ('switch-to-confi')... machine # [ 26.162863] systemd[572]: Reexecuting. machine # [ 26.211117] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.320919] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.327899] systemd[572]: Reload requested from client PID 1499 ('switch-to-confi')... machine # [ 26.331556] systemd[572]: Reloading... machine # [ 26.440934] systemd[572]: Reloading finished in 111 ms. machine # [ 26.456155] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.468038] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 26.469161] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 26.472001] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 26.499773] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 26.504194] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 26.506778] systemd[1]: Stopping Reactivate sysinit units... machine # [ 26.507646] systemd[1]: Reached target Reactivate sysinit units. machine # [ 26.510154] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.511508] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 26.517453] systemd[1]: Reached target Local File Systems. machine # [ 26.521001] systemd[1]: Reached target Remote File Systems. machine # [ 26.526136] systemd[1]: Starting linger-users.service... machine # [ 26.536375] systemd[1]: Starting test.service... machine # [ 26.537207] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 26.552614] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 26.553532] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 26.554768] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 26.566676] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 26.574828] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.581514] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.598137] systemd[1]: Finished test.service. machine # [ 26.630831] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 26.634787] systemd[1]: Finished linger-users.service. machine # [ 26.766794] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 26.769936] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 27.026743] nixos[1430]: finished switching to system configuration /nix/store/qj6rllzng194h73cd9j0libalvnmpgwf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.84 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 27.237594] nixos[1573]: switching to system configuration /nix/store/qj6rllzng194h73cd9j0libalvnmpgwf-nixos-system-machine-test machine # [ 27.240133] systemd[1]: Stopped target Local File Systems. machine # [ 27.242385] systemd[1]: Stopped target Remote File Systems. machine # [ 27.501435] systemd[1]: Reload requested from client PID 1573 ('.switch-to-conf') (unit backdoor.service)... machine # [ 27.503380] systemd[1]: Reloading... machine # [ 27.810915] systemd[1]: Reloading finished in 305 ms. machine # [ 27.899062] systemd[572]: Reexecution requested from client PID 1642 ('switch-to-confi')... machine # [ 27.903070] systemd[572]: Reexecuting. machine # [ 27.963430] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.079903] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.087655] systemd[572]: Reload requested from client PID 1642 ('switch-to-confi')... machine # [ 28.089936] systemd[572]: Reloading... machine # [ 28.195573] systemd[572]: Reloading finished in 104 ms. machine # [ 28.212169] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.224097] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 28.225265] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 28.227966] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 28.260336] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 28.264811] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 28.266878] systemd[1]: Stopping Reactivate sysinit units... machine # [ 28.267765] systemd[1]: Reached target Reactivate sysinit units. machine # [ 28.271020] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.273566] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 28.274892] systemd[1]: Reached target Remote File Systems. machine # [ 28.277839] systemd[1]: Reached target Local File Systems. machine # [ 28.286639] systemd[1]: Starting linger-users.service... machine # [ 28.291450] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 28.295381] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 28.301603] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 28.302987] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 28.310493] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 28.313341] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.314693] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.365405] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 28.368478] systemd[1]: Finished linger-users.service. machine # [ 28.498362] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 28.500701] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 28.758116] nixos[1573]: finished switching to system configuration /nix/store/qj6rllzng194h73cd9j0libalvnmpgwf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.73 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 28.982361] nixos[1713]: switching to system configuration /nix/store/1pdyv92xxxnpkzx2d4i4nfsk1bjj8l6x-nixos-system-machine-test machine # [ 28.985165] systemd[1]: Stopped target Local File Systems. machine # [ 28.987416] systemd[1]: Stopped target Remote File Systems. machine # [ 29.421782] systemd[1]: Reload requested from client PID 1713 ('.switch-to-conf') (unit backdoor.service)... machine # [ 29.423816] systemd[1]: Reloading... machine # [ 29.761652] systemd[1]: Reloading finished in 335 ms. machine # [ 29.936621] systemd[572]: Reexecution requested from client PID 1782 ('switch-to-confi')... machine # [ 29.941480] systemd[572]: Reexecuting. machine # [ 30.004159] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.130068] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.136659] systemd[572]: Reload requested from client PID 1782 ('switch-to-confi')... machine # [ 30.140080] systemd[572]: Reloading... machine # [ 30.307142] systemd[572]: Reloading finished in 167 ms. machine # [ 30.324187] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.334861] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 30.337343] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 30.339584] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 30.372283] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 30.377107] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 30.378162] systemd[1]: Stopping Reactivate sysinit units... machine # [ 30.379000] systemd[1]: Reached target Reactivate sysinit units. machine # [ 30.383521] systemd[1]: Reached target Local File Systems. machine # [ 30.387691] systemd[1]: Reached target Remote File Systems. machine # [ 30.392093] systemd[1]: Starting linger-users.service... machine # [ 30.400579] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.402017] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 30.408627] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 30.413973] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 30.414976] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 30.424708] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 30.427061] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 30.430933] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.433425] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.479834] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 30.497895] systemd[1]: Finished linger-users.service. machine # [ 30.639926] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 30.642219] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 30.899257] nixos[1713]: finished switching to system configuration /nix/store/1pdyv92xxxnpkzx2d4i4nfsk1bjj8l6x-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 2.14 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 31.159864] nixos[1854]: switching to system configuration /nix/store/hg8p5kfzr19hfw60n4kyhnf0z1m5fmxv-nixos-system-machine-test machine # [ 31.163143] systemd[1]: Stopped target Remote File Systems. machine # [ 31.166146] systemd[1]: test.service: Deactivated successfully. machine # [ 31.167156] systemd[1]: Stopped Test unit. machine # [ 31.168822] systemd[1]: Stopped target Local File Systems. machine # [ 31.471980] systemd[1]: Reload requested from client PID 1854 ('.switch-to-conf') (unit backdoor.service)... machine # [ 31.474092] systemd[1]: Reloading... machine # [ 31.814116] systemd[1]: Reloading finished in 338 ms. machine # [ 31.900862] systemd[572]: Reexecution requested from client PID 1923 ('switch-to-confi')... machine # [ 31.905296] systemd[572]: Reexecuting. machine # [ 31.959359] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.071562] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.079525] systemd[572]: Reload requested from client PID 1923 ('switch-to-confi')... machine # [ 32.082671] systemd[572]: Reloading... machine # [ 32.185713] systemd[572]: Reloading finished in 104 ms. machine # [ 32.200195] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.211904] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 32.214437] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 32.216678] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 32.248225] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 32.252612] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 32.253620] systemd[1]: Stopping Reactivate sysinit units... machine # [ 32.257368] systemd[1]: Reached target Reactivate sysinit units. machine # [ 32.258329] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.259621] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 32.265589] systemd[1]: Reached target Local File Systems. machine # [ 32.266483] systemd[1]: Reached target Remote File Systems. machine # [ 32.273406] systemd[1]: Starting test.service... machine # [ 32.278362] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 32.283821] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 32.292243] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 32.293706] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 32.295955] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 32.303364] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.304859] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.338336] systemd[1]: Finished test.service. machine # [ 32.513675] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 32.516134] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 32.522173] systemd[1]: Starting linger-users.service... machine # [ 32.564796] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 32.567399] systemd[1]: Finished linger-users.service. machine # [ 32.823157] nixos[1854]: finished switching to system configuration /nix/store/hg8p5kfzr19hfw60n4kyhnf0z1m5fmxv-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.92 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 33.061450] nixos[1996]: switching to system configuration /nix/store/fw6b4gvv1kcdf7b99yypdjx4vh4z97yx-nixos-system-machine-test machine # [ 33.064072] systemd[1]: Stopped target Remote File Systems. machine # [ 33.066755] systemd[1]: Stopped target Local File Systems. machine # [ 33.361755] systemd[1]: Reload requested from client PID 1996 ('.switch-to-conf') (unit backdoor.service)... machine # [ 33.363774] systemd[1]: Reloading... machine # [ 33.721730] systemd[1]: Reloading finished in 355 ms. machine # [ 33.848677] systemd[572]: Reexecution requested from client PID 2065 ('switch-to-confi')... machine # [ 33.850137] systemd[572]: Reexecuting. machine # [ 33.890986] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.001749] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.008277] systemd[572]: Reload requested from client PID 2065 ('switch-to-confi')... machine # [ 34.010725] systemd[572]: Reloading... machine # [ 34.119114] systemd[572]: Reloading finished in 107 ms. machine # [ 34.132204] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.143237] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 34.145743] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 34.147837] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 34.180941] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 34.185136] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 34.187652] systemd[1]: Stopping Reactivate sysinit units... machine # [ 34.193276] systemd[1]: Reached target Reactivate sysinit units. machine # [ 34.194265] systemd[1]: test.service: Deactivated successfully. machine # [ 34.195114] systemd[1]: Stopped test.service. machine # [ 34.195759] systemd[1]: Stopping test.service... machine # [ 34.197327] systemd[1]: Starting test.service... machine # [ 34.223579] systemd[1]: Finished test.service. machine # [ 34.230219] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.231718] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 34.237403] systemd[1]: Reached target Local File Systems. machine # [ 34.240776] systemd[1]: Reached target Remote File Systems. machine # [ 34.241703] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 34.246343] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 34.247281] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 34.255546] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 34.259474] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 34.265191] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.266539] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.431009] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 34.434062] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 34.438674] systemd[1]: Starting linger-users.service... machine # [ 34.483020] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 34.484936] systemd[1]: Finished linger-users.service. machine # [ 34.741597] nixos[1996]: finished switching to system configuration /nix/store/fw6b4gvv1kcdf7b99yypdjx4vh4z97yx-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.92 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 34.982183] nixos[2139]: switching to system configuration /nix/store/si0196gl0k7bjl3ikp6hfz16hkdrgn99-nixos-system-machine-test machine # [ 34.985344] systemd[1]: Stopped target Local File Systems. machine # [ 34.987742] systemd[1]: Stopped target Remote File Systems. machine # [ 35.284081] systemd[1]: Reload requested from client PID 2139 ('.switch-to-conf') (unit backdoor.service)... machine # [ 35.286205] systemd[1]: Reloading... machine # [ 35.643389] systemd[1]: Reloading finished in 355 ms. machine # [ 35.736522] systemd[572]: Reexecution requested from client PID 2208 ('switch-to-confi')... machine # [ 35.740002] systemd[572]: Reexecuting. machine # [ 35.787365] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.897390] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.903891] systemd[572]: Reload requested from client PID 2208 ('switch-to-confi')... machine # [ 35.907821] systemd[572]: Reloading... machine # [ 36.016807] systemd[572]: Reloading finished in 110 ms. machine # [ 36.032246] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.043534] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 36.046231] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 36.048211] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 36.079714] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 36.084835] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 36.085819] systemd[1]: Stopping Reactivate sysinit units... machine # [ 36.086623] systemd[1]: Reached target Reactivate sysinit units. machine # [ 36.091937] systemd[1]: Reloading test.service... machine # [ 36.119111] systemd[1]: Reloaded test.service. machine # [ 36.123548] systemd[1]: Reached target Local File Systems. machine # [ 36.128728] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.131266] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 36.134997] systemd[1]: Reached target Remote File Systems. machine # [ 36.137298] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 36.142279] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 36.143284] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 36.152971] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 36.155283] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 36.159619] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.161153] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.323346] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 36.328907] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 36.331115] systemd[1]: Starting linger-users.service... machine # [ 36.377857] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 36.380652] systemd[1]: Finished linger-users.service. machine # [ 36.636743] nixos[2139]: finished switching to system configuration /nix/store/si0196gl0k7bjl3ikp6hfz16hkdrgn99-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 1.90 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 36.922629] nixos[2281]: switching to system configuration /nix/store/lq8mx411s1kjmyfx0zca1gs1q0bw9v9y-nixos-system-machine-test machine # [ 36.928176] systemd[1]: Stopped target Local File Systems. machine # [ 36.929133] systemd[1]: Stopped target Remote File Systems. machine # [ 37.216798] systemd[1]: Reload requested from client PID 2281 ('.switch-to-conf') (unit backdoor.service)... machine # [ 37.218794] systemd[1]: Reloading... machine # [ 37.554636] systemd[1]: Reloading finished in 334 ms. machine # [ 37.637617] systemd[572]: Reexecution requested from client PID 2351 ('switch-to-confi')... machine # [ 37.641044] systemd[572]: Reexecuting. machine # [ 37.691019] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.800928] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.807836] systemd[572]: Reload requested from client PID 2351 ('switch-to-confi')... machine # [ 37.811378] systemd[572]: Reloading... machine # [ 37.916710] systemd[572]: Reloading finished in 106 ms. machine # [ 37.928202] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.938259] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 37.940674] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 37.942775] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 37.975500] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 37.979602] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 37.983136] systemd[1]: Stopping Reactivate sysinit units... machine # [ 37.985963] systemd[1]: Reached target Reactivate sysinit units. machine # [ 37.986923] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.988805] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 37.993254] systemd[1]: Reached target Local File Systems. machine # [ 37.995766] systemd[1]: Reached target Remote File Systems. machine # [ 37.999652] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 38.007392] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 38.012241] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 38.013692] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 38.015902] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 38.019766] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.021301] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.187044] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 38.189583] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.194917] systemd[1]: Starting linger-users.service... machine # [ 38.240263] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 38.242931] systemd[1]: Finished linger-users.service. machine # [ 38.498987] nixos[2281]: finished switching to system configuration /nix/store/lq8mx411s1kjmyfx0zca1gs1q0bw9v9y-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.86 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.31 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 39.000096] nixos[2432]: switching to system configuration /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test machine # [ 39.003327] systemd[1]: test.service: Deactivated successfully. machine # [ 39.005817] systemd[1]: Stopped test.service. machine # [ 39.006557] systemd[1]: Stopped target Local File Systems. machine # [ 39.008166] systemd[1]: Stopped target Remote File Systems. machine # [ 39.290379] systemd[1]: Reload requested from client PID 2432 ('.switch-to-conf') (unit backdoor.service)... machine # [ 39.292574] systemd[1]: Reloading... machine # [ 39.609058] systemd[1]: Reloading finished in 315 ms. machine # [ 39.693814] systemd[572]: Reexecution requested from client PID 2501 ('switch-to-confi')... machine # [ 39.698188] systemd[572]: Reexecuting. machine # [ 39.752115] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.866410] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.873563] systemd[572]: Reload requested from client PID 2501 ('switch-to-confi')... machine # [ 39.877601] systemd[572]: Reloading... machine # [ 39.992276] systemd[572]: Reloading finished in 115 ms. machine # [ 40.008204] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.018242] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 40.020816] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 40.022827] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 40.055907] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 40.059946] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 40.062254] systemd[1]: Stopping Reactivate sysinit units... machine # [ 40.063111] systemd[1]: Reached target Reactivate sysinit units. machine # [ 40.067390] systemd[1]: Reached target Remote File Systems. machine # [ 40.071150] systemd[1]: Starting linger-users.service... machine # [ 40.081419] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.082879] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 40.088939] systemd[1]: Reached target Local File Systems. machine # [ 40.089891] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 40.096347] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 40.097316] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 40.098570] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 40.115250] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 40.120824] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.122198] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.165976] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 40.167060] systemd[1]: Finished linger-users.service. machine # [ 40.358768] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 40.362245] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 40.617870] nixos[2432]: finished switching to system configuration /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine: must succeed: /nix/store/xgl0qcnfnadir7gbc4q4glg425ylc80v-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 40.846705] nixos[2573]: switching to system configuration /nix/store/bbkpc0ji3mcd70fms3hmn9rlfrs5j6sx-nixos-system-machine-test machine # [ 40.849477] systemd[1]: Stopped target Remote File Systems. machine # [ 40.851875] systemd[1]: Stopped target Local File Systems. machine # [ 41.149496] systemd[1]: Reload requested from client PID 2573 ('.switch-to-conf') (unit backdoor.service)... machine # [ 41.151486] systemd[1]: Reloading... machine # [ 41.474088] systemd[1]: Reloading finished in 320 ms. machine # [ 41.565353] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 41.569347] systemd[572]: Reexecution requested from client PID 2642 ('switch-to-confi')... machine # [ 41.570720] systemd[572]: Reexecuting. machine # [ 41.618915] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.730063] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.737899] systemd[572]: Reload requested from client PID 2642 ('switch-to-confi')... machine # [ 41.739257] systemd[572]: Reloading... machine # [ 41.845354] systemd[572]: Reloading finished in 104 ms. machine # [ 41.856280] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.867825] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 41.873110] systemd[1]: Stopping Reactivate sysinit units... machine # [ 41.874038] systemd[1]: Reached target Reactivate sysinit units. machine # [ 41.874900] systemd[1]: Reached target Local File Systems. machine # [ 41.875726] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 41.880410] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 41.881357] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 41.882636] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 41.895434] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 41.900974] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.902338] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.903584] systemd[1]: Reached target Remote File Systems. machine # [ 41.909253] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.910689] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 42.065361] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 42.067267] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 42.072237] systemd[1]: Starting linger-users.service... machine # [ 42.080421] systemd[1]: Starting test.service... machine # [ 42.117130] systemd[1]: Finished test.service. machine # [ 42.135860] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 42.138503] systemd[1]: Finished linger-users.service. machine # [ 42.396139] nixos[2573]: finished switching to system configuration /nix/store/bbkpc0ji3mcd70fms3hmn9rlfrs5j6sx-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xgl0qcnfnadir7gbc4q4glg425ylc80v-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.78 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/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 42.666630] nixos[2721]: switching to system configuration /nix/store/ziysk1dymv92py72k68kklf6ppra0hy1-nixos-system-machine-test machine # [ 42.669660] systemd[1]: Stopped target Local File Systems. machine # [ 42.673556] systemd[1]: test.service: Deactivated successfully. machine # [ 42.675211] systemd[1]: Stopped test.service. machine # [ 42.675905] systemd[1]: Stopped target Remote File Systems. machine # [ 42.971955] systemd[1]: Reload requested from client PID 2721 ('.switch-to-conf') (unit backdoor.service)... machine # [ 42.974304] systemd[1]: Reloading... machine # [ 43.313416] systemd[1]: Reloading finished in 337 ms. machine # [ 43.400084] systemd[572]: Reexecution requested from client PID 2790 ('switch-to-confi')... machine # [ 43.404473] systemd[572]: Reexecuting. machine # [ 43.455121] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.614121] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.621322] systemd[572]: Reload requested from client PID 2790 ('switch-to-confi')... machine # [ 43.622687] systemd[572]: Reloading... machine # [ 43.729609] systemd[572]: Reloading finished in 105 ms. machine # [ 43.745879] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.754946] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 43.788917] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 43.792205] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 43.794715] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 43.798607] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 43.809275] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 43.810344] systemd[1]: Stopping Reactivate sysinit units... machine # [ 43.811182] systemd[1]: Reached target Reactivate sysinit units. machine # [ 43.815793] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.823122] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 43.828589] systemd[1]: Reached target Remote File Systems. machine # [ 43.829681] systemd[1]: Reached target Local File Systems. machine # [ 43.839473] systemd[1]: Started test.service. machine # [ 43.854776] systemd[1]: Starting linger-users.service... machine # [ 43.879302] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 43.890369] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 43.891601] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 43.904898] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 43.906351] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 43.921842] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 43.923597] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.938962] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.943205] systemd[1]: test.service: Deactivated successfully. machine # [ 43.977588] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 43.980382] systemd[1]: Finished linger-users.service. machine # [ 44.125871] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 44.128967] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 44.386040] nixos[2721]: finished switching to system configuration /nix/store/ziysk1dymv92py72k68kklf6ppra0hy1-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.93 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 44.626928] nixos[2867]: switching to system configuration /nix/store/n4n9qmx74xbh731443124mh1pdcq164k-nixos-system-machine-test machine # [ 44.629690] systemd[1]: Stopped target Local File Systems. machine # [ 44.632224] systemd[1]: Stopped target Remote File Systems. machine # [ 44.930132] systemd[1]: Reload requested from client PID 2867 ('.switch-to-conf') (unit backdoor.service)... machine # [ 44.932371] systemd[1]: Reloading... machine # [ 45.265379] systemd[1]: Reloading finished in 331 ms. machine # [ 45.351603] systemd[572]: Reexecution requested from client PID 2936 ('switch-to-confi')... machine # [ 45.356559] systemd[572]: Reexecuting. machine # [ 45.407884] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.523983] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.531243] systemd[572]: Reload requested from client PID 2936 ('switch-to-confi')... machine # [ 45.534658] systemd[572]: Reloading... machine # [ 45.642684] systemd[572]: Reloading finished in 109 ms. machine # [ 45.660198] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.670664] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 45.673308] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 45.675624] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 45.709530] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 45.713753] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 45.716879] systemd[1]: Stopping Reactivate sysinit units... machine # [ 45.717828] systemd[1]: Reached target Reactivate sysinit units. machine # [ 45.718733] systemd[1]: Reached target Remote File Systems. machine # [ 45.721772] systemd[1]: Reached target Local File Systems. machine # [ 45.731823] systemd[1]: Starting escaped\x2ddash.service... machine # [ 45.740213] systemd[1]: Starting linger-users.service... machine # [ 45.741234] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 45.762144] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 45.763172] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 45.766958] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 45.769534] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 45.771241] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.777440] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.778761] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.790009] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 45.810717] systemd[1]: Finished escaped\x2ddash.service. machine # [ 45.846436] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 45.849120] systemd[1]: Finished linger-users.service. machine # [ 45.988208] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 45.990997] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 46.248168] nixos[2867]: finished switching to system configuration /nix/store/n4n9qmx74xbh731443124mh1pdcq164k-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 1.86 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 46.474838] nixos[3009]: switching to system configuration /nix/store/rg34lpk7si9vqpiv7j6x926nnyfacyh6-nixos-system-machine-test machine # [ 46.478727] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 46.479839] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 46.484092] systemd[1]: Stopped target Local File Systems. machine # [ 46.485065] systemd[1]: Stopped target Remote File Systems. machine # [ 46.797783] systemd[1]: Reload requested from client PID 3009 ('.switch-to-conf') (unit backdoor.service)... machine # [ 46.799787] systemd[1]: Reloading... machine # [ 47.127629] systemd[1]: Reloading finished in 325 ms. machine # [ 47.213673] systemd[572]: Reexecution requested from client PID 3078 ('switch-to-confi')... machine # [ 47.218118] systemd[572]: Reexecuting. machine # [ 47.267242] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.375524] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.382808] systemd[572]: Reload requested from client PID 3078 ('switch-to-confi')... machine # [ 47.386517] systemd[572]: Reloading... machine # [ 47.494930] systemd[572]: Reloading finished in 109 ms. machine # [ 47.512203] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.522638] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 47.523773] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 47.528181] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 47.556773] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 47.561044] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 47.563625] systemd[1]: Stopping Reactivate sysinit units... machine # [ 47.567160] systemd[1]: Reached target Reactivate sysinit units. machine # [ 47.568964] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.570322] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 47.578300] systemd[1]: Starting escaped\x2ddash.service... machine # [ 47.588848] systemd[1]: Reached target Remote File Systems. machine # [ 47.591927] systemd[1]: Starting linger-users.service... machine # [ 47.594499] systemd[1]: Reached target Local File Systems. machine # [ 47.603624] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 47.615795] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 47.621285] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 47.622668] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 47.630823] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 47.639459] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.646351] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.655443] systemd[1]: Finished escaped\x2ddash.service. machine # [ 47.696849] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 47.701794] systemd[1]: Finished linger-users.service. machine # [ 47.833833] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 47.837455] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 48.094197] nixos[3009]: finished switching to system configuration /nix/store/rg34lpk7si9vqpiv7j6x926nnyfacyh6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 1.85 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 48.388466] nixos[3151]: switching to system configuration /nix/store/m18fwk9l5skh6p0z96nbkmlf65xxywkg-nixos-system-machine-test machine # [ 48.391816] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 48.395851] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 48.398002] systemd[1]: Stopped target Remote File Systems. machine # [ 48.398834] systemd[1]: Stopped target Local File Systems. machine # [ 48.700722] systemd[1]: Reload requested from client PID 3151 ('.switch-to-conf') (unit backdoor.service)... machine # [ 48.702749] systemd[1]: Reloading... machine # [ 49.056479] systemd[1]: Reloading finished in 352 ms. machine # [ 49.150006] systemd[572]: Reexecution requested from client PID 3220 ('switch-to-confi')... machine # [ 49.151546] systemd[572]: Reexecuting. machine # [ 49.207254] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.321594] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.328492] systemd[572]: Reload requested from client PID 3220 ('switch-to-confi')... machine # [ 49.331067] systemd[572]: Reloading... machine # [ 49.439058] systemd[572]: Reloading finished in 107 ms. machine # [ 49.456187] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.466692] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 49.469723] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 49.473654] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 49.505850] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 49.510801] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 49.513673] systemd[1]: Stopping Reactivate sysinit units... machine # [ 49.514626] systemd[1]: Reached target Reactivate sysinit units. machine # [ 49.518425] systemd[1]: Reached target Local File Systems. machine # [ 49.522506] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 49.527558] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 49.536198] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 49.537683] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 49.539947] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 49.546109] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.547548] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.556891] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.562023] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 49.563965] systemd[1]: Reached target Remote File Systems. machine # [ 49.729132] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 49.734467] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 49.738023] systemd[1]: Starting -.service... machine # [ 49.741277] systemd[1]: Starting linger-users.service... machine # [ 49.779890] systemd[1]: Finished -.service. machine # [ 49.802475] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 49.804459] systemd[1]: Finished linger-users.service. machine # [ 50.061866] nixos[3151]: finished switching to system configuration /nix/store/m18fwk9l5skh6p0z96nbkmlf65xxywkg-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.97 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 50.293540] nixos[3293]: switching to system configuration /nix/store/wn3gdx4wlwgkd2blwrj3z61cimi2p9x6-nixos-system-machine-test machine # [ 50.296524] systemd[1]: Stopped target Remote File Systems. machine # [ 50.298941] systemd[1]: Stopped target Local File Systems. machine # [ 50.602252] systemd[1]: Reload requested from client PID 3293 ('.switch-to-conf') (unit backdoor.service)... machine # [ 50.603879] systemd[1]: Reloading... machine # [ 50.936830] systemd[1]: Reloading finished in 331 ms. machine # [ 51.020668] systemd[572]: Reexecution requested from client PID 3362 ('switch-to-confi')... machine # [ 51.025262] systemd[572]: Reexecuting. machine # [ 51.079308] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.195233] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.202562] systemd[572]: Reload requested from client PID 3362 ('switch-to-confi')... machine # [ 51.206337] systemd[572]: Reloading... machine # [ 51.314462] systemd[572]: Reloading finished in 109 ms. machine # [ 51.332296] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.343024] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 51.345504] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 51.347782] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 51.380585] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 51.384725] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 51.388640] systemd[1]: Stopping Reactivate sysinit units... machine # [ 51.389605] systemd[1]: Reached target Reactivate sysinit units. machine # [ 51.392721] systemd[1]: Reloading -.service... machine # [ 51.417929] systemd[1]: Reloaded -.service. machine # [ 51.423105] systemd[1]: Reached target Remote File Systems. machine # [ 51.428736] systemd[1]: Starting linger-users.service... machine # [ 51.440737] systemd[1]: Reached target Local File Systems. machine # [ 51.446480] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 51.451071] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 51.452006] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 51.464877] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 51.467307] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 51.477003] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.478479] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.479739] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.484931] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 51.533086] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 51.538172] systemd[1]: Finished linger-users.service. machine # [ 51.697192] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 51.701043] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 51.956432] nixos[3293]: finished switching to system configuration /nix/store/wn3gdx4wlwgkd2blwrj3z61cimi2p9x6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.89 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 52.203887] nixos[3435]: switching to system configuration /nix/store/2bz53wnzfkwq4vb6wck0yfvrpfpam4gd-nixos-system-machine-test machine # [ 52.207151] systemd[1]: Stopped target Remote File Systems. machine # [ 52.209206] systemd[1]: -.service: Deactivated successfully. machine # [ 52.212869] systemd[1]: Stopped -.service. machine # [ 52.213614] systemd[1]: Stopped target Local File Systems. machine # [ 52.518000] systemd[1]: Reload requested from client PID 3435 ('.switch-to-conf') (unit backdoor.service)... machine # [ 52.520181] systemd[1]: Reloading... machine # [ 52.907810] systemd[1]: Reloading finished in 385 ms. machine # [ 52.995082] systemd[572]: Reexecution requested from client PID 3504 ('switch-to-confi')... machine # [ 52.998996] systemd[572]: Reexecuting. machine # [ 53.055598] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.172116] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.179591] systemd[572]: Reload requested from client PID 3504 ('switch-to-confi')... machine # [ 53.183038] systemd[572]: Reloading... machine # [ 53.292953] systemd[572]: Reloading finished in 111 ms. machine # [ 53.308273] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.318084] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 53.320513] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 53.322635] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 53.357253] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 53.361483] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 53.364817] systemd[1]: Stopping Reactivate sysinit units... machine # [ 53.365751] systemd[1]: Reached target Reactivate sysinit units. machine # [ 53.366666] systemd[1]: Reached target Remote File Systems. machine # [ 53.371374] systemd[1]: Reached target Local File Systems. machine # [ 53.377290] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 53.378970] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 53.379821] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 53.388717] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 53.391054] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 53.397264] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.398627] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.399862] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.406018] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 53.566304] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 53.571581] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 53.575854] systemd[1]: Starting linger-users.service... machine # [ 53.582318] systemd[1]: Starting required-service.service... machine # [ 53.583206] systemd[1]: Starting test-service.service... machine # [ 53.642881] systemd[1]: Finished required-service.service. machine # [ 53.645466] systemd[1]: Finished test-service.service. machine # [ 53.663664] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 53.666665] systemd[1]: Finished linger-users.service. machine # [ 53.922774] nixos[3435]: finished switching to system configuration /nix/store/2bz53wnzfkwq4vb6wck0yfvrpfpam4gd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.97 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 54.152965] nixos[3579]: switching to system configuration /nix/store/911820is9sm66i0fwwzld0x4hg4vz3dj-nixos-system-machine-test machine # [ 54.155831] systemd[1]: Stopped target Local File Systems. machine # [ 54.160406] systemd[1]: required-service.service: Deactivated successfully. machine # [ 54.162239] systemd[1]: Stopped required-service.service. machine # [ 54.163020] systemd[1]: test-service.service: Deactivated successfully. machine # [ 54.163947] systemd[1]: Stopped test-service.service. machine # [ 54.165805] systemd[1]: Stopped target Remote File Systems. machine # [ 54.463643] systemd[1]: Reload requested from client PID 3579 ('.switch-to-conf') (unit backdoor.service)... machine # [ 54.465876] systemd[1]: Reloading... machine # [ 54.793020] systemd[1]: Reloading finished in 325 ms. machine # [ 54.878887] systemd[572]: Reexecution requested from client PID 3648 ('switch-to-confi')... machine # [ 54.881321] systemd[572]: Reexecuting. machine # [ 54.939780] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.055656] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.062811] systemd[572]: Reload requested from client PID 3648 ('switch-to-confi')... machine # [ 55.066475] systemd[572]: Reloading... machine # [ 55.173831] systemd[572]: Reloading finished in 108 ms. machine # [ 55.188260] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.199224] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 55.200561] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 55.202870] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 55.236642] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 55.240985] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 55.241956] systemd[1]: Stopping Reactivate sysinit units... machine # [ 55.243680] systemd[1]: Reached target Reactivate sysinit units. machine # [ 55.246997] systemd[1]: Reached target Local File Systems. machine # [ 55.254658] systemd[1]: Starting required-service.service... machine # [ 55.263502] systemd[1]: Reached target Remote File Systems. machine # [ 55.268504] systemd[1]: Starting linger-users.service... machine # [ 55.276741] systemd[1]: Starting test-service.service... machine # [ 55.277647] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.278941] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 55.298410] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 55.310108] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 55.311295] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 55.324589] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 55.326948] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 55.345299] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.354353] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.359851] systemd[1]: Finished required-service.service. machine # [ 55.369766] systemd[1]: Finished test-service.service. machine # [ 55.404640] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 55.408817] systemd[1]: Finished linger-users.service. machine # [ 55.545072] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 55.549283] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 55.803394] nixos[3579]: finished switching to system configuration /nix/store/911820is9sm66i0fwwzld0x4hg4vz3dj-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.88 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 56.038975] nixos[3723]: switching to system configuration /nix/store/0hk0zdndvph9k1djln7lw5qchhfvqcvq-nixos-system-machine-test machine # [ 56.041651] systemd[1]: Stopped target Remote File Systems. machine # [ 56.046879] systemd[1]: required-service.service: Deactivated successfully. machine # [ 56.047950] systemd[1]: Stopped required-service.service. machine # [ 56.051700] systemd[1]: test-service.service: Deactivated successfully. machine # [ 56.054625] systemd[1]: Stopped test-service.service. machine # [ 56.055423] systemd[1]: Stopped target Local File Systems. machine # [ 56.348841] systemd[1]: Reload requested from client PID 3723 ('.switch-to-conf') (unit backdoor.service)... machine # [ 56.350806] systemd[1]: Reloading... machine # [ 56.689532] systemd[1]: Reloading finished in 336 ms. machine # [ 56.777907] systemd[572]: Reexecution requested from client PID 3792 ('switch-to-confi')... machine # [ 56.779408] systemd[572]: Reexecuting. machine # [ 56.844810] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.959648] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.967442] systemd[572]: Reload requested from client PID 3792 ('switch-to-confi')... machine # [ 56.971146] systemd[572]: Reloading... machine # [ 57.083821] systemd[572]: Reloading finished in 113 ms. machine # [ 57.100272] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.111823] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 57.114315] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 57.116411] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 57.147939] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 57.152321] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 57.155365] systemd[1]: Stopping Reactivate sysinit units... machine # [ 57.157788] systemd[1]: Reached target Reactivate sysinit units. machine # [ 57.161708] systemd[1]: Reached target Local File Systems. machine # [ 57.164995] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 57.169244] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 57.170167] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 57.171414] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 57.181230] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 57.182941] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.191564] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.193048] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.194348] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 57.195652] systemd[1]: Reached target Remote File Systems. machine # [ 57.355656] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 57.360945] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 57.364563] systemd[1]: Starting linger-users.service... machine # [ 57.368305] systemd[1]: Starting required-service.service... machine # [ 57.379510] systemd[1]: Starting test-service.service... machine # [ 57.430175] systemd[1]: Finished required-service.service. machine # [ 57.434754] systemd[1]: Finished test-service.service. machine # [ 57.451802] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 57.455159] systemd[1]: Finished linger-users.service. machine # [ 57.710311] nixos[3723]: finished switching to system configuration /nix/store/0hk0zdndvph9k1djln7lw5qchhfvqcvq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.91 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 57.936537] nixos[3867]: switching to system configuration /nix/store/77qm3cf09xfzzxgrjq0j8n18ax03syj8-nixos-system-machine-test machine # [ 57.939738] systemd[1]: required-service.service: Deactivated successfully. machine # [ 57.943760] systemd[1]: Stopped required-service.service. machine # [ 57.945507] systemd[1]: test-service.service: Deactivated successfully. machine # [ 57.946482] systemd[1]: Stopped test-service.service. machine # [ 57.947224] systemd[1]: Stopped target Local File Systems. machine # [ 57.948262] systemd[1]: Stopped target Remote File Systems. machine # [ 58.229715] systemd[1]: Reload requested from client PID 3867 ('.switch-to-conf') (unit backdoor.service)... machine # [ 58.231662] systemd[1]: Reloading... machine # [ 58.558158] systemd[1]: Reloading finished in 323 ms. machine # [ 58.644522] systemd[572]: Reexecution requested from client PID 3936 ('switch-to-confi')... machine # [ 58.648500] systemd[572]: Reexecuting. machine # [ 58.707204] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.818762] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.825395] systemd[572]: Reload requested from client PID 3936 ('switch-to-confi')... machine # [ 58.829042] systemd[572]: Reloading... machine # [ 58.934877] systemd[572]: Reloading finished in 106 ms. machine # [ 58.952166] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.965529] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 58.966647] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 58.969502] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 58.999713] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 59.004542] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 59.005535] systemd[1]: Stopping Reactivate sysinit units... machine # [ 59.006387] systemd[1]: Reached target Reactivate sysinit units. machine # [ 59.011628] systemd[1]: Created slice Slice /system/instantiated. machine # [ 59.013329] systemd[1]: Reached target Remote File Systems. machine # [ 59.018374] systemd[1]: Starting instantiated@one.service... machine # [ 59.022258] systemd[1]: Starting instantiated@two.service... machine # [ 59.033665] systemd[1]: Starting linger-users.service... machine # [ 59.040774] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.042259] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 59.043613] systemd[1]: Reached target Local File Systems. machine # [ 59.068608] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 59.081223] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 59.082224] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 59.083564] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 59.111389] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 59.116368] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.117798] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.119066] systemd[1]: Finished instantiated@two.service. machine # [ 59.127554] systemd[1]: Finished instantiated@one.service. machine # [ 59.151582] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 59.153650] systemd[1]: Finished linger-users.service. machine # [ 59.293277] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 59.296837] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 59.551629] nixos[3867]: finished switching to system configuration /nix/store/77qm3cf09xfzzxgrjq0j8n18ax03syj8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.84 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 59.782338] nixos[4011]: switching to system configuration /nix/store/1d6f4whin9038i0dnh0va9wyyqv3i8kb-nixos-system-machine-test machine # [ 59.785208] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 59.789111] systemd[1]: Stopped instantiated@two.service. machine # [ 59.789986] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 59.790961] systemd[1]: Stopped instantiated@one.service. machine # [ 59.791740] systemd[1]: Stopped target Remote File Systems. machine # [ 59.794283] systemd[1]: Stopped target Local File Systems. machine # [ 60.078538] systemd[1]: Reload requested from client PID 4011 ('.switch-to-conf') (unit backdoor.service)... machine # [ 60.080643] systemd[1]: Reloading... machine # [ 60.409495] systemd[1]: Reloading finished in 327 ms. machine # [ 60.494440] systemd[572]: Reexecution requested from client PID 4080 ('switch-to-confi')... machine # [ 60.495859] systemd[572]: Reexecuting. machine # [ 60.546785] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.652243] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.660415] systemd[572]: Reload requested from client PID 4080 ('switch-to-confi')... machine # [ 60.662764] systemd[572]: Reloading... machine # [ 60.769027] systemd[572]: Reloading finished in 105 ms. machine # [ 60.780193] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.789939] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 60.792076] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 60.794282] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 60.823691] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 60.828897] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 60.829891] systemd[1]: Stopping Reactivate sysinit units... machine # [ 60.830720] systemd[1]: Reached target Reactivate sysinit units. machine # [ 60.835933] systemd[1]: Reached target Local File Systems. machine # [ 60.840349] systemd[1]: Starting instantiated@one.service... machine # [ 60.844687] systemd[1]: Reached target Remote File Systems. machine # [ 60.848480] systemd[1]: Starting instantiated@two.service... machine # [ 60.864338] systemd[1]: Starting linger-users.service... machine # [ 60.865306] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 60.876837] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 60.877862] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 60.879143] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 60.890637] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 60.902764] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.914791] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.922813] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.931280] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 60.945929] systemd[1]: Finished instantiated@one.service. machine # [ 60.953474] systemd[1]: Finished instantiated@two.service. machine # [ 60.984816] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 60.987530] systemd[1]: Finished linger-users.service. machine # [ 61.122510] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 61.125766] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 61.381702] nixos[4011]: finished switching to system configuration /nix/store/1d6f4whin9038i0dnh0va9wyyqv3i8kb-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.83 seconds) (finished: subtest: services, in 40.00 seconds) subtest: failing units machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 61.613625] nixos[4155]: switching to system configuration /nix/store/hg8p5kfzr19hfw60n4kyhnf0z1m5fmxv-nixos-system-machine-test machine # [ 61.616501] systemd[1]: Stopped target Local File Systems. machine # [ 61.619161] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 61.621998] systemd[1]: Stopped instantiated@two.service. machine # [ 61.622854] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 61.623833] systemd[1]: Stopped instantiated@one.service. machine # [ 61.625422] systemd[1]: Stopped target Remote File Systems. machine # [ 61.902959] systemd[1]: Reload requested from client PID 4155 ('.switch-to-conf') (unit backdoor.service)... machine # [ 61.905193] systemd[1]: Reloading... machine # [ 62.237594] systemd[1]: Reloading finished in 331 ms. machine # [ 62.322780] systemd[572]: Reexecution requested from client PID 4224 ('switch-to-confi')... machine # [ 62.327056] systemd[572]: Reexecuting. machine # [ 62.383759] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.498719] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.505592] systemd[572]: Reload requested from client PID 4224 ('switch-to-confi')... machine # [ 62.509347] systemd[572]: Reloading... machine # [ 62.628463] systemd[572]: Reloading finished in 120 ms. machine # [ 62.644213] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.657796] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 62.658866] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 62.661117] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 62.691620] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 62.696457] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 62.699880] systemd[1]: Stopping Reactivate sysinit units... machine # [ 62.701410] systemd[1]: Reached target Reactivate sysinit units. machine # [ 62.702294] systemd[1]: Reached target Remote File Systems. machine # [ 62.703849] systemd[1]: Reached target Local File Systems. machine # [ 62.707162] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.713062] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 62.714511] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 62.718951] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 62.719890] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 62.728651] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 62.735951] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 62.738161] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.739506] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.899488] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 62.901709] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 62.908829] systemd[1]: Starting linger-users.service... machine # [ 62.912394] systemd[1]: Starting test.service... machine # [ 62.955112] systemd[1]: Finished test.service. machine # [ 62.975009] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 62.977232] systemd[1]: Finished linger-users.service. machine # [ 63.234732] nixos[4155]: finished switching to system configuration /nix/store/hg8p5kfzr19hfw60n4kyhnf0z1m5fmxv-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.85 seconds) machine: must fail: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 63.477777] nixos[4297]: switching to system configuration /nix/store/30xgqx96faqc5595n1sagh30pbn8jzy2-nixos-system-machine-test machine # [ 63.480550] systemd[1]: Stopped target Remote File Systems. machine # [ 63.483339] systemd[1]: test.service: Deactivated successfully. machine # [ 63.486498] systemd[1]: Stopped test.service. machine # [ 63.487246] systemd[1]: Stopped target Local File Systems. machine # [ 63.802699] systemd[1]: Reload requested from client PID 4297 ('.switch-to-conf') (unit backdoor.service)... machine # [ 63.805015] systemd[1]: Reloading... machine # [ 64.150017] systemd[1]: Reloading finished in 343 ms. machine # [ 64.240362] systemd[572]: Reexecution requested from client PID 4366 ('switch-to-confi')... machine # [ 64.244736] systemd[572]: Reexecuting. machine # [ 64.291186] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.406846] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.414089] systemd[572]: Reload requested from client PID 4366 ('switch-to-confi')... machine # [ 64.416889] systemd[572]: Reloading... machine # [ 64.531623] systemd[572]: Reloading finished in 113 ms. machine # [ 64.548239] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.560121] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 64.561234] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 64.564485] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 64.600758] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 64.604740] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 64.607632] systemd[1]: Stopping Reactivate sysinit units... machine # [ 64.611450] systemd[1]: Reached target Reactivate sysinit units. machine # [ 64.612836] systemd[1]: Reached target Local File Systems. machine # [ 64.614774] systemd[1]: Starting test.service... machine # [ 64.619583] systemd[1]: Reached target Remote File Systems. machine # [ 64.622512] systemd[1]: Starting linger-users.service... machine # [ 64.637252] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.638768] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 64.655162] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 64.663058] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 64.668572] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 64.670061] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 64.681216] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 64.682971] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.704700] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.706074] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 64.707429] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 64.716633] systemd[1]: Failed to start test.service. machine # [ 64.744524] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 64.747307] systemd[1]: Finished linger-users.service. machine # [ 64.891859] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 64.895925] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 65.173054] nixos[4297]: switching to system configuration /nix/store/30xgqx96faqc5595n1sagh30pbn8jzy2-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.94 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 65.405643] nixos[4440]: switching to system configuration /nix/store/q5ssw7j1y7xc7zix8gxpn54lhk9bx62r-nixos-system-machine-test machine # [ 65.408668] systemd[1]: Stopped target Remote File Systems. machine # [ 65.411199] systemd[1]: Stopped target Local File Systems. machine # [ 65.717715] systemd[1]: Reload requested from client PID 4440 ('.switch-to-conf') (unit backdoor.service)... machine # [ 65.719356] systemd[1]: Reloading... machine # [ 66.081292] systemd[1]: Reloading finished in 360 ms. machine # [ 66.176656] systemd[572]: Reexecution requested from client PID 4509 ('switch-to-confi')... machine # [ 66.179684] systemd[572]: Reexecuting. machine # [ 66.231098] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.345310] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.352128] systemd[572]: Reload requested from client PID 4509 ('switch-to-confi')... machine # [ 66.355963] systemd[572]: Reloading... machine # [ 66.470062] systemd[572]: Reloading finished in 115 ms. machine # [ 66.485806] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.494727] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 66.497259] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 66.499590] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 66.535353] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 66.540825] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 66.541932] systemd[1]: Stopping Reactivate sysinit units... machine # [ 66.542845] systemd[1]: Reached target Reactivate sysinit units. machine # [ 66.550036] systemd[1]: Reached target Local File Systems. machine # [ 66.554156] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 66.558106] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 66.559074] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 66.568955] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 66.571420] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 66.580194] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.581633] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.582909] systemd[1]: Reached target Remote File Systems. machine # [ 66.583799] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.585616] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 66.749496] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 66.755227] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 66.759602] systemd[1]: Started autorestart.service. machine # [ 66.762556] systemd[1]: Starting linger-users.service... machine # [ 66.805698] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 66.829529] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 66.832364] systemd[1]: Finished linger-users.service. machine # [ 67.090268] nixos[4440]: finished switching to system configuration /nix/store/q5ssw7j1y7xc7zix8gxpn54lhk9bx62r-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.92 seconds) machine # [ 67.141926] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 67.361450] nixos[4587]: switching to system configuration /nix/store/q5ssw7j1y7xc7zix8gxpn54lhk9bx62r-nixos-system-machine-test machine # [ 67.364435] systemd[1]: Stopped target Remote File Systems. machine # [ 67.366251] systemd[1]: Stopped target Local File Systems. machine # [ 67.668777] systemd[1]: Reload requested from client PID 4587 ('.switch-to-conf') (unit backdoor.service)... machine # [ 67.670418] systemd[1]: Reloading... machine # [ 67.992827] systemd[1]: Reloading finished in 320 ms. machine # [ 68.083667] systemd[572]: Reexecution requested from client PID 4656 ('switch-to-confi')... machine # [ 68.087762] systemd[572]: Reexecuting. machine # [ 68.126917] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.234571] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.242480] systemd[572]: Reload requested from client PID 4656 ('switch-to-confi')... machine # [ 68.243894] systemd[572]: Reloading... machine # [ 68.351378] systemd[572]: Reloading finished in 106 ms. machine # [ 68.368194] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.377889] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 68.380250] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 68.382802] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 68.416830] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 68.420787] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 68.423476] systemd[1]: Stopping Reactivate sysinit units... machine # [ 68.425803] systemd[1]: Reached target Reactivate sysinit units. machine # [ 68.426706] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.427992] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 68.433633] systemd[1]: Reached target Remote File Systems. machine # [ 68.437445] systemd[1]: Reached target Local File Systems. machine # [ 68.441635] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 68.449785] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 68.450815] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 68.458421] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 68.461083] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 68.462709] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.463993] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.622645] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 68.625743] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 68.631333] systemd[1]: Started autorestart.service. machine # [ 68.634291] systemd[1]: Starting linger-users.service... machine # [ 68.676687] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 68.698646] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 68.702138] systemd[1]: Finished linger-users.service. machine # [ 68.957967] nixos[4587]: finished switching to system configuration /nix/store/q5ssw7j1y7xc7zix8gxpn54lhk9bx62r-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine # [ 69.005789] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 69.243620] nixos[4734]: switching to system configuration /nix/store/sacl0bzgx3ir0n1y5h9vkqsw693k5qar-nixos-system-machine-test machine # [ 69.246426] systemd[1]: Stopped target Remote File Systems. machine # [ 69.248534] systemd[1]: Stopped target Local File Systems. machine # [ 69.547398] systemd[1]: Reload requested from client PID 4734 ('.switch-to-conf') (unit backdoor.service)... machine # [ 69.549662] systemd[1]: Reloading... machine # [ 69.899821] systemd[1]: Reloading finished in 348 ms. machine # [ 69.989195] systemd[572]: Reexecution requested from client PID 4803 ('switch-to-confi')... machine # [ 69.993399] systemd[572]: Reexecuting. machine # [ 70.050985] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.163507] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.170707] systemd[572]: Reload requested from client PID 4803 ('switch-to-confi')... machine # [ 70.173235] systemd[572]: Reloading... machine # [ 70.281154] systemd[572]: Reloading finished in 106 ms. machine # [ 70.296251] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.305658] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 70.308411] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 70.310708] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 70.338674] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 70.342501] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 70.345518] systemd[1]: Stopping Reactivate sysinit units... machine # [ 70.346430] systemd[1]: Reached target Reactivate sysinit units. machine # [ 70.352129] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.356637] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 70.358031] systemd[1]: Reached target Remote File Systems. machine # [ 70.362665] systemd[1]: Started autorestart.service. machine # [ 70.366706] systemd[1]: Starting linger-users.service... machine # [ 70.379225] systemd[1]: Reached target Local File Systems. machine # [ 70.382854] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 70.388876] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 70.389768] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 70.391034] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 70.404881] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 70.406598] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.420313] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.431325] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 70.437602] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 70.472592] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 70.475722] systemd[1]: Finished linger-users.service. machine # [ 70.600141] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 70.602891] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.877938] nixos[4734]: switching to system configuration /nix/store/sacl0bzgx3ir0n1y5h9vkqsw693k5qar-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.87 seconds) (finished: subtest: failing units, in 9.49 seconds) subtest: unit file parser machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 71.076734] nixos[4877]: switching to system configuration /nix/store/fw6b4gvv1kcdf7b99yypdjx4vh4z97yx-nixos-system-machine-test machine # [ 71.080600] systemd[1]: Stopped autorestart.service. machine # [ 71.083577] systemd[1]: Stopped target Remote File Systems. machine # [ 71.084851] systemd[1]: Stopped target Local File Systems. machine # [ 71.346755] systemd[1]: Reload requested from client PID 4877 ('.switch-to-conf') (unit backdoor.service)... machine # [ 71.349024] systemd[1]: Reloading... machine # [ 71.661611] systemd[1]: Reloading finished in 311 ms. machine # [ 71.743135] systemd[572]: Reexecution requested from client PID 4946 ('switch-to-confi')... machine # [ 71.747838] systemd[572]: Reexecuting. machine # [ 71.802572] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.908356] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.914727] systemd[572]: Reload requested from client PID 4946 ('switch-to-confi')... machine # [ 71.918478] systemd[572]: Reloading... machine # [ 72.021395] systemd[572]: Reloading finished in 104 ms. machine # [ 72.036177] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.046225] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 72.048571] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 72.050734] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 72.083808] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 72.089148] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 72.090168] systemd[1]: Stopping Reactivate sysinit units... machine # [ 72.091009] systemd[1]: Reached target Reactivate sysinit units. machine # [ 72.096700] systemd[1]: Reached target Local File Systems. machine # [ 72.099499] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 72.108804] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 72.109710] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 72.110989] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 72.123312] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 72.125398] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.126728] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.127940] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.129382] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 72.130687] systemd[1]: Reached target Remote File Systems. machine # [ 72.287223] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 72.292290] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 72.295508] systemd[1]: Starting linger-users.service... machine # [ 72.298347] systemd[1]: Starting test.service... machine # [ 72.342899] systemd[1]: Finished test.service. machine # [ 72.361259] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 72.364543] systemd[1]: Finished linger-users.service. machine # [ 72.620734] nixos[4877]: finished switching to system configuration /nix/store/fw6b4gvv1kcdf7b99yypdjx4vh4z97yx-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.74 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 72.850016] nixos[5019]: switching to system configuration /nix/store/gab79g8w5zyqi9w339v11s5572p6f5mr-nixos-system-machine-test machine # [ 72.852682] systemd[1]: Stopped target Remote File Systems. machine # [ 72.855514] systemd[1]: Stopped target Local File Systems. machine # [ 73.147736] systemd[1]: Reload requested from client PID 5019 ('.switch-to-conf') (unit backdoor.service)... machine # [ 73.149960] systemd[1]: Reloading... machine # [ 73.470548] systemd[1]: Reloading finished in 319 ms. machine # [ 73.562497] systemd[572]: Reexecution requested from client PID 5088 ('switch-to-confi')... machine # [ 73.563930] systemd[572]: Reexecuting. machine # [ 73.626689] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.733936] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.740466] systemd[572]: Reload requested from client PID 5088 ('switch-to-confi')... machine # [ 73.742820] systemd[572]: Reloading... machine # [ 73.847664] systemd[572]: Reloading finished in 103 ms. machine # [ 73.864170] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.873782] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 73.876138] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 73.878371] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 73.907133] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 73.911169] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 73.913232] systemd[1]: Stopping Reactivate sysinit units... machine # [ 73.914096] systemd[1]: Reached target Reactivate sysinit units. machine # [ 73.917947] systemd[1]: test.service: Deactivated successfully. machine # [ 73.918927] systemd[1]: Stopped test.service. machine # [ 73.919612] systemd[1]: Stopping test.service... machine # [ 73.924206] systemd[1]: Starting test.service... machine # [ 73.944785] systemd[1]: Finished test.service. machine # [ 73.950559] systemd[1]: Reached target Remote File Systems. machine # [ 73.955524] systemd[1]: Starting linger-users.service... machine # [ 73.967245] systemd[1]: Reached target Local File Systems. machine # [ 73.971303] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 73.980431] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 73.981407] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 73.982878] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 73.998566] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 74.003135] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.006944] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.011117] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.016260] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 74.046203] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 74.049936] systemd[1]: Finished linger-users.service. machine # [ 74.185924] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 74.189924] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 74.444324] nixos[5019]: finished switching to system configuration /nix/store/gab79g8w5zyqi9w339v11s5572p6f5mr-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.82 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 74.679571] nixos[5161]: switching to system configuration /nix/store/mizps51ka678fn40fqg33gddb1mr85xb-nixos-system-machine-test machine # [ 74.682315] systemd[1]: Stopped target Local File Systems. machine # [ 74.684875] systemd[1]: Stopped target Remote File Systems. machine # [ 75.073060] systemd[1]: Reload requested from client PID 5161 ('.switch-to-conf') (unit backdoor.service)... machine # [ 75.075214] systemd[1]: Reloading... machine # [ 75.405282] systemd[1]: Reloading finished in 327 ms. machine # [ 75.499850] systemd[572]: Reexecution requested from client PID 5229 ('switch-to-confi')... machine # [ 75.502466] systemd[572]: Reexecuting. machine # [ 75.555722] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.677530] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.684571] systemd[572]: Reload requested from client PID 5229 ('switch-to-confi')... machine # [ 75.687205] systemd[572]: Reloading... machine # [ 75.797375] systemd[572]: Reloading finished in 109 ms. machine # [ 75.812200] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.821892] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 75.824081] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 75.826445] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 75.860207] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 75.864461] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 75.865805] systemd[1]: Stopping Reactivate sysinit units... machine # [ 75.866671] systemd[1]: Reached target Reactivate sysinit units. machine # [ 75.871291] systemd[1]: test.service: Deactivated successfully. machine # [ 75.872619] systemd[1]: Stopped test.service. machine # [ 75.873340] systemd[1]: Stopping test.service... machine # [ 75.875529] systemd[1]: Starting test.service... machine # [ 75.901551] systemd[1]: Finished test.service. machine # [ 75.911410] systemd[1]: Reached target Local File Systems. machine # [ 75.915307] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 75.919370] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 75.924450] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 75.925759] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 75.934710] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 75.936985] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.938305] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.939531] systemd[1]: Reached target Remote File Systems. machine # [ 75.940518] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.941836] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 76.100506] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 76.104413] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 76.107832] systemd[1]: Starting linger-users.service... machine # [ 76.150492] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 76.154036] systemd[1]: Finished linger-users.service. machine # [ 76.408656] nixos[5161]: finished switching to system configuration /nix/store/mizps51ka678fn40fqg33gddb1mr85xb-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.96 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 76.642739] nixos[5303]: switching to system configuration /nix/store/fw6b4gvv1kcdf7b99yypdjx4vh4z97yx-nixos-system-machine-test machine # [ 76.645951] systemd[1]: Stopped target Local File Systems. machine # [ 76.648599] systemd[1]: Stopped target Remote File Systems. machine # [ 76.940456] systemd[1]: Reload requested from client PID 5303 ('.switch-to-conf') (unit backdoor.service)... machine # [ 76.942499] systemd[1]: Reloading... machine # [ 77.273291] systemd[1]: Reloading finished in 329 ms. machine # [ 77.357478] systemd[572]: Reexecution requested from client PID 5372 ('switch-to-confi')... machine # [ 77.361720] systemd[572]: Reexecuting. machine # [ 77.419947] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.539118] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.546495] systemd[572]: Reload requested from client PID 5372 ('switch-to-confi')... machine # [ 77.550143] systemd[572]: Reloading... machine # [ 77.659252] systemd[572]: Reloading finished in 110 ms. machine # [ 77.672186] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.682887] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 77.685487] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 77.687812] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 77.719988] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 77.724883] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 77.725911] systemd[1]: Stopping Reactivate sysinit units... machine # [ 77.726769] systemd[1]: Reached target Reactivate sysinit units. machine # [ 77.729414] systemd[1]: test.service: Deactivated successfully. machine # [ 77.732448] systemd[1]: Stopped test.service. machine # [ 77.733242] systemd[1]: Stopping test.service... machine # [ 77.735444] systemd[1]: Starting test.service... machine # [ 77.762016] systemd[1]: Finished test.service. machine # [ 77.767159] systemd[1]: Reached target Remote File Systems. machine # [ 77.772361] systemd[1]: Starting linger-users.service... machine # [ 77.781490] systemd[1]: Reached target Local File Systems. machine # [ 77.786265] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.787816] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 77.793470] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 77.804557] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 77.808708] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 77.810321] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 77.820496] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 77.822256] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.823610] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.872345] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 77.874226] systemd[1]: Finished linger-users.service. machine # [ 78.023848] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 78.026302] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 78.283451] nixos[5303]: finished switching to system configuration /nix/store/fw6b4gvv1kcdf7b99yypdjx4vh4z97yx-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.87 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 78.522558] nixos[5445]: switching to system configuration /nix/store/0ipmqmd30jv3c9cazr0qy4gshxizgckd-nixos-system-machine-test machine # [ 78.525192] systemd[1]: Stopped target Local File Systems. machine # [ 78.527718] systemd[1]: Stopped target Remote File Systems. machine # [ 78.830868] systemd[1]: Reload requested from client PID 5445 ('.switch-to-conf') (unit backdoor.service)... machine # [ 78.833036] systemd[1]: Reloading... machine # [ 79.191677] systemd[1]: Reloading finished in 357 ms. machine # [ 79.287300] systemd[572]: Reexecution requested from client PID 5514 ('switch-to-confi')... machine # [ 79.290464] systemd[572]: Reexecuting. machine # [ 79.351649] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.474708] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.481575] systemd[572]: Reload requested from client PID 5514 ('switch-to-confi')... machine # [ 79.485823] systemd[572]: Reloading... machine # [ 79.598221] systemd[572]: Reloading finished in 113 ms. machine # [ 79.612215] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.625181] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 79.626282] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 79.629412] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 79.660833] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 79.666275] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 79.669338] systemd[1]: Stopping Reactivate sysinit units... machine # [ 79.670231] systemd[1]: Reached target Reactivate sysinit units. machine # [ 79.671078] systemd[1]: Reached target Local File Systems. machine # [ 79.673289] systemd[1]: Reached target Remote File Systems. machine # [ 79.675756] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.677910] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 79.689336] systemd[1]: Starting linger-users.service... machine # [ 79.695601] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 79.705322] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 79.706253] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 79.707511] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 79.716757] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 79.718447] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.719757] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.787904] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 79.791887] systemd[1]: Finished linger-users.service. machine # [ 79.922023] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 79.925071] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 80.181747] nixos[5445]: finished switching to system configuration /nix/store/0ipmqmd30jv3c9cazr0qy4gshxizgckd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.90 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 80.422153] nixos[5585]: switching to system configuration /nix/store/8sfwca02qh4rkmcp9sy9bamq04x74j7q-nixos-system-machine-test machine # [ 80.424873] systemd[1]: Stopped target Local File Systems. machine # [ 80.427267] systemd[1]: Stopped target Remote File Systems. machine # [ 80.751720] systemd[1]: Reload requested from client PID 5585 ('.switch-to-conf') (unit backdoor.service)... machine # [ 80.754044] systemd[1]: Reloading... machine # [ 81.118657] systemd[1]: Reloading finished in 362 ms. machine # [ 81.205716] systemd[572]: Reexecution requested from client PID 5654 ('switch-to-confi')... machine # [ 81.209987] systemd[572]: Reexecuting. machine # [ 81.271534] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.390182] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.397403] systemd[572]: Reload requested from client PID 5654 ('switch-to-confi')... machine # [ 81.401305] systemd[572]: Reloading... machine # [ 81.513016] systemd[572]: Reloading finished in 112 ms. machine # [ 81.528206] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.538453] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 81.541185] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 81.543393] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 81.579279] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 81.583595] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 81.585802] systemd[1]: Stopping Reactivate sysinit units... machine # [ 81.586636] systemd[1]: Reached target Reactivate sysinit units. machine # [ 81.590544] systemd[1]: test.service: Deactivated successfully. machine # [ 81.591513] systemd[1]: Stopped test.service. machine # [ 81.596257] systemd[1]: Stopping test.service... machine # [ 81.597041] systemd[1]: Starting test.service... machine # [ 81.621275] systemd[1]: Finished test.service. machine # [ 81.628192] systemd[1]: Reached target Local File Systems. machine # [ 81.631605] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 81.635370] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 81.640608] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 81.641972] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 81.652394] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 81.654126] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.655431] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.659371] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.660984] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 81.662286] systemd[1]: Reached target Remote File Systems. machine # [ 81.818549] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 81.821914] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 81.826295] systemd[1]: Starting linger-users.service... machine # [ 81.872174] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 81.874796] systemd[1]: Finished linger-users.service. machine # [ 82.132135] nixos[5585]: finished switching to system configuration /nix/store/8sfwca02qh4rkmcp9sy9bamq04x74j7q-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.95 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 82.371014] nixos[5727]: switching to system configuration /nix/store/1l2ihihwmw6i5prgr2521w3rk4c4ib3v-nixos-system-machine-test machine # [ 82.374260] systemd[1]: Stopped target Local File Systems. machine # [ 82.376735] systemd[1]: Stopped target Remote File Systems. machine # [ 82.684232] systemd[1]: Reload requested from client PID 5727 ('.switch-to-conf') (unit backdoor.service)... machine # [ 82.686203] systemd[1]: Reloading... machine # [ 83.025749] systemd[1]: Reloading finished in 338 ms. machine # [ 83.116545] systemd[572]: Reexecution requested from client PID 5796 ('switch-to-confi')... machine # [ 83.121133] systemd[572]: Reexecuting. machine # [ 83.179534] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.294672] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.301641] systemd[572]: Reload requested from client PID 5796 ('switch-to-confi')... machine # [ 83.305831] systemd[572]: Reloading... machine # [ 83.412857] systemd[572]: Reloading finished in 108 ms. machine # [ 83.428204] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.440098] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 83.441210] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 83.444458] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 83.476435] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 83.480915] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 83.483061] systemd[1]: Stopping Reactivate sysinit units... machine # [ 83.487282] systemd[1]: Reached target Reactivate sysinit units. machine # [ 83.488420] systemd[1]: test.service: Deactivated successfully. machine # [ 83.489282] systemd[1]: Stopped test.service. machine # [ 83.489938] systemd[1]: Stopping test.service... machine # [ 83.491766] systemd[1]: Starting test.service... machine # [ 83.517675] systemd[1]: Finished test.service. machine # [ 83.522499] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.526957] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 83.532482] systemd[1]: Reached target Remote File Systems. machine # [ 83.533380] systemd[1]: Reached target Local File Systems. machine # [ 83.535016] systemd[1]: Starting linger-users.service... machine # [ 83.547426] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 83.552703] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 83.553617] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 83.554874] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 83.568124] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 83.572707] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.577745] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.627758] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 83.632416] systemd[1]: Finished linger-users.service. machine # [ 83.767304] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 83.770572] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 84.026539] nixos[5727]: finished switching to system configuration /nix/store/1l2ihihwmw6i5prgr2521w3rk4c4ib3v-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.90 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 84.291451] nixos[5869]: switching to system configuration /nix/store/kcd5fsmk9k1pgby1yhz6a6y4xygv5px9-nixos-system-machine-test machine # [ 84.297318] systemd[1]: Stopped target Local File Systems. machine # [ 84.298252] systemd[1]: Stopped target Remote File Systems. machine # [ 84.594963] systemd[1]: Reload requested from client PID 5869 ('.switch-to-conf') (unit backdoor.service)... machine # [ 84.597185] systemd[1]: Reloading... machine # [ 84.930937] systemd[1]: Reloading finished in 332 ms. machine # [ 85.019047] systemd[572]: Reexecution requested from client PID 5938 ('switch-to-confi')... machine # [ 85.022967] systemd[572]: Reexecuting. machine # [ 85.083721] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.202208] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.209004] systemd[572]: Reload requested from client PID 5938 ('switch-to-confi')... machine # [ 85.212082] systemd[572]: Reloading... machine # [ 85.317247] systemd[572]: Reloading finished in 105 ms. machine # [ 85.332178] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.341683] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 85.344040] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 85.346165] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 85.375483] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 85.379627] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 85.384990] systemd[1]: Stopping Reactivate sysinit units... machine # [ 85.385871] systemd[1]: Reached target Reactivate sysinit units. machine # [ 85.386711] systemd[1]: test.service: Deactivated successfully. machine # [ 85.387551] systemd[1]: Stopped test.service. machine # [ 85.389455] systemd[1]: Stopping test.service... machine # [ 85.390158] systemd[1]: Starting test.service... machine # [ 85.412740] systemd[1]: Finished test.service. machine # [ 85.419580] systemd[1]: Reached target Local File Systems. machine # [ 85.424845] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 85.426393] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 85.427288] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 85.436660] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 85.438940] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 85.446521] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.447860] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.450730] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.453421] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 85.455030] systemd[1]: Reached target Remote File Systems. machine # [ 85.607718] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 85.612980] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 85.615066] systemd[1]: Starting linger-users.service... machine # [ 85.657475] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 85.659377] systemd[1]: Finished linger-users.service. machine # [ 85.915663] nixos[5869]: finished switching to system configuration /nix/store/kcd5fsmk9k1pgby1yhz6a6y4xygv5px9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 1.89 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 86.132523] nixos[6011]: switching to system configuration /nix/store/fw6b4gvv1kcdf7b99yypdjx4vh4z97yx-nixos-system-machine-test machine # [ 86.136475] systemd[1]: Stopped target Local File Systems. machine # [ 86.138657] systemd[1]: Stopped target Remote File Systems. machine # [ 86.408124] systemd[1]: Reload requested from client PID 6011 ('.switch-to-conf') (unit backdoor.service)... machine # [ 86.410047] systemd[1]: Reloading... machine # [ 86.717548] systemd[1]: Reloading finished in 304 ms. machine # [ 86.805955] systemd[572]: Reexecution requested from client PID 6080 ('switch-to-confi')... machine # [ 86.809740] systemd[572]: Reexecuting. machine # [ 86.867292] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.982763] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.989453] systemd[572]: Reload requested from client PID 6080 ('switch-to-confi')... machine # [ 86.993271] systemd[572]: Reloading... machine # [ 87.098074] systemd[572]: Reloading finished in 105 ms. machine # [ 87.112198] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.122743] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 87.125302] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 87.127497] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 87.160000] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 87.164315] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 87.166737] systemd[1]: Stopping Reactivate sysinit units... machine # [ 87.167627] systemd[1]: Reached target Reactivate sysinit units. machine # [ 87.172613] systemd[1]: test.service: Deactivated successfully. machine # [ 87.173554] systemd[1]: Stopped test.service. machine # [ 87.174225] systemd[1]: Stopping test.service... machine # [ 87.174905] systemd[1]: Starting test.service... machine # [ 87.201384] systemd[1]: Finished test.service. machine # [ 87.206831] systemd[1]: Reached target Remote File Systems. machine # [ 87.213102] systemd[1]: Starting linger-users.service... machine # [ 87.220407] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.221860] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 87.231613] systemd[1]: Reached target Local File Systems. machine # [ 87.236450] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 87.238042] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 87.238855] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 87.245321] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 87.247631] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 87.256965] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.258489] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.317893] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 87.321310] systemd[1]: Finished linger-users.service. machine # [ 87.464385] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 87.468395] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 87.723210] nixos[6011]: finished switching to system configuration /nix/store/fw6b4gvv1kcdf7b99yypdjx4vh4z97yx-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 87.966897] nixos[6153]: switching to system configuration /nix/store/k8w7ar74cbwwpqsjwrzn0dhqd1x4hzg1-nixos-system-machine-test machine # [ 87.969738] systemd[1]: Stopped target Local File Systems. machine # [ 87.972213] systemd[1]: Stopped target Remote File Systems. machine # [ 88.271705] systemd[1]: Reload requested from client PID 6153 ('.switch-to-conf') (unit backdoor.service)... machine # [ 88.274182] systemd[1]: Reloading... machine # [ 88.643338] systemd[1]: Reloading finished in 368 ms. machine # [ 88.738400] systemd[572]: Reexecution requested from client PID 6222 ('switch-to-confi')... machine # [ 88.743050] systemd[572]: Reexecuting. machine # [ 88.795413] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 88.909598] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 88.916437] systemd[572]: Reload requested from client PID 6222 ('switch-to-confi')... machine # [ 88.920085] systemd[572]: Reloading... machine # [ 89.031365] systemd[572]: Reloading finished in 112 ms. machine # [ 89.048492] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.061035] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 89.064207] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 89.066851] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 89.106907] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 89.112802] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 89.113837] systemd[1]: Stopping Reactivate sysinit units... machine # [ 89.114698] systemd[1]: Reached target Reactivate sysinit units. machine # [ 89.122315] systemd[1]: Reloading test.service... machine # [ 89.151711] systemd[1]: Reloaded test.service. machine # [ 89.159009] systemd[1]: Reached target Local File Systems. machine # [ 89.165271] systemd[1]: Reached target Remote File Systems. machine # [ 89.166217] systemd[1]: Starting linger-users.service... machine # [ 89.174444] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.175977] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 89.185741] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 89.195704] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 89.200712] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 89.202085] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 89.213501] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 89.215326] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.220985] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.267114] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 89.271996] systemd[1]: Finished linger-users.service. machine # [ 89.417372] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 89.421319] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 89.677784] nixos[6153]: finished switching to system configuration /nix/store/k8w7ar74cbwwpqsjwrzn0dhqd1x4hzg1-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.95 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 89.936490] nixos[6295]: switching to system configuration /nix/store/xgf6p8xb1hjg0wxv7dm4g4l00bbwzf9z-nixos-system-machine-test machine # [ 89.939038] systemd[1]: Stopped target Remote File Systems. machine # [ 89.941567] systemd[1]: Stopped target Local File Systems. machine # [ 90.262165] systemd[1]: Reload requested from client PID 6295 ('.switch-to-conf') (unit backdoor.service)... machine # [ 90.264213] systemd[1]: Reloading... machine # [ 90.615672] systemd[1]: Reloading finished in 350 ms. machine # [ 90.708435] systemd[572]: Reexecution requested from client PID 6364 ('switch-to-confi')... machine # [ 90.712482] systemd[572]: Reexecuting. machine # [ 90.781015] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 90.903238] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 90.910327] systemd[572]: Reload requested from client PID 6364 ('switch-to-confi')... machine # [ 90.914152] systemd[572]: Reloading... machine # [ 91.019472] systemd[572]: Reloading finished in 106 ms. machine # [ 91.036214] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.048069] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 91.049160] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 91.051574] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 91.086067] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 91.090254] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 91.094772] systemd[1]: Stopping Reactivate sysinit units... machine # [ 91.095702] systemd[1]: Reached target Reactivate sysinit units. machine # [ 91.097737] systemd[1]: Reloading test.service... machine # [ 91.125477] systemd[1]: Reloaded test.service. machine # [ 91.128763] systemd[1]: Reached target Remote File Systems. machine # [ 91.136190] systemd[1]: Starting linger-users.service... machine # [ 91.144425] systemd[1]: Reached target Local File Systems. machine # [ 91.151505] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 91.159649] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 91.168619] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 91.170012] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 91.178396] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 91.182424] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.183825] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.187064] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.191390] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 91.231047] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 91.235649] systemd[1]: Finished linger-users.service. machine # [ 91.377780] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 91.381047] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 91.637942] nixos[6295]: finished switching to system configuration /nix/store/xgf6p8xb1hjg0wxv7dm4g4l00bbwzf9z-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.96 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 91.883191] nixos[6437]: switching to system configuration /nix/store/1zaby7pj2ig5qm5y1gavm1s7i87aqaw6-nixos-system-machine-test machine # [ 91.886104] systemd[1]: Stopped target Local File Systems. machine # [ 91.888845] systemd[1]: Stopped target Remote File Systems. machine # [ 92.210263] systemd[1]: Reload requested from client PID 6437 ('.switch-to-conf') (unit backdoor.service)... machine # [ 92.213045] systemd[1]: Reloading... machine # [ 92.570545] systemd[1]: Reloading finished in 355 ms. machine # [ 92.656471] systemd[572]: Reexecution requested from client PID 6506 ('switch-to-confi')... machine # [ 92.659507] systemd[572]: Reexecuting. machine # [ 92.715318] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.830704] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.837857] systemd[572]: Reload requested from client PID 6506 ('switch-to-confi')... machine # [ 92.841544] systemd[572]: Reloading... machine # [ 92.956891] systemd[572]: Reloading finished in 115 ms. machine # [ 92.972185] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.983414] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 92.985885] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 92.988064] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 93.020460] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 93.025863] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 93.030981] systemd[1]: Stopping Reactivate sysinit units... machine # [ 93.031944] systemd[1]: Reached target Reactivate sysinit units. machine # [ 93.033032] systemd[1]: test.service: Deactivated successfully. machine # [ 93.033873] systemd[1]: Stopped test.service. machine # [ 93.034536] systemd[1]: Stopping test.service... machine # [ 93.036562] systemd[1]: Starting test.service... machine # [ 93.061732] systemd[1]: Finished test.service. machine # [ 93.068174] systemd[1]: Reached target Remote File Systems. machine # [ 93.071616] systemd[1]: Starting linger-users.service... machine # [ 93.081102] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.082578] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 93.092127] systemd[1]: Reached target Local File Systems. machine # [ 93.093101] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 93.104966] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 93.105961] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 93.107216] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 93.121085] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 93.122817] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.128259] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.167867] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 93.170804] systemd[1]: Finished linger-users.service. machine # [ 93.315195] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 93.318959] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 93.573977] nixos[6437]: finished switching to system configuration /nix/store/1zaby7pj2ig5qm5y1gavm1s7i87aqaw6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.94 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 93.795318] nixos[6579]: switching to system configuration /nix/store/8sfwca02qh4rkmcp9sy9bamq04x74j7q-nixos-system-machine-test machine # [ 93.798490] systemd[1]: Stopped target Remote File Systems. machine # [ 93.801772] systemd[1]: Stopped target Local File Systems. machine # [ 94.089685] systemd[1]: Reload requested from client PID 6579 ('.switch-to-conf') (unit backdoor.service)... machine # [ 94.091694] systemd[1]: Reloading... machine # [ 94.418180] systemd[1]: Reloading finished in 324 ms. machine # [ 94.510299] systemd[572]: Reexecution requested from client PID 6648 ('switch-to-confi')... machine # [ 94.514141] systemd[572]: Reexecuting. machine # [ 94.567442] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.683291] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.690640] systemd[572]: Reload requested from client PID 6648 ('switch-to-confi')... machine # [ 94.694737] systemd[572]: Reloading... machine # [ 94.805171] systemd[572]: Reloading finished in 111 ms. machine # [ 94.820251] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.831534] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 94.834222] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 94.836402] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 94.868881] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 94.873844] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 94.876461] systemd[1]: Stopping Reactivate sysinit units... machine # [ 94.877358] systemd[1]: Reached target Reactivate sysinit units. machine # [ 94.879865] systemd[1]: Reached target Local File Systems. machine # [ 94.885598] systemd[1]: Reached target Remote File Systems. machine # [ 94.890335] systemd[1]: Starting linger-users.service... machine # [ 94.901336] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 94.903022] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 94.903971] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 94.917765] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 94.924414] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 94.926149] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.933718] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.939229] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.945471] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 94.988869] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 94.994072] systemd[1]: Finished linger-users.service. machine # [ 95.135285] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 95.137739] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 95.395191] nixos[6579]: finished switching to system configuration /nix/store/8sfwca02qh4rkmcp9sy9bamq04x74j7q-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.82 seconds) (finished: subtest: unit file parser, in 24.52 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 95.623007] nixos[6719]: switching to system configuration /nix/store/lq8mx411s1kjmyfx0zca1gs1q0bw9v9y-nixos-system-machine-test machine # [ 95.625754] systemd[1]: Stopped target Remote File Systems. machine # [ 95.628358] systemd[1]: Stopped target Local File Systems. machine # [ 95.917786] systemd[1]: Reload requested from client PID 6719 ('.switch-to-conf') (unit backdoor.service)... machine # [ 95.919767] systemd[1]: Reloading... machine # [ 96.239651] systemd[1]: Reloading finished in 318 ms. machine # [ 96.325889] systemd[572]: Reexecution requested from client PID 6788 ('switch-to-confi')... machine # [ 96.330263] systemd[572]: Reexecuting. machine # [ 96.379302] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.499746] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.507017] systemd[572]: Reload requested from client PID 6788 ('switch-to-confi')... machine # [ 96.509799] systemd[572]: Reloading... machine # [ 96.629634] systemd[572]: Reloading finished in 118 ms. machine # [ 96.645815] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.655028] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 96.657543] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 96.660064] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 96.693076] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 96.697339] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 96.699358] systemd[1]: Stopping Reactivate sysinit units... machine # [ 96.703888] systemd[1]: Reached target Reactivate sysinit units. machine # [ 96.705359] systemd[1]: Reached target Remote File Systems. machine # [ 96.708939] systemd[1]: Starting linger-users.service... machine # [ 96.713335] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.714754] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 96.720432] systemd[1]: Reached target Local File Systems. machine # [ 96.724608] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 96.737139] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 96.738069] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 96.739373] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 96.760417] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 96.762165] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.763459] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.807052] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 96.812232] systemd[1]: Finished linger-users.service. machine # [ 96.956536] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 96.960315] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 97.215454] nixos[6719]: finished switching to system configuration /nix/store/lq8mx411s1kjmyfx0zca1gs1q0bw9v9y-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.82 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 97.447330] nixos[6859]: switching to system configuration /nix/store/w4xd54nyz1jwb6a4r7xdi5w79wk4ynsy-nixos-system-machine-test machine # [ 97.450200] systemd[1]: Stopped target Local File Systems. machine # [ 97.453105] systemd[1]: test.service: Deactivated successfully. machine # [ 97.454078] systemd[1]: Stopped test.service. machine # [ 97.455431] systemd[1]: Stopped target Remote File Systems. machine # [ 97.769562] systemd[1]: Reload requested from client PID 6859 ('.switch-to-conf') (unit backdoor.service)... machine # [ 97.771594] systemd[1]: Reloading... machine # [ 98.117735] systemd[1]: Reloading finished in 344 ms. machine # [ 98.207628] systemd[572]: Reexecution requested from client PID 6930 ('switch-to-confi')... machine # [ 98.211475] systemd[572]: Reexecuting. machine # [ 98.276395] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.393813] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.401340] systemd[572]: Reload requested from client PID 6930 ('switch-to-confi')... machine # [ 98.402688] systemd[572]: Reloading... machine # [ 98.510977] systemd[572]: Reloading finished in 107 ms. machine # [ 98.528194] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.538708] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 98.541154] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 98.543342] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 98.576414] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 98.580615] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 98.582510] systemd[1]: Stopping Reactivate sysinit units... machine # [ 98.583399] systemd[1]: Reached target Reactivate sysinit units. machine # [ 98.590134] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 98.596101] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 98.597292] systemd[1]: Reached target Remote File Systems. machine # [ 98.605329] systemd[1]: Starting simple-restart-service.service... machine # [ 98.615119] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.624545] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 98.625984] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 98.627010] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 98.660279] systemd[1]: Starting linger-users.service... machine # [ 98.661188] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 98.662335] systemd[1]: Starting reload-triggers.service... machine # [ 98.663258] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 98.710905] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 98.728369] systemd[1]: Reached target Local File Systems. machine # [ 98.729474] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 98.730676] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 98.732001] systemd[1]: Starting simple-service.service... machine # [ 98.777710] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 98.778786] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 98.819681] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 98.849832] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 98.881893] systemd[1]: Starting no-restart-service.service... machine # [ 98.882992] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 98.923921] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 98.954500] systemd[1]: Starting simple-reload-service.service... machine # [ 98.982382] systemd[1]: Finished simple-restart-service.service. machine # [ 98.997476] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 99.015928] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 99.030857] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 99.041781] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 99.055592] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 99.065617] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 99.067312] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.074971] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.081353] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 99.082346] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 99.083477] systemd[1]: Finished reload-triggers.service. machine # [ 99.092208] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 99.093604] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 99.094617] systemd[1]: Finished simple-service.service. machine # [ 99.095379] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 99.097583] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 99.102046] systemd[1]: Finished no-restart-service.service. machine # [ 99.102928] systemd[1]: Finished simple-reload-service.service. machine # [ 99.103808] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 99.106583] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 99.109216] systemd[1]: Finished linger-users.service. machine # [ 99.238970] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 99.243891] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 99.246797] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 99.274484] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 99.532350] nixos[6859]: finished switching to system configuration /nix/store/w4xd54nyz1jwb6a4r7xdi5w79wk4ynsy-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.32 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 99.799873] nixos[7030]: switching to system configuration /nix/store/w4xd54nyz1jwb6a4r7xdi5w79wk4ynsy-nixos-system-machine-test machine # [ 99.802696] systemd[1]: Stopped target Local File Systems. machine # [ 99.805337] systemd[1]: Stopped target Remote File Systems. machine # [ 100.119156] systemd[1]: Reload requested from client PID 7030 ('.switch-to-conf') (unit backdoor.service)... machine # [ 100.121300] systemd[1]: Reloading... machine # [ 100.467042] systemd[1]: Reloading finished in 344 ms. machine # [ 100.556423] systemd[572]: Reexecution requested from client PID 7101 ('switch-to-confi')... machine # [ 100.559298] systemd[572]: Reexecuting. machine # [ 100.619597] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 100.735167] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 100.742244] systemd[572]: Reload requested from client PID 7101 ('switch-to-confi')... machine # [ 100.744783] systemd[572]: Reloading... machine # [ 100.856197] systemd[572]: Reloading finished in 110 ms. machine # [ 100.872210] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 100.883029] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 100.885650] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 100.887977] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 100.921269] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 100.925182] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 100.927985] systemd[1]: Stopping Reactivate sysinit units... machine # [ 100.929221] systemd[1]: Reached target Reactivate sysinit units. machine # [ 100.934295] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 100.952389] systemd[1]: Reloading reload-triggers.service... machine # [ 100.956462] systemd[1]: Reloading simple-reload-service.service... machine # [ 100.964449] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 100.976716] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 100.992611] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 101.036751] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 101.054818] systemd[1]: Reloaded reload-triggers.service. machine # [ 101.069406] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 101.075349] systemd[1]: Reloaded simple-reload-service.service. machine # [ 101.084299] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 101.085472] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 101.089056] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 101.092659] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 101.093795] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 101.096650] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 101.101057] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 101.102239] systemd[1]: Stopped simple-restart-service.service. machine # [ 101.103127] systemd[1]: Stopping simple-restart-service.service... machine # [ 101.112297] systemd[1]: Starting simple-restart-service.service... machine # [ 101.113322] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 101.114286] systemd[1]: Stopped simple-service.service. machine # [ 101.115058] systemd[1]: Stopping simple-service.service... machine # [ 101.115892] systemd[1]: Starting simple-service.service... machine # [ 101.149565] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 101.151028] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 101.161325] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 101.162692] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 101.184807] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 101.186361] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 101.187580] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 101.222014] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 101.232270] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 101.240228] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 101.241506] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 101.242539] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 101.243527] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 101.249086] systemd[1]: Finished simple-restart-service.service. machine # [ 101.250070] systemd[1]: Finished simple-service.service. machine # [ 101.250858] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 101.251943] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 101.254099] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 101.255122] systemd[1]: Reached target Remote File Systems. machine # [ 101.259333] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.261547] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 101.264726] systemd[1]: Reached target Local File Systems. machine # [ 101.268886] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 101.275684] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 101.279725] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 101.286123] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 101.291297] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 101.293427] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.294756] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.462694] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 101.468515] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 101.470755] systemd[1]: Starting linger-users.service... machine # [ 101.516427] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 101.518879] systemd[1]: Finished linger-users.service. machine # [ 101.775532] nixos[7030]: finished switching to system configuration /nix/store/w4xd54nyz1jwb6a4r7xdi5w79wk4ynsy-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.25 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 102.128356] nixos[7196]: switching to system configuration /nix/store/bwln5lyiy87mpgy55kp1z2a64qbi0d5n-nixos-system-machine-test machine # [ 102.131122] systemd[1]: Stopped target Local File Systems. machine # [ 102.133529] systemd[1]: Stopped target Remote File Systems. machine # [ 102.508921] systemd[1]: Reload requested from client PID 7196 ('.switch-to-conf') (unit backdoor.service)... machine # [ 102.510847] systemd[1]: Reloading... machine # [ 102.869282] systemd[1]: Reloading finished in 355 ms. machine # [ 102.963042] systemd[572]: Reexecution requested from client PID 7267 ('switch-to-confi')... machine # [ 102.965473] systemd[572]: Reexecuting. machine # [ 103.023507] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.138068] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.145678] systemd[572]: Reload requested from client PID 7267 ('switch-to-confi')... machine # [ 103.147009] systemd[572]: Reloading... machine # [ 103.255387] systemd[572]: Reloading finished in 107 ms. machine # [ 103.272223] systemd[572]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.286053] systemd[572]: Stopped Run user-specific NixOS activation. machine # [ 103.287115] systemd[572]: Stopping Run user-specific NixOS activation... machine # [ 103.290324] systemd[572]: Starting Run user-specific NixOS activation... machine # [ 103.319655] systemd[572]: Finished Run user-specific NixOS activation. machine # [ 103.324725] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 103.326524] systemd[1]: Stopping Reactivate sysinit units... machine # [ 103.327356] systemd[1]: Reached target Reactivate sysinit units. machine # [ 103.333279] systemd[1]: Reloading reload-triggers.service... machine # [ 103.338267] systemd[1]: Reloading simple-reload-service.service... machine # [ 103.348264] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 103.359491] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 103.433928] systemd[1]: Reloaded reload-triggers.service. machine # [ 103.437288] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 103.441362] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 103.451418] systemd[1]: Reloaded simple-reload-service.service. machine # [ 103.459067] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 103.461408] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 103.462521] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 103.483366] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 103.484890] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 103.486045] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 103.486994] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 103.496202] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 103.524426] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 103.552594] systemd[1]: Stopped simple-restart-service.service. machine # [ 103.553827] systemd[1]: Stopping simple-restart-service.service... machine # [ 103.568602] systemd[1]: Starting simple-restart-service.service... machine # [ 103.634281] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 103.636656] systemd[1]: Stopped simple-service.service. machine # [ 103.638002] systemd[1]: Stopping simple-service.service... machine # [ 103.660405] systemd[1]: Starting simple-service.service... machine # [ 103.718207] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 103.749944] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 103.752887] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 103.755070] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 103.759023] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 103.780232] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 103.782094] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 103.818500] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 103.833444] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 103.834525] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 103.835922] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 103.853471] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 103.862114] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 103.867121] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 103.872500] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 103.881824] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 103.889324] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 103.890456] systemd[1]: Finished simple-restart-service.service. machine # [ 103.891319] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 103.907504] systemd[1]: Finished simple-service.service. machine # [ 103.911595] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 103.920933] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 103.922111] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 103.923078] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 103.925433] systemd[1]: Reached target Remote File Systems. machine # [ 103.929803] systemd[1]: Starting linger-users.service... machine # [ 103.930679] systemd[1]: Reached target Local File Systems. machine # [ 103.944904] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.956123] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 103.957717] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 103.959482] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 103.972661] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 103.974084] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 103.977855] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 103.982582] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.988543] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 104.033767] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 104.038577] systemd[1]: Finished linger-users.service. machine # [ 104.185896] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 104.187918] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 104.445829] nixos[7196]: finished switching to system configuration /nix/store/bwln5lyiy87mpgy55kp1z2a64qbi0d5n-nixos-system-machine-test machine: (finished: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.67 seconds) machine: must succeed: /nix/store/82w947bcwayzy2k0xwdyvmg6msgzk7vb-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/82w947bcwayzy2k0xwdyvmg6msgzk7vb-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.40 seconds) (finished: subtest: restart and reload by activation script, in 9.45 seconds) (finished: run the VM test script, in 105.53 seconds) test script finished in 105.57s 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-03T03:27:41Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-03T03:27:41Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-03T03:27:41Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.27 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