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.FWPbRFEe4O', 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: c4d75ee2-7705-44ff-b880-04eb95ef6bf5 machine # Superblock backups stored on blocks: machine # 32768, 98304, 163840, 229376 machine # machine # Allocating group tables: 0/8 done machine # Writing inode tables: 0/8 done machine # Creating journal (8192 blocks): done machine # Writing superblocks and filesystem accounting information: 0/8 done machine # machine # Virtualisation disk image created. machine # Starting virtiofs daemons... machine # [2026-09-29T03:50:01Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-29T03:50:01Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-29T03:50:01Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-29T03:50:01Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-29T03:50:01Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-29T03:50:01Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-29T03:50:01Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-29T03:50:01Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-29T03:50:01Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-29T03:50:01Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-29T03:50:01Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-29T03:50:01Z 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) 15.3.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 0x7fdee700-0x7fdf1e7f] 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/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/init regInfo=/nix/.ro-store/kpz7iz6w1368n661xhvqxak5shv5y17r-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/kpz7iz6w1368n661xhvqxak5shv5y17r-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 74966 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.000032] arm-pv: using stolen time PV machine # [ 0.000425] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000601] Console: colour dummy device 80x25 machine # [ 0.000610] printk: legacy console [tty0] enabled machine # [ 0.000818] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000825] pid_max: default: 32768 minimum: 301 machine # [ 0.000904] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.001073] landlock: Up and running. machine # [ 0.001076] Yama: becoming mindful. machine # [ 0.001545] LSM support for eBPF active machine # [ 0.001691] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.001711] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.003705] rcu: Hierarchical SRCU implementation. machine # [ 0.003710] rcu: Max phase no-delay instances is 1000. machine # [ 0.005028] fsl-mc MSI: its@8080000 domain created machine # [ 0.005151] EFI services will not be available. machine # [ 0.005230] smp: Bringing up secondary CPUs ... machine # [ 0.005240] smp: Brought up 1 node, 1 CPU machine # [ 0.005243] SMP: Total of 1 processors activated. machine # [ 0.005245] CPU: All CPU(s) started at EL1 machine # [ 0.005259] CPU features: detected: Branch Target Identification machine # [ 0.005264] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.005267] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.005270] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.005274] CPU features: detected: Common not Private translations machine # [ 0.005277] CPU features: detected: CRC32 instructions machine # [ 0.005280] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.005283] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.005286] CPU features: detected: Data independent timing control (DIT) machine # [ 0.005289] CPU features: detected: E0PD machine # [ 0.005292] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.005295] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.005298] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.005301] CPU features: detected: Fine Grained Traps machine # [ 0.005305] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.005309] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.005312] CPU features: detected: LSE atomic instructions machine # [ 0.005315] CPU features: detected: Privileged Access Never machine # [ 0.005318] CPU features: detected: PMUv3 machine # [ 0.005321] CPU features: detected: RAS Extension Support machine # [ 0.005324] CPU features: detected: RASv1p1 Extension Support machine # [ 0.005326] CPU features: detected: Random Number Generator machine # [ 0.005329] CPU features: detected: Speculation barrier (SB) machine # [ 0.005331] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.005334] CPU features: detected: TLB range maintenance instructions machine # [ 0.005338] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.005378] alternatives: applying system-wide alternatives machine # [ 0.008415] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.008648] Memory: 893736K/1048576K available (24448K kernel code, 7094K rwdata, 26596K rodata, 4736K init, 1107K bss, 113540K reserved, 32768K cma-reserved) machine # [ 0.009041] devtmpfs: initialized machine # [ 0.010802] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.010826] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.011022] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.011034] 0 pages in range for non-PLT usage machine # [ 0.011036] 508224 pages in range for PLT usage machine # [ 0.011250] pinctrl core: initialized pinctrl subsystem machine # [ 0.012104] DMI not present or invalid. machine # [ 0.015428] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.017894] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.018054] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.018214] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.018237] audit: initializing netlink subsys (disabled) machine # [ 0.018871] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.018874] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.018877] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.018880] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.018883] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.018914] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 machine # [ 0.018922] cpuidle: using governor ladder machine # [ 0.018928] cpuidle: using governor menu machine # [ 0.019150] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.019167] ASID allocator initialised with 65536 entries machine # [ 0.020383] Serial: AMBA PL011 UART driver machine # [ 0.026268] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.026448] printk: console [ttyAMA0] enabled machine # [ 0.159420] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.159430] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.159434] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.159437] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.159439] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.159442] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.159445] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.159448] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.160691] fbcon: Taking over console machine # [ 0.160701] ACPI: Interpreter disabled. machine # [ 0.170907] iommu: Default domain type: Translated machine # [ 0.170913] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.171338] SCSI subsystem initialized machine # [ 0.173485] usbcore: registered new interface driver usbfs machine # [ 0.173513] usbcore: registered new interface driver hub machine # [ 0.173529] usbcore: registered new device driver usb machine # [ 0.173856] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.173860] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.173868] PTP clock support registered machine # [ 0.173907] EDAC MC: Ver: 3.0.0 machine # [ 0.174078] scmi_core: SCMI protocol bus registered machine # [ 0.181020] FPGA manager framework machine # [ 0.181536] vgaarb: loaded machine # [ 0.181806] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.189587] VFS: Disk quotas dquot_6.6.0 machine # [ 0.189619] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.193589] netfs: FS-Cache loaded machine # [ 0.193715] pnp: PnP ACPI: disabled machine # [ 0.197804] NET: Registered PF_INET protocol family machine # [ 0.197971] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.229251] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.229290] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.229312] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.229354] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.229430] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.229547] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.229579] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.229603] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.229689] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.229727] NET: Registered PF_XDP protocol family machine # [ 0.229743] PCI: CLS 0 bytes, default 64 machine # [ 0.229901] Trying to unpack rootfs image as initramfs... machine # [ 0.248401] kvm [1]: HYP mode not available machine # [ 0.347454] Initialise system trusted keyrings machine # [ 0.347597] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.347976] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.348022] 9p: Installing v9fs 9p2000 file system support machine # [ 0.376339] Key type asymmetric registered machine # [ 0.376360] Asymmetric key parser 'x509' registered machine # [ 0.376447] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.376578] io scheduler mq-deadline registered machine # [ 0.376583] io scheduler kyber registered machine # [ 0.388872] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.389454] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.398003] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.398032] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.398062] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.398069] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.398092] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.398118] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.398228] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.398235] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.398240] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.398243] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.398246] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.398340] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.398821] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.399018] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.399030] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.399143] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.399158] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.399643] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.399831] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.399845] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.399870] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.400334] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.400521] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.400532] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.400558] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.401031] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.401224] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.401235] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.401261] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.401273] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.401751] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.430584] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.430611] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.431127] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.431325] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.431352] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.431768] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.431956] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.432215] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.432413] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.432441] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.432920] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.433114] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.433139] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.433607] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.433797] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.453894] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.454441] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.454755] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.454768] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.454793] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.455367] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.455561] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.455572] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.455598] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.456203] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.456209] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.456213] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.456260] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.456304] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.456349] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.456395] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.456441] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.456487] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.456535] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.456580] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.456627] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.456704] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.456750] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.456767] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.456786] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.456806] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.456824] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.456842] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.456860] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.456878] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.456900] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.456918] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.456936] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.456955] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.456972] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.456990] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.457007] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned machine # [ 0.457024] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned machine # [ 0.457041] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.457059] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.457080] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.457086] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.457089] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.497173] pci 0000:00:07.0: enabling device (0000 -> 0002) machine # [ 0.524852] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.528494] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.539024] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.541152] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.545188] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002) machine # [ 0.555582] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002) machine # [ 0.557391] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.561035] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.571229] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.573172] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.577625] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.590157] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.592201] msm_serial: driver initialized machine # [ 0.592344] SuperH (H)SCI(F) driver initialized machine # [ 0.592402] STM32 USART driver initialized machine # [ 0.628926] loop: module loaded machine # [ 0.629114] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 0.631244] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.638565] megasas: 07.734.00.00-rc1 machine # [ 0.639440] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.641438] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.641488] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.655030] Using buffer write method machine # [ 0.655152] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.656950] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.656965] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.658773] Using buffer write method machine # [ 0.658788] Concatenating MTD devices: machine # [ 0.658791] (0): "0.flash" machine # [ 0.658793] (1): "0.flash" machine # [ 0.658795] into device "0.flash" machine # [ 0.958710] Freeing initrd memory: 26428K machine # [ 0.964966] tun: Universal TUN/TAP device driver, 1.6 machine # [ 0.968900] thunder_xcv, ver 1.0 machine # [ 0.968927] thunder_bgx, ver 1.0 machine # [ 0.968946] nicpf, ver 1.0 machine # [ 0.969509] e1000: Intel(R) PRO/1000 Network Driver machine # [ 0.969513] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 0.969538] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 0.969549] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 0.969578] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 0.969582] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 0.969606] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 0.969610] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 0.969744] sky2: driver version 1.30 machine # [ 0.979307] usbcore: registered new interface driver usb-storage machine # [ 0.979408] usbcore: registered new interface driver usbserial_generic machine # [ 0.979419] usbserial: USB Serial support registered for generic machine # [ 0.980040] hv_vmbus: registering driver hyperv_keyboard machine # [ 0.981469] ehci-pci 0000:00:07.0: EHCI Host Controller machine # [ 0.981492] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1 machine # [ 0.981696] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000 machine # [ 0.987804] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 0.987829] rtc-pl031 9010000.pl031: setting system clock to 2026-09-29T03:50:03 UTC (1790653803) machine # [ 0.988230] i2c_dev: i2c /dev entries driver machine # [ 0.989870] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00 machine # [ 0.990181] hub 1-0:1.0: USB hub found machine # [ 0.990194] hub 1-0:1.0: 6 ports detected machine # [ 0.996992] sdhci: Secure Digital Host Controller Interface driver machine # [ 0.996998] sdhci: Copyright(c) Pierre Ossman machine # [ 0.997286] Synopsys Designware Multimedia Card Interface Driver machine # [ 0.997676] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 1.002354] hid: raw HID events driver (C) Jiri Kosina machine # [ 1.002599] usbcore: registered new interface driver usbhid machine # [ 1.002615] usbhid: USB HID core driver machine # [ 1.003842] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 1.005435] drop_monitor: Initializing network drop monitor service machine # [ 1.005631] NET: Registered PF_INET6 protocol family machine # [ 1.010886] Segment Routing with IPv6 machine # [ 1.010899] In-situ OAM (IOAM) with IPv6 machine # [ 1.010926] NET: Registered PF_PACKET protocol family machine # [ 1.010992] 9pnet: Installing 9P2000 support machine # [ 1.011030] Key type dns_resolver registered machine # [ 1.020038] registered taskstats version 1 machine # [ 1.020171] Loading compiled-in X.509 certificates machine # [ 1.028957] Demotion targets for Node 0: null machine # [ 1.029076] Key type .fscrypt registered machine # [ 1.029083] Key type fscrypt-provisioning registered machine # [ 1.029186] ima: No TPM chip found, activating TPM-bypass! machine # [ 1.029204] ima: Allocated hash algorithm: sha1 machine # [ 1.029225] ima: No architecture policies found machine # [ 1.033608] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 1.051999] clk: Disabling unused clocks machine # [ 1.052015] PM: genpd: Disabling unused power domains machine # [ 1.056319] Freeing unused kernel memory: 4736K machine # [ 1.056519] Run /init as init process machine # [ 1.072705] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.073212] systemd[1]: systemd 263-583679f 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.073228] systemd[1]: Detected virtualization qemu. machine # [ 1.073272] systemd[1]: Detected architecture arm64. machine # [ 1.073279] systemd[1]: Running in initrd. machine # [ 1.073597] systemd[1]: Initializing machine ID from random generator. machine # [ 1.073700] systemd[1]: Hostname set to . machine # [ 1.179330] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.237894] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.239821] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.248133] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.248379] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.248409] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.248430] systemd[1]: Reached target Path Units. machine # [ 1.248453] systemd[1]: Reached target Slice Units. machine # [ 1.248469] systemd[1]: Reached target Swaps. machine # [ 1.248483] systemd[1]: Reached target Timer Units. machine # [ 1.248631] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.248768] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.248919] systemd[1]: Listening on Journal Sockets. machine # [ 1.248998] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.249013] systemd[1]: Reached target Socket Units. machine # [ 1.259899] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.259985] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.269426] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.287698] systemd[1]: Starting Journal Service... machine # [ 1.298028] systemd[1]: Starting Load Kernel Modules... machine # [ 1.298160] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.326144] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.328720] systemd-journald[71]: Collecting audit messages is disabled. machine # [ 1.331772] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.362046] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.362671] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.401776] 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.415714] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.421985] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.427293] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.439492] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.448634] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0 machine # [ 1.448878] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.448881] [drm] features: -context_init machine # [ 1.449655] [drm] number of scanouts: 1 machine # [ 1.449667] [drm] number of cap sets: 0 machine # [ 1.478562] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.478778] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.478803] systemd[1]: Reached target Local File Systems. machine # [ 1.480408] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.482110] 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.487870] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic machine # [ 1.487883] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0 machine # [ 1.504916] systemd-modules-load[72]: Inserted module 'dm_mod' machine # [ 1.518292] Console: switching to colour frame buffer device 160x50 machine # [ 1.506950] systemd-modules-load[72]: Module 'virtio_balloon' is built in machine # [ 1.509859] systemd-modules-load[72]: Module 'virtio_console' is built in machine # [ 1.526146] systemd[1]: Started Journal Service. machine # [ 1.514050] systemd[1]: Starting Create System Files and Directories... machine # [ 1.546670] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.536855] systemd-modules-load[72]: Inserted module 'virtio_gpu' machine # [ 1.541047] systemd-modules-load[72]: Module 'virtio_rng' is built in machine # [ 1.545198] systemd[1]: Finished Load Kernel Modules. machine # [ 1.568863] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.581953] systemd-udevd[79]: Using default interface naming scheme 'v261'. machine # [ 1.601933] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.604603] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.609504] systemd[1]: Finished Create System Files and Directories. machine # [ 1.627979] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.728900] systemd[1]: Starting Virtual Console Setup... machine # [ 1.762471] 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.762739] 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.813497] systemd-vconsole-setup[102]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 1.820223] systemd[1]: Finished Virtual Console Setup. machine # [ 2.479950] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.481969] systemd[1]: Reached target System Initialization. machine # [ 2.484540] systemd[1]: Reached target Basic System. machine # [ 2.654493] (udev-worker)[98]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.658490] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.735423] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.738754] systemd[1]: Reached target Initrd Root Device. machine # [ 2.744112] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 2.795229] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 2.804083] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.808271] systemd[1]: Mounting /sysroot... machine # [ 2.862068] EXT4-fs (vda): mounted filesystem c4d75ee2-7705-44ff-b880-04eb95ef6bf5 r/w with ordered data mode. Quota mode: none. machine # [ 2.851128] systemd[1]: Mounted /sysroot. machine # [ 2.853092] systemd[1]: Reached target Initrd Root File System. machine # [ 2.856943] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.883213] systemd-sysroot-fstab-check[119]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.888116] systemd[1]: Reload requested from client PID 119 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.892181] systemd[1]: Reloading... machine # [ 3.084678] systemd[1]: Reloading finished in 195 ms. machine # [ 3.114270] systemd-sysroot-fstab-check[119]: Requesting initrd-fs.target/start/replace... machine # [ 3.120271] systemd-sysroot-fstab-check[119]: Requesting swap.target/start/replace... machine # [ 3.124154] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.127683] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.130288] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.315065] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.327295] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.343763] systemd[1]: Mounting /sysroot/run... machine # [ 3.348758] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.377883] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.448867] fuse: init (API version 7.45) machine # [ 3.467594] virtiofs virtio6: discovered new tag: nix-store machine # [ 3.468435] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 3.457886] systemd[1]: Mounted /sysroot/run. machine # [ 3.462928] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.483714] virtiofs virtio7: discovered new tag: shared machine # [ 3.484535] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 3.492346] virtiofs virtio8: discovered new tag: xchg machine # [ 3.493196] virtiofs virtio8: virtio_fs_setup_dax: No cache capability machine # [ 3.499759] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.511686] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.514917] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.517174] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.538117] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.540369] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.549539] systemd[1]: Mounting /sysroot/nix/store... machine # [ 3.597994] systemd[1]: Mounted /sysroot/nix/store. machine # [ 3.600069] systemd[1]: Reached target Initrd File Systems. machine # [ 3.602317] systemd[1]: Starting Find NixOS closure... machine # [ 3.611807] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 3.646804] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 3.663617] systemd[1]: Finished Find NixOS closure. machine # [ 3.666773] systemd[1]: Reached target Initrd Default Target. machine # [ 3.669406] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 3.702783] systemd[1]: Stopped target Initrd Default Target. machine # [ 3.705852] systemd[1]: Stopped target Basic System. machine # [ 3.706863] systemd[1]: Stopped target Initrd Root Device. machine # [ 3.708631] systemd[1]: Stopped target Path Units. machine # [ 3.713544] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 3.715395] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 3.720254] systemd[1]: Stopped target Slice Units. machine # [ 3.722244] systemd[1]: Stopped target Socket Units. machine # [ 3.728149] systemd[1]: Stopped target System Initialization. machine # [ 3.730300] systemd[1]: Stopped target Swaps. machine # [ 3.731157] systemd[1]: Stopped target Timer Units. machine # [ 3.733211] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 3.735522] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 3.746309] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 3.747542] systemd[1]: Stopped Find NixOS closure. machine # [ 3.752816] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.758467] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 3.761634] systemd[1]: Stopped Apply Kernel Variables. machine # [ 3.765781] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 3.768598] systemd[1]: Stopped Load Kernel Modules. machine # [ 3.770596] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 3.773669] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 3.776251] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 3.780220] systemd[1]: Stopped Create System Files and Directories. machine # [ 3.781248] systemd[1]: Stopped target Local File Systems. machine # [ 3.783316] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 3.786965] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 3.788245] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 3.791336] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 3.792692] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 3.793953] systemd[1]: Stopped Virtual Console Setup. machine # [ 3.794865] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 3.795861] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 3.801906] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.804178] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.808428] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 3.809647] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 3.811426] systemd[1]: systemd-udevd.service: Consumed 1.116s CPU time over 2.337s wall clock time, 16.7M memory peak. machine # [ 3.813532] systemd[1]: Starting Cleanup udev Database... machine # [ 3.814375] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 3.815496] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 3.816547] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 3.817818] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 3.818840] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 3.819848] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 3.850651] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 3.854130] systemd[1]: Finished Cleanup udev Database. machine # [ 3.855030] systemd[1]: Reached target Switch Root. machine # [ 3.860302] systemd[1]: Starting NixOS Activation... machine # [ 3.939358] initrd-nixos-activation-start[169]: booting system configuration /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test machine # [ 3.972656] initrd-nixos-activation-start[169]: running activation script... machine # [ 4.193048] initrd-nixos-activation-start[192]: setting up /etc... machine # [ 4.326014] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 4.329723] systemd[1]: Finished NixOS Activation. machine # [ 4.331430] systemd[1]: Starting Switch Root... machine # [ 4.359763] systemd[1]: Switching root. machine # [ 4.551587] systemd-journald[71]: Received SIGTERM from PID 1 (systemd). machine # [ 4.712467] systemd[1]: systemd 263-583679f running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 4.713335] systemd[1]: Detected virtualization qemu. machine # [ 4.722362] systemd[1]: Detected architecture arm64. machine # [ 4.722489] systemd[1]: Detected first boot. machine # [ 4.723992] systemd[1]: Initializing machine ID from random generator. machine # [ 4.855167] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 4.982079] systemd[1]: Applying preset policy. machine # [ 5.176483] systemd[1]: Populated /etc with preset unit settings. machine # [ 5.360391] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 5.361194] systemd[1]: Stopped initrd-switch-root.service. machine # [ 5.366613] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 5.368225] systemd[1]: Created slice Slice /system/getty. machine # [ 5.369317] systemd[1]: Created slice User and Session Slice. machine # [ 5.369702] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 5.374757] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 5.375253] systemd[1]: Expecting device /dev/hvc0... machine # [ 5.375847] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 5.376427] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 5.376999] systemd[1]: Stopped target initrd-fs.target. machine # [ 5.377523] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 5.383163] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 5.383566] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 5.384181] systemd[1]: Reached target Path Units. machine # [ 5.384738] systemd[1]: Reached target Remote File Systems. machine # [ 5.385307] systemd[1]: Reached target Slice Units. machine # [ 5.390195] systemd[1]: Reached target Swaps. machine # [ 5.391847] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 5.393624] systemd[1]: Listening on Process Core Dump Socket. machine # [ 5.397341] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 5.400068] systemd[1]: Listening on Factory Reset Management. machine # [ 5.400567] systemd[1]: Listening on Hostname Service Socket. machine # [ 5.405178] systemd[1]: Starting Journal Log Access Socket... machine # [ 5.407947] systemd[1]: Listening on Journal Audit Socket. machine # [ 5.410662] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 5.411374] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 5.411699] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.411954] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 5.421562] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 5.423085] systemd[1]: Listening on udev Varlink Socket. machine # [ 5.425750] systemd[1]: Mounting Huge Pages File System... machine # [ 5.437929] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 5.449899] systemd[1]: Mounting Kernel Debug File System... machine # [ 5.458117] systemd[1]: Mounting Kernel Trace File System... machine # [ 5.469028] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 5.473972] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 5.486196] systemd[1]: Mounting Kernel Configuration File System... machine # [ 5.488504] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 5.501956] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 5.502493] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 5.521390] systemd[1]: Mounting FUSE Control File System... machine # [ 5.525795] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 5.560640] systemd[1]: Starting Journal Service... machine # [ 5.581710] systemd[1]: Starting Load Kernel Modules... machine # [ 5.600627] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 5.614562] systemd-journald[264]: Collecting audit messages is enabled. machine # [ 5.622839] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 5.623229] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.612813] systemd[1]: Queued start job for default target Multi-User System. machine # [ 5.615528] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 5.651470] systemd[1]: Starting Coldplug All udev Devices... machine # [ 5.677754] systemd[1]: Started Journal Service. machine # [ 5.666904] systemd[1]: Listening on Journal Log Access Socket. machine # [ 5.670811] systemd-modules-load[265]: Module 'atkbd' is built in machine # [ 5.671799] systemd-modules-load[265]: Module 'loop' is built in machine # [ 5.681133] systemd[1]: Mounted Huge Pages File System. machine # [ 5.682255] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 5.683298] systemd[1]: Mounted Kernel Debug File System. machine # [ 5.693276] systemd[1]: Mounted Kernel Trace File System. machine # [ 5.694142] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 5.695084] systemd[1]: Mounted Kernel Configuration File System. machine # [ 5.695998] systemd[1]: Finished Load Kernel Modules. machine # [ 5.708545] systemd[1]: Starting Firewall... machine # [ 5.719091] systemd[1]: Starting Apply Kernel Variables... machine # [ 5.722848] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 5.786233] systemd-oomd[267]: No swap; memory pressure usage will be degraded machine # [ 5.807487] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 5.826926] EXT4-fs (vda): re-mounted c4d75ee2-7705-44ff-b880-04eb95ef6bf5. machine # [ 5.819067] systemd[1]: Mounted FUSE Control File System. machine # [ 5.831064] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 5.836375] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 5.848096] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 5.849189] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 5.862639] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 5.863640] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.915546] systemd[1]: Finished Apply Kernel Variables. machine # [ 5.954904] systemd-journald[264]: Received client request to flush runtime journal. machine # [ 5.996567] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 5.997612] systemd[1]: Reached target First Boot Complete. machine # [ 6.009081] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 6.058484] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 6.061905] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 6.212487] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 6.215936] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 6.218305] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 6.352687] systemd[1]: Mounting /run/wrappers... machine # [ 6.492083] systemd[1]: Mounted /run/wrappers. machine # [ 6.492948] systemd[1]: Reached target Local File Systems. machine # [ 6.510435] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 6.516120] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 6.517163] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 6.526682] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 6.532287] systemd[1]: Starting Create System Files and Directories... machine # [ 6.556654] systemd-udevd[307]: Using default interface naming scheme 'v261'. machine # [ 6.666107] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 6.680422] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 6.726069] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 6.756340] systemd[1]: Finished Create System Files and Directories. machine # [ 6.832098] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 6.837393] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 6.986950] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 7.022514] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 7.033304] systemd[1]: Starting Update is Completed... machine # [ 7.122070] systemd[1]: Finished Update is Completed. machine # [ 7.436339] systemd[1]: Finished Coldplug All udev Devices. machine # [ 7.517454] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 7.522380] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 7.528386] systemd[1]: Reached target System Initialization. machine # [ 7.529443] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 7.530532] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 7.531542] systemd[1]: Reached target Timer Units. machine # [ 7.539861] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 7.545594] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 7.546908] systemd[1]: Reached target Socket Units. machine # [ 7.547684] systemd[1]: Reached target Basic System. machine # [ 7.555140] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 7.561876] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 7.562940] systemd[1]: Starting Post-Boot Actions... machine # [ 7.571380] systemd[1]: Started Reset console on configuration changes. machine # [ 7.615327] systemd[1]: Starting resolvconf update... machine # [ 7.679431] systemd[1]: Starting D-Bus System Message Bus... machine # [ 7.739039] nsncd[424]: Sep 29 03:50:10.267 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 7.756371] systemd[1]: Finished Post-Boot Actions. machine # [ 7.757310] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 7.780331] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 7.781586] systemd[1]: Reached target User and Group Name Lookups. machine # [ 7.808156] systemd[1]: Starting User Login Management... machine # [ 7.864170] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 7.971361] dbus-broker-launch[433]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 7.979473] dbus-broker-launch[433]: NSS returned no entry for 'systemd-timesync' machine # [ 7.987813] dbus-broker-launch[433]: Invalid user-name in /nix/store/n9gdx9aa5f6rhwnpm4q6k6k9ys4c0vjz-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 8.018394] systemd[1]: Started D-Bus System Message Bus. machine # [ 8.029282] systemd-logind[452]: New seat seat0. machine # [ 8.035682] systemd[1]: Started User Login Management. machine # [ 8.047030] systemd[1]: Starting linger-users.service... machine # [ 8.081284] dbus-broker-launch[433]: Ready machine # [ 8.106724] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 8.114468] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 8.115588] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 8.128461] systemd[1]: Stopping User and Group Name Lookups... machine # [ 8.129455] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 8.130414] systemd[1]: nscd.service: Deactivated successfully. machine # [ 8.140530] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 8.170662] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 8.236741] systemd[1]: Created slice Slice /user/1001. machine # [ 8.251395] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 8.269529] nsncd[517]: Sep 29 03:50:10.797 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 8.292320] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 8.300632] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 8.301779] systemd[1]: Reached target User and Group Name Lookups. machine # [ 8.310556] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 8.317878] systemd[1]: Finished linger-users.service. machine # [ 8.334529] systemd[1]: Finished resolvconf update. machine # [ 8.350064] systemd[1]: Starting DHCP Client... machine # [ 8.382830] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 8.415384] systemd[1]: Starting User Manager for UID 1001... machine # [ 8.596194] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3 machine # [ 8.602213] (systemd)[554]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 8.631933] systemd-logind[452]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 8.705281] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 8.977470] systemd[554]: Queued start job for default target Main User Target. machine # [ 9.012330] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 9.070808] systemd[554]: Created slice User Application Slice. machine # [ 9.107195] systemd[554]: Started Daily Cleanup of User's Temporary Directories. machine # [ 9.130483] systemd[554]: Reached target Paths. machine # [ 9.131411] systemd[554]: Reached target Timers. machine # [ 9.178140] systemd[554]: Starting D-Bus User Message Bus Socket... machine # [ 9.202991] systemd[554]: Starting Create User Files and Directories... machine # [ 9.231285] systemd[554]: Finished Create User Files and Directories. machine # [ 9.247045] systemd[554]: Listening on D-Bus User Message Bus Socket. machine # [ 9.267979] systemd[554]: Reached target Sockets. machine # [ 9.281509] systemd[554]: Reached target Basic System. machine # [ 9.296501] systemd[1]: Started User Manager for UID 1001. machine # [ 9.315549] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 9.332115] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 9.357004] systemd[554]: Reached target Main User Target. machine # [ 9.373318] systemd[554]: Startup finished in 473ms. machine # [ 9.402854] systemd[1]: Starting Virtual Console Setup... machine # [ 9.413314] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 9.452248] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 9.474141] systemd[1]: Stopped Virtual Console Setup. machine # [ 9.490441] systemd[1]: Starting Virtual Console Setup... machine # [ 9.507603] systemd[1]: Finished Firewall. machine # [ 9.517320] systemd[1]: Reached target Preparation for Network. machine # [ 9.528312] systemd[1]: Starting Extra networking commands.... machine # [ 9.540477] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 9.551825] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 9.563114] systemd[1]: Started backdoor.service. machine # [ 9.573044] (udev-worker)[352]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 9.593619] (udev-worker)[352]: Network interface NamePolicy= disabled on kernel command line. machine # [ 9.646142] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 9.657624] dhcpcd[571]: dhcpcd-10.3.2 starting machine # [ 9.664991] systemd[1]: Starting Address configuration of eth1... machine # [ 9.676634] dhcpcd[603]: dev: loaded udev machine # [ 9.715360] 8021q: 802.1Q VLAN Support v1.8 machine # connecting to host... machine # [ 9.819311] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 9.842184] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 9.842667] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 9.843617] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 9.843912] cfg80211: failed to load regulatory.db machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 10.15 seconds) machine: (finished: waiting for the VM to finish booting, in 10.67 seconds) machine # [ 9.982316] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 10.100446] network-addresses-eth1-start[601]: adding address 192.168.1.1/24... done machine # [ 10.193257] systemd-logind[452]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # [ 10.194832] dhcpcd[654]: /nix/store/1ki7bgdr0niilkg9jbkpcdaggbv0kb8a-openresolv-3.17.4/sbin/.resolvconf-wrapped: line 1250: kill: (600) - Operation not permitted machine # [ 10.265414] dhcpcd[654]: .resolvconf-wrapped: clearing stale lock pid 600 machine # [ 10.266477] network-addresses-eth1-start[601]: adding address 2001:db8:1::1/64... done machine # [ 10.329458] systemd[1]: Finished Address configuration of eth1. machine # [ 10.379938] mousedev: PS/2 mouse device common for all mice machine # [ 10.401649] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 10.389947] dhcpcd[603]: eth0: waiting for carrier machine # [ 10.393622] dhcpcd[603]: eth0: carrier acquired machine # [ 10.427746] dhcpcd[603]: DUID 00:01:00:01:32:4d:f1:f4:52:54:00:12:34:56 machine # [ 10.434268] systemd[1]: Finished Extra networking commands.. machine # [ 10.435387] dhcpcd[603]: eth0: IAID 00:12:34:56 machine # [ 10.446411] systemd[1]: Reached target Network. machine # [ 10.447194] dhcpcd[603]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 10.460114] systemd[1]: Starting Permit User Sessions... machine # [ 10.475968] systemd-vconsole-setup[590]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 10.494439] systemd[1]: Finished Virtual Console Setup. machine # [ 10.559169] systemd-logind[452]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 10.615590] systemd[1]: Finished Permit User Sessions. machine # [ 10.625494] systemd[1]: Started Getty on tty1. machine # [ 10.626257] systemd[1]: Reached target Login Prompts. machine # [ 11.520528] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 11.524458] systemd[1]: Stopped Virtual Console Setup. machine # [ 11.525363] systemd[1]: Stopping Virtual Console Setup... machine # [ 11.567612] systemd[1]: Starting Virtual Console Setup... machine # [ 11.576344] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 11.592153] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 11.593456] systemd[1]: Stopped Virtual Console Setup. machine # [ 11.612165] systemd-logind[452]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 11.613605] systemd[1]: Starting Virtual Console Setup... machine # [ 11.732792] systemd-vconsole-setup[712]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 11.738590] systemd[1]: Finished Virtual Console Setup. machine # [ 11.786927] dhcpcd[603]: eth0: soliciting a DHCP lease machine # [ 11.788988] dhcpcd[603]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 11.796277] dhcpcd[603]: eth0: probing address 10.0.2.15/24 machine # [ 13.281093] dhcpcd[603]: eth0: soliciting an IPv6 router machine # [ 13.283098] dhcpcd[603]: eth0: Router Advertisement from fe80::2 machine # [ 13.284713] dhcpcd[603]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 13.286205] dhcpcd[603]: eth0: adding route to fec0::/64 machine # [ 13.287393] dhcpcd[603]: eth0: adding default route via fe80::2 machine # [ 16.772756] dhcpcd[603]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 16.775631] dhcpcd[603]: eth0: adding route to 10.0.2.0/24 machine # [ 16.778317] dhcpcd[603]: eth0: adding default route via 10.0.2.2 machine # [ 16.892731] systemd[1]: Started DHCP Client. machine # [ 16.895113] systemd[1]: Reached target Multi-User System. machine # [ 16.896597] systemd[1]: Startup finished in 1.043s (kernel) + 3.564s (initrd) + 12.286s (userspace) = 16.894s. machine: (finished: waiting for unit multi-user.target, in 17.82 seconds) machine: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 17.226550] nixos[825]: switching to system configuration /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test machine # [ 17.229286] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # [ 17.232274] systemd[1]: Stopped target Local File Systems. machine # setting up /etc... machine # [ 17.522459] systemd[1]: Reload requested from client PID 825 ('.switch-to-conf') (unit backdoor.service)... machine # [ 17.524671] systemd[1]: Reloading... machine # [ 17.835868] systemd[1]: Reloading finished in 309 ms. machine # reloading user units for usertest... machine # [ 17.888973] systemd[554]: Created slice User Core Session Slice. machine # [ 17.892547] systemd[554]: Starting D-Bus User Message Bus... machine # [ 17.923391] dbus-broker-launch[895]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/n9gdx9aa5f6rhwnpm4q6k6k9ys4c0vjz-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 17.926920] dbus-broker-launch[895]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/n9gdx9aa5f6rhwnpm4q6k6k9ys4c0vjz-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 17.930089] dbus-broker-launch[895]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/n9gdx9aa5f6rhwnpm4q6k6k9ys4c0vjz-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 17.933226] dbus-broker-launch[895]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/n9gdx9aa5f6rhwnpm4q6k6k9ys4c0vjz-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 17.938035] dbus-broker-launch[895]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 17.939879] dbus-broker-launch[895]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 17.943088] systemd[554]: Started D-Bus User Message Bus. machine # [ 17.946140] dbus-broker-launch[895]: Ready machine # [ 17.987895] systemd[554]: Reexecution requested from client PID 894 ('switch-to-confi')... machine # [ 17.990937] systemd[554]: Reexecuting. machine # [ 18.047936] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 18.154058] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 18.160396] systemd[554]: Reload requested from client PID 894 ('switch-to-confi')... machine # [ 18.162843] systemd[554]: Reloading... machine # [ 18.264854] systemd[554]: Reloading finished in 101 ms. machine # [ 18.280224] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 18.290178] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 18.292488] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 18.294844] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 18.326781] systemd[554]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 18.338034] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 18.420281] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 18.424685] systemd[1]: Reached target Reactivate sysinit units. machine # [ 18.427614] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.430544] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 18.435113] systemd[1]: Reached target Local File Systems. machine # [ 18.437591] systemd[1]: Reached target Remote File Systems. machine # [ 18.444576] systemd[1]: Starting linger-users.service... machine # [ 18.450013] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 18.463182] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 18.464544] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 18.465950] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 18.468607] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 18.470284] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.471644] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.531120] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 18.534559] systemd[1]: Finished linger-users.service. machine # [ 18.658565] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 18.662016] systemd[1]: Finished Create SUID/SGID Wrappers. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 18.918259] nixos[825]: finished switching to system configuration /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/bin/switch-to-configuration test, in 1.92 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.03 seconds) machine: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/y9v5acm6cxjwf9wq5327x1qz6yz5rk47-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/y9v5acm6cxjwf9wq5327x1qz6yz5rk47-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 19.162150] nixos[972]: switching to system configuration /nix/store/y9v5acm6cxjwf9wq5327x1qz6yz5rk47-nixos-system-other-test machine # [ 19.164716] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # [ 19.167493] systemd[1]: Stopped target Local File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 19.435384] systemd[1]: Reload requested from client PID 972 ('.switch-to-conf') (unit backdoor.service)... machine # [ 19.437567] systemd[1]: Reloading... machine # [ 19.763957] systemd[1]: Reloading finished in 324 ms. machine # reloading user units for usertest... machine # [ 19.878176] systemd[554]: Reexecution requested from client PID 1043 ('switch-to-confi')... machine # [ 19.882708] systemd[554]: Reexecuting. machine # [ 19.945117] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.073332] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.080803] systemd[554]: Reload requested from client PID 1043 ('switch-to-confi')... machine # [ 20.082412] systemd[554]: Reloading... machine # [ 20.195223] systemd[554]: Reloading finished in 110 ms. machine # [ 20.212190] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 20.222859] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 20.225374] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 20.227626] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 20.261292] systemd[554]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 20.266089] systemd[1]: Stopped target Reactivate sysinit units. machine # reloading the following units: [ 20.268685] systemd[1]: Stopping Reactivate sysinit units... machine # dbus-broker.service machine # [ 20.273464] systemd[1]: Reached target Reactivate sysinit units. machine # [ 20.274421] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 20.275664] dbus-broker-launch[433]: Caught SIGHUP, trigger reload. machine # [ 20.281571] dbus-broker-launch[433]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 20.283846] dbus-broker-launch[433]: NSS returned no entry for 'systemd-timesync' machine # [ 20.285419] dbus-broker-launch[433]: Invalid user-name in /nix/store/yjpadarjghmqr4jbyr5h20nranfk3nc8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 20.301251] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 20.308249] systemd[1]: Stopping Address configuration of eth1... machine # [ 20.338966] network-addresses-eth1-pre-stop[1056]: deleting address 192.168.1.1/24... done machine # [ 20.345636] network-addresses-eth1-pre-stop[1056]: deleting address 2001:db8:1::1/64... done machine # [ 20.352788] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 20.355276] systemd[1]: Stopped Address configuration of eth1. machine # [ 20.360236] systemd[1]: Starting Address configuration of eth1... machine # [ 20.402456] network-addresses-eth1-start[1061]: adding address 192.168.1.2/24... done machine # [ 20.409836] network-addresses-eth1-start[1061]: adding address 2001:db8:1::2/64... done machine # [ 20.419581] systemd[1]: Finished Address configuration of eth1. machine # [ 20.426681] systemd[1]: Reached target Remote File Systems. machine # [ 20.434516] systemd[1]: Starting linger-users.service... machine # [ 20.440783] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.442342] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 20.451576] systemd[1]: Reached target Local File Systems. machine # [ 20.457757] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 20.459405] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 20.466029] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 20.467481] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 20.476290] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 20.478103] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.479436] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.507778] linger-users-start[1075]: id: ‘usertest’: no such user machine # [ 20.510411] linger-users-start[1072]: Removing linger for missing user usertest machine # [ 20.521954] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 20.525455] systemd[1]: Finished linger-users.service. machine # [ 20.685638] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 20.688520] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 20.944933] nixos[972]: finished switching to system configuration /nix/store/y9v5acm6cxjwf9wq5327x1qz6yz5rk47-nixos-system-other-test machine: (finished: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/y9v5acm6cxjwf9wq5327x1qz6yz5rk47-nixos-system-other-test/bin/switch-to-configuration test, in 2.00 seconds) subtest: services machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 21.163896] nixos[1139]: switching to system configuration /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test machine # [ 21.166646] systemd[1]: Stopped target Remote File Systems. machine # [ 21.169399] systemd[1]: Stopped target Local File Systems. machine # [ 21.433941] systemd[1]: Reload requested from client PID 1139 ('.switch-to-conf') (unit backdoor.service)... machine # [ 21.435978] systemd[1]: Reloading... machine # [ 21.743884] systemd[1]: Reloading finished in 305 ms. machine # [ 21.826850] systemd[554]: Reexecution requested from client PID 1208 ('switch-to-confi')... machine # [ 21.831124] systemd[554]: Reexecuting. machine # [ 21.887167] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.998051] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.004690] systemd[554]: Reload requested from client PID 1208 ('switch-to-confi')... machine # [ 22.007210] systemd[554]: Reloading... machine # [ 22.113316] systemd[554]: Reloading finished in 104 ms. machine # [ 22.128435] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.137986] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 22.140155] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 22.143088] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 22.182181] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 22.187228] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 22.193401] systemd[1]: Stopping Reactivate sysinit units... machine # [ 22.194512] systemd[1]: Reached target Reactivate sysinit units. machine # [ 22.196806] dbus-broker-launch[433]: Caught SIGHUP, trigger reload. machine # [ 22.199407] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 22.202486] dbus-broker-launch[433]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 22.205096] dbus-broker-launch[433]: NSS returned no entry for 'systemd-timesync' machine # [ 22.206316] dbus-broker-launch[433]: Invalid user-name in /nix/store/n9gdx9aa5f6rhwnpm4q6k6k9ys4c0vjz-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 22.231990] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 22.238732] systemd[1]: Stopping Address configuration of eth1... machine # [ 22.276516] network-addresses-eth1-pre-stop[1220]: deleting address 192.168.1.2/24... done machine # [ 22.284687] network-addresses-eth1-pre-stop[1220]: deleting address 2001:db8:1::2/64... done machine # [ 22.294290] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 22.296538] systemd[1]: Stopped Address configuration of eth1. machine # [ 22.301104] systemd[1]: Starting Address configuration of eth1... machine # [ 22.345304] network-addresses-eth1-start[1225]: adding address 192.168.1.1/24... done machine # [ 22.353195] network-addresses-eth1-start[1225]: adding address 2001:db8:1::1/64... done machine # [ 22.363405] systemd[1]: Finished Address configuration of eth1. machine # [ 22.366856] systemd[1]: Reached target Remote File Systems. machine # [ 22.372736] systemd[1]: Reached target Local File Systems. machine # [ 22.377042] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 22.382302] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 22.383428] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 22.394940] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 22.403449] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 22.405857] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.407523] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.409346] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.410984] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 22.586666] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 22.591871] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 22.594324] systemd[1]: Starting linger-users.service... machine # [ 22.630229] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 22.633395] systemd[1]: Finished linger-users.service. machine # [ 22.889986] nixos[1139]: finished switching to system configuration /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.94 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 23.142799] nixos[1294]: switching to system configuration /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test machine # [ 23.145865] systemd[1]: Stopped target Remote File Systems. machine # [ 23.148424] systemd[1]: Stopped target Local File Systems. machine # [ 23.432308] systemd[1]: Reload requested from client PID 1294 ('.switch-to-conf') (unit backdoor.service)... machine # [ 23.434513] systemd[1]: Reloading... machine # [ 23.747790] systemd[1]: Reloading finished in 311 ms. machine # [ 23.832410] systemd[554]: Reexecution requested from client PID 1364 ('switch-to-confi')... machine # [ 23.833886] systemd[554]: Reexecuting. machine # [ 23.895894] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.006916] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.013636] systemd[554]: Reload requested from client PID 1364 ('switch-to-confi')... machine # [ 24.017434] systemd[554]: Reloading... machine # [ 24.120416] systemd[554]: Reloading finished in 103 ms. machine # [ 24.136179] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.146943] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 24.149359] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 24.151566] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 24.183790] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 24.187709] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 24.191060] systemd[1]: Stopping Reactivate sysinit units... machine # [ 24.191946] systemd[1]: Reached target Reactivate sysinit units. machine # [ 24.194975] systemd[1]: Reached target Local File Systems. machine # [ 24.195838] systemd[1]: Reached target Remote File Systems. machine # [ 24.200799] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 24.205973] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 24.206956] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 24.216317] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 24.218753] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 24.224402] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.225910] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.227175] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.228565] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 24.381068] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 24.384708] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 24.387953] systemd[1]: Starting linger-users.service... machine # [ 24.429385] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 24.432671] systemd[1]: Finished linger-users.service. machine # [ 24.686822] nixos[1294]: finished switching to system configuration /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.80 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 24.907603] nixos[1435]: switching to system configuration /nix/store/y6dbhpqs004pcws0as1989c2plsw071z-nixos-system-machine-test machine # [ 24.910316] systemd[1]: Stopped target Remote File Systems. machine # [ 24.912758] systemd[1]: Stopped target Local File Systems. machine # [ 25.183243] systemd[1]: Reload requested from client PID 1435 ('.switch-to-conf') (unit backdoor.service)... machine # [ 25.185612] systemd[1]: Reloading... machine # [ 25.495459] systemd[1]: Reloading finished in 308 ms. machine # [ 25.580076] systemd[554]: Reexecution requested from client PID 1504 ('switch-to-confi')... machine # [ 25.584460] systemd[554]: Reexecuting. machine # [ 25.639811] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.753911] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.760572] systemd[554]: Reload requested from client PID 1504 ('switch-to-confi')... machine # [ 25.763172] systemd[554]: Reloading... machine # [ 25.870454] systemd[554]: Reloading finished in 106 ms. machine # [ 25.889677] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.897002] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 25.899496] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 25.901843] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 25.936107] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 25.940123] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 25.944848] systemd[1]: Stopping Reactivate sysinit units... machine # [ 25.945936] systemd[1]: Reached target Reactivate sysinit units. machine # [ 25.946814] systemd[1]: Reached target Remote File Systems. machine # [ 25.951074] systemd[1]: Starting linger-users.service... machine # [ 25.954342] systemd[1]: Starting test.service... machine # [ 25.968111] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.969735] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 25.977509] systemd[1]: Reached target Local File Systems. machine # [ 25.978467] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 25.989262] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 25.990286] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 26.005726] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 26.013174] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 26.021591] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.023068] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.038194] systemd[1]: Finished test.service. machine # [ 26.073870] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 26.075673] systemd[1]: Finished linger-users.service. machine # [ 26.207324] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 26.209707] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 26.467256] nixos[1435]: finished switching to system configuration /nix/store/y6dbhpqs004pcws0as1989c2plsw071z-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.78 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 26.666217] nixos[1578]: switching to system configuration /nix/store/y6dbhpqs004pcws0as1989c2plsw071z-nixos-system-machine-test machine # [ 26.671337] systemd[1]: Stopped target Local File Systems. machine # [ 26.673668] systemd[1]: Stopped target Remote File Systems. machine # [ 26.938138] systemd[1]: Reload requested from client PID 1578 ('.switch-to-conf') (unit backdoor.service)... machine # [ 26.940426] systemd[1]: Reloading... machine # [ 27.253598] systemd[1]: Reloading finished in 310 ms. machine # [ 27.336420] systemd[554]: Reexecution requested from client PID 1647 ('switch-to-confi')... machine # [ 27.339919] systemd[554]: Reexecuting. machine # [ 27.395277] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.507174] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.513713] systemd[554]: Reload requested from client PID 1647 ('switch-to-confi')... machine # [ 27.517200] systemd[554]: Reloading... machine # [ 27.619143] systemd[554]: Reloading finished in 102 ms. machine # [ 27.637735] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.646012] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 27.648353] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 27.650502] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 27.683265] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 27.687421] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 27.689647] systemd[1]: Stopping Reactivate sysinit units... machine # [ 27.690510] systemd[1]: Reached target Reactivate sysinit units. machine # [ 27.692837] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.694224] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 27.702987] systemd[1]: Reached target Local File Systems. machine # [ 27.703907] systemd[1]: Reached target Remote File Systems. machine # [ 27.708878] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 27.710501] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 27.711322] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 27.721821] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 27.724208] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 27.725867] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.727169] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.881870] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 27.886646] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 27.889127] systemd[1]: Starting linger-users.service... machine # [ 27.927752] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 27.929864] systemd[1]: Finished linger-users.service. machine # [ 28.185877] nixos[1578]: finished switching to system configuration /nix/store/y6dbhpqs004pcws0as1989c2plsw071z-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.72 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 28.408189] nixos[1718]: switching to system configuration /nix/store/jy5smpgiy37rir4p4w11r4dx0nawg6vx-nixos-system-machine-test machine # [ 28.410815] systemd[1]: Stopped target Local File Systems. machine # [ 28.413116] systemd[1]: Stopped target Remote File Systems. machine # [ 28.679288] systemd[1]: Reload requested from client PID 1718 ('.switch-to-conf') (unit backdoor.service)... machine # [ 28.681618] systemd[1]: Reloading... machine # [ 29.019598] systemd[1]: Reloading finished in 336 ms. machine # [ 29.103414] systemd[554]: Reexecution requested from client PID 1787 ('switch-to-confi')... machine # [ 29.106553] systemd[554]: Reexecuting. machine # [ 29.163551] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.276621] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.283361] systemd[554]: Reload requested from client PID 1787 ('switch-to-confi')... machine # [ 29.286735] systemd[554]: Reloading... machine # [ 29.389397] systemd[554]: Reloading finished in 103 ms. machine # [ 29.406002] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.414735] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 29.417564] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 29.419852] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 29.457277] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 29.461344] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 29.464705] systemd[1]: Stopping Reactivate sysinit units... machine # [ 29.465789] systemd[1]: Reached target Reactivate sysinit units. machine # [ 29.466698] systemd[1]: Reached target Local File Systems. machine # [ 29.471502] systemd[1]: Reached target Remote File Systems. machine # [ 29.477161] systemd[1]: Starting linger-users.service... machine # [ 29.488920] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.499718] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 29.508358] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 29.515646] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 29.518967] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 29.521277] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 29.527339] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 29.531818] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.536979] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.572565] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 29.575787] systemd[1]: Finished linger-users.service. machine # [ 29.751637] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 29.754434] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 30.009807] nixos[1718]: finished switching to system configuration /nix/store/jy5smpgiy37rir4p4w11r4dx0nawg6vx-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 1.82 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 30.235333] nixos[1859]: switching to system configuration /nix/store/s3b407h36nxah08jmy7rz1m5vjysag6i-nixos-system-machine-test machine # [ 30.238555] systemd[1]: Stopped target Local File Systems. machine # [ 30.240440] systemd[1]: test.service: Deactivated successfully. machine # [ 30.242072] systemd[1]: Stopped Test unit. machine # [ 30.243986] systemd[1]: Stopped target Remote File Systems. machine # [ 30.546911] systemd[1]: Reload requested from client PID 1859 ('.switch-to-conf') (unit backdoor.service)... machine # [ 30.549422] systemd[1]: Reloading... machine # [ 30.871000] systemd[1]: Reloading finished in 320 ms. machine # [ 30.958773] systemd[554]: Reexecution requested from client PID 1928 ('switch-to-confi')... machine # [ 30.962518] systemd[554]: Reexecuting. machine # [ 31.019830] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.134051] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.141042] systemd[554]: Reload requested from client PID 1928 ('switch-to-confi')... machine # [ 31.144888] systemd[554]: Reloading... machine # [ 31.248822] systemd[554]: Reloading finished in 104 ms. machine # [ 31.264187] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.274281] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 31.276688] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 31.278776] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 31.311971] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 31.316439] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 31.320906] systemd[1]: Stopping Reactivate sysinit units... machine # [ 31.321954] systemd[1]: Reached target Reactivate sysinit units. machine # [ 31.323920] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.328813] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 31.331665] systemd[1]: Starting test.service... machine # [ 31.336501] systemd[1]: Reached target Local File Systems. machine # [ 31.337481] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 31.341417] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 31.342385] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 31.343704] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 31.361776] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 31.363512] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.370928] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.374977] systemd[1]: Reached target Remote File Systems. machine # [ 31.392929] systemd[1]: Finished test.service. machine # [ 31.535286] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 31.538476] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 31.543045] systemd[1]: Starting linger-users.service... machine # [ 31.584718] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 31.588083] systemd[1]: Finished linger-users.service. machine # [ 31.842386] nixos[1859]: finished switching to system configuration /nix/store/s3b407h36nxah08jmy7rz1m5vjysag6i-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.83 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 32.058338] nixos[2001]: switching to system configuration /nix/store/r3yvszdzilbq30gd4r6y9cy3afzfkb29-nixos-system-machine-test machine # [ 32.060956] systemd[1]: Stopped target Local File Systems. machine # [ 32.063523] systemd[1]: Stopped target Remote File Systems. machine # [ 32.335387] systemd[1]: Reload requested from client PID 2001 ('.switch-to-conf') (unit backdoor.service)... machine # [ 32.337697] systemd[1]: Reloading... machine # [ 32.642722] systemd[1]: Reloading finished in 303 ms. machine # [ 32.720808] systemd[554]: Reexecution requested from client PID 2069 ('switch-to-confi')... machine # [ 32.725186] systemd[554]: Reexecuting. machine # [ 32.779200] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.890255] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.897532] systemd[554]: Reload requested from client PID 2069 ('switch-to-confi')... machine # [ 32.901287] systemd[554]: Reloading... machine # [ 33.025826] systemd[554]: Reloading finished in 125 ms. machine # [ 33.051473] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.063134] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 33.065604] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 33.067665] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 33.099553] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 33.103232] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 33.105070] systemd[1]: Stopping Reactivate sysinit units... machine # [ 33.105925] systemd[1]: Reached target Reactivate sysinit units. machine # [ 33.109851] systemd[1]: test.service: Deactivated successfully. machine # [ 33.110811] systemd[1]: Stopped test.service. machine # [ 33.111506] systemd[1]: Stopping test.service... machine # [ 33.116261] systemd[1]: Starting test.service... machine # [ 33.136653] systemd[1]: Finished test.service. machine # [ 33.140496] systemd[1]: Reached target Local File Systems. machine # [ 33.144381] systemd[1]: Reached target Remote File Systems. machine # [ 33.151137] systemd[1]: Starting linger-users.service... machine # [ 33.162454] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 33.172353] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 33.173338] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 33.174613] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 33.185840] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 33.187599] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.196559] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.198035] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.199347] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 33.242314] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 33.245282] systemd[1]: Finished linger-users.service. machine # [ 33.367040] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 33.370284] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 33.624331] nixos[2001]: finished switching to system configuration /nix/store/r3yvszdzilbq30gd4r6y9cy3afzfkb29-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.78 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 33.848533] nixos[2144]: switching to system configuration /nix/store/nb0pij20dhxa0fzxmlbvnzmrihgp5mba-nixos-system-machine-test machine # [ 33.850983] systemd[1]: Stopped target Remote File Systems. machine # [ 33.853553] systemd[1]: Stopped target Local File Systems. machine # [ 34.120745] systemd[1]: Reload requested from client PID 2144 ('.switch-to-conf') (unit backdoor.service)... machine # [ 34.122859] systemd[1]: Reloading... machine # [ 34.436861] systemd[1]: Reloading finished in 312 ms. machine # [ 34.520062] systemd[554]: Reexecution requested from client PID 2213 ('switch-to-confi')... machine # [ 34.521542] systemd[554]: Reexecuting. machine # [ 34.579682] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.690827] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.697215] systemd[554]: Reload requested from client PID 2213 ('switch-to-confi')... machine # [ 34.700666] systemd[554]: Reloading... machine # [ 34.801326] systemd[554]: Reloading finished in 101 ms. machine # [ 34.816179] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.825778] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 34.828127] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 34.830158] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 34.858946] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 34.862418] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 34.866468] systemd[1]: Stopping Reactivate sysinit units... machine # [ 34.867381] systemd[1]: Reached target Reactivate sysinit units. machine # [ 34.869339] systemd[1]: Reloading test.service... machine # [ 34.891848] systemd[1]: Reloaded test.service. machine # [ 34.898951] systemd[1]: Reached target Local File Systems. machine # [ 34.899897] systemd[1]: Reached target Remote File Systems. machine # [ 34.908551] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 34.910157] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 34.910991] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 34.919758] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 34.923505] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 34.925643] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.926986] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.931151] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.933189] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 35.074130] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 35.078609] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 35.080525] systemd[1]: Starting linger-users.service... machine # [ 35.119700] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 35.122750] systemd[1]: Finished linger-users.service. machine # [ 35.378404] nixos[2144]: finished switching to system configuration /nix/store/nb0pij20dhxa0fzxmlbvnzmrihgp5mba-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 1.75 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 35.593451] nixos[2286]: switching to system configuration /nix/store/5wq5ssa3v3cskp0p48jbyiik1xwwwhv5-nixos-system-machine-test machine # [ 35.596437] systemd[1]: Stopped target Remote File Systems. machine # [ 35.599012] systemd[1]: Stopped target Local File Systems. machine # [ 35.872523] systemd[1]: Reload requested from client PID 2286 ('.switch-to-conf') (unit backdoor.service)... machine # [ 35.874641] systemd[1]: Reloading... machine # [ 36.185424] systemd[1]: Reloading finished in 309 ms. machine # [ 36.268425] systemd[554]: Reexecution requested from client PID 2355 ('switch-to-confi')... machine # [ 36.269873] systemd[554]: Reexecuting. machine # [ 36.319356] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.474143] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.481145] systemd[554]: Reload requested from client PID 2355 ('switch-to-confi')... machine # [ 36.484829] systemd[554]: Reloading... machine # [ 36.590079] systemd[554]: Reloading finished in 106 ms. machine # [ 36.604168] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.613350] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 36.615654] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 36.617922] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 36.642685] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 36.646943] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 36.652758] systemd[1]: Stopping Reactivate sysinit units... machine # [ 36.653712] systemd[1]: Reached target Reactivate sysinit units. machine # [ 36.654593] systemd[1]: Reached target Local File Systems. machine # [ 36.655431] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 36.659438] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 36.664274] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 36.665641] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 36.667880] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 36.681349] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.682740] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.683975] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.685485] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 36.686828] systemd[1]: Reached target Remote File Systems. machine # [ 36.834142] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 36.836436] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 36.841108] systemd[1]: Starting linger-users.service... machine # [ 36.879371] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 36.881517] systemd[1]: Finished linger-users.service. machine # [ 37.137604] nixos[2286]: finished switching to system configuration /nix/store/5wq5ssa3v3cskp0p48jbyiik1xwwwhv5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.76 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.28 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 37.592990] nixos[2437]: switching to system configuration /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test machine # [ 37.595771] systemd[1]: Stopped target Remote File Systems. machine # [ 37.599920] systemd[1]: Stopped target Local File Systems. machine # [ 37.602276] systemd[1]: test.service: Deactivated successfully. machine # [ 37.603247] systemd[1]: Stopped test.service. machine # [ 37.850890] systemd[1]: Reload requested from client PID 2437 ('.switch-to-conf') (unit backdoor.service)... machine # [ 37.853066] systemd[1]: Reloading... machine # [ 38.141473] systemd[1]: Reloading finished in 285 ms. machine # [ 38.220786] systemd[554]: Reexecution requested from client PID 2505 ('switch-to-confi')... machine # [ 38.225296] systemd[554]: Reexecuting. machine # [ 38.279439] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.387516] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.394139] systemd[554]: Reload requested from client PID 2505 ('switch-to-confi')... machine # [ 38.396534] systemd[554]: Reloading... machine # [ 38.499055] systemd[554]: Reloading finished in 101 ms. machine # [ 38.516178] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.525482] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 38.527815] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 38.530066] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 38.563739] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 38.567803] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 38.569757] systemd[1]: Stopping Reactivate sysinit units... machine # [ 38.570646] systemd[1]: Reached target Reactivate sysinit units. machine # [ 38.572527] systemd[1]: Reached target Remote File Systems. machine # [ 38.575243] systemd[1]: Reached target Local File Systems. machine # [ 38.579199] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 38.583267] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 38.588255] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 38.589880] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 38.595570] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 38.602267] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.603731] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.610115] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.612144] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 38.764543] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 38.766964] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.771641] systemd[1]: Starting linger-users.service... machine # [ 38.812345] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 38.815366] systemd[1]: Finished linger-users.service. machine # [ 39.069635] nixos[2437]: finished switching to system configuration /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.65 seconds) machine: must succeed: /nix/store/cxknny9xdwf51j3gly0lk0r0ivfr4z5g-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 39.285564] nixos[2577]: switching to system configuration /nix/store/acmmalsdfsc1s68sngibhbwh3jagcx6i-nixos-system-machine-test machine # [ 39.288644] systemd[1]: Stopped target Local File Systems. machine # [ 39.290526] systemd[1]: Stopped target Remote File Systems. machine # [ 39.566158] systemd[1]: Reload requested from client PID 2577 ('.switch-to-conf') (unit backdoor.service)... machine # [ 39.568373] systemd[1]: Reloading... machine # [ 39.897775] systemd[1]: Reloading finished in 327 ms. machine # [ 40.041726] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 40.045934] systemd[554]: Reexecution requested from client PID 2646 ('switch-to-confi')... machine # [ 40.047470] systemd[554]: Reexecuting. machine # [ 40.103977] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.222303] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.229366] systemd[554]: Reload requested from client PID 2646 ('switch-to-confi')... machine # [ 40.233550] systemd[554]: Reloading... machine # [ 40.341543] systemd[554]: Reloading finished in 109 ms. machine # [ 40.356478] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.370435] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 40.374397] systemd[1]: Stopping Reactivate sysinit units... machine # [ 40.375484] systemd[1]: Reached target Reactivate sysinit units. machine # [ 40.383510] systemd[1]: Reached target Local File Systems. machine # [ 40.388548] systemd[1]: Reached target Remote File Systems. machine # [ 40.389674] systemd[1]: Starting linger-users.service... machine # [ 40.408201] systemd[1]: Starting test.service... machine # [ 40.409465] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 40.417177] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 40.428852] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 40.430392] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 40.434915] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 40.443520] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.449859] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.458094] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.467116] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 40.481993] systemd[1]: Finished test.service. machine # [ 40.520630] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 40.524207] systemd[1]: Finished linger-users.service. machine # [ 40.652877] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 40.655770] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 40.912300] nixos[2577]: finished switching to system configuration /nix/store/acmmalsdfsc1s68sngibhbwh3jagcx6i-nixos-system-machine-test machine: (finished: must succeed: /nix/store/cxknny9xdwf51j3gly0lk0r0ivfr4z5g-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.84 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/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 41.175164] nixos[2726]: switching to system configuration /nix/store/s0w2dcbh0kzf92dmfvmx1mv9dkl406mq-nixos-system-machine-test machine # [ 41.178117] systemd[1]: Stopped target Local File Systems. machine # [ 41.181132] systemd[1]: test.service: Deactivated successfully. machine # [ 41.182113] systemd[1]: Stopped test.service. machine # [ 41.183507] systemd[1]: Stopped target Remote File Systems. machine # [ 41.486445] systemd[1]: Reload requested from client PID 2726 ('.switch-to-conf') (unit backdoor.service)... machine # [ 41.488669] systemd[1]: Reloading... machine # [ 41.849880] systemd[1]: Reloading finished in 359 ms. machine # [ 41.929856] systemd[554]: Reexecution requested from client PID 2795 ('switch-to-confi')... machine # [ 41.931342] systemd[554]: Reexecuting. machine # [ 41.991524] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.108604] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.115500] systemd[554]: Reload requested from client PID 2795 ('switch-to-confi')... machine # [ 42.119008] systemd[554]: Reloading... machine # [ 42.224166] systemd[554]: Reloading finished in 106 ms. machine # [ 42.240178] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.250323] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 42.284613] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 42.289571] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 42.290691] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 42.293009] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 42.300405] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 42.302489] systemd[1]: Stopping Reactivate sysinit units... machine # [ 42.306521] systemd[1]: Reached target Reactivate sysinit units. machine # [ 42.309587] systemd[1]: Reached target Local File Systems. machine # [ 42.311608] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 42.320206] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 42.321205] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 42.322530] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 42.342990] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 42.347366] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.353969] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.355341] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.364443] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 42.365916] systemd[1]: Reached target Remote File Systems. machine # [ 42.373424] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 42.533985] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 42.538753] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 42.542568] systemd[1]: Starting linger-users.service... machine # [ 42.546513] systemd[1]: Started test.service. machine # [ 42.583562] systemd[1]: test.service: Deactivated successfully. machine # [ 42.606165] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 42.608188] systemd[1]: Finished linger-users.service. machine # [ 42.866129] nixos[2726]: finished switching to system configuration /nix/store/s0w2dcbh0kzf92dmfvmx1mv9dkl406mq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.91 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 43.137220] nixos[2871]: switching to system configuration /nix/store/jn8yggy7p16al6p9yy4c1lf8s7cpp4k6-nixos-system-machine-test machine # [ 43.139732] systemd[1]: Stopped target Local File Systems. machine # [ 43.142416] systemd[1]: Stopped target Remote File Systems. machine # [ 43.421770] systemd[1]: Reload requested from client PID 2871 ('.switch-to-conf') (unit backdoor.service)... machine # [ 43.423865] systemd[1]: Reloading... machine # [ 43.749644] systemd[1]: Reloading finished in 323 ms. machine # [ 43.831580] systemd[554]: Reexecution requested from client PID 2941 ('switch-to-confi')... machine # [ 43.834220] systemd[554]: Reexecuting. machine # [ 43.895829] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.008564] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.015831] systemd[554]: Reload requested from client PID 2941 ('switch-to-confi')... machine # [ 44.019296] systemd[554]: Reloading... machine # [ 44.121313] systemd[554]: Reloading finished in 102 ms. machine # [ 44.137910] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.147806] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 44.150302] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 44.152492] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 44.182990] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 44.187401] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 44.188884] systemd[1]: Stopping Reactivate sysinit units... machine # [ 44.189738] systemd[1]: Reached target Reactivate sysinit units. machine # [ 44.192556] systemd[1]: Reached target Local File Systems. machine # [ 44.196768] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 44.208544] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 44.209522] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 44.210799] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 44.218687] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 44.222394] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.223779] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.225830] systemd[1]: Reached target Remote File Systems. machine # [ 44.226728] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.230450] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 44.374746] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 44.379664] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 44.383192] systemd[1]: Starting escaped\x2ddash.service... machine # [ 44.386294] systemd[1]: Starting linger-users.service... machine # [ 44.423380] systemd[1]: Finished escaped\x2ddash.service. machine # [ 44.440913] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 44.443950] systemd[1]: Finished linger-users.service. machine # [ 44.700661] nixos[2871]: finished switching to system configuration /nix/store/jn8yggy7p16al6p9yy4c1lf8s7cpp4k6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 1.83 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 44.940605] nixos[3014]: switching to system configuration /nix/store/fv1lh96gr0sqns33q4zca6hjlhldkqmp-nixos-system-machine-test machine # [ 44.943653] systemd[1]: Stopped target Remote File Systems. machine # [ 44.947876] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 44.950405] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 44.951291] systemd[1]: Stopped target Local File Systems. machine # [ 45.225210] systemd[1]: Reload requested from client PID 3014 ('.switch-to-conf') (unit backdoor.service)... machine # [ 45.227228] systemd[1]: Reloading... machine # [ 45.534361] systemd[1]: Reloading finished in 305 ms. machine # [ 45.620410] systemd[554]: Reexecution requested from client PID 3083 ('switch-to-confi')... machine # [ 45.624269] systemd[554]: Reexecuting. machine # [ 45.675042] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.785756] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.792634] systemd[554]: Reload requested from client PID 3083 ('switch-to-confi')... machine # [ 45.796116] systemd[554]: Reloading... machine # [ 45.899580] systemd[554]: Reloading finished in 104 ms. machine # [ 45.916168] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.925678] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 45.928118] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 45.930393] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 45.959016] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 45.962858] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 45.964896] systemd[1]: Stopping Reactivate sysinit units... machine # [ 45.965840] systemd[1]: Reached target Reactivate sysinit units. machine # [ 45.970455] systemd[1]: Starting escaped\x2ddash.service... machine # [ 45.975384] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.980562] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 45.986120] systemd[1]: Reached target Remote File Systems. machine # [ 45.988953] systemd[1]: Starting linger-users.service... machine # [ 45.999232] systemd[1]: Reached target Local File Systems. machine # [ 46.003018] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 46.012656] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 46.013733] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 46.024122] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 46.026685] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 46.039627] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.046800] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.051184] systemd[1]: Finished escaped\x2ddash.service. machine # [ 46.090980] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 46.093829] systemd[1]: Finished linger-users.service. machine # [ 46.221173] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 46.224681] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 46.478706] nixos[3014]: finished switching to system configuration /nix/store/fv1lh96gr0sqns33q4zca6hjlhldkqmp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 1.78 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 46.729167] nixos[3156]: switching to system configuration /nix/store/ghw31aqrcmxnhil608by94k7d614k5rc-nixos-system-machine-test machine # [ 46.732353] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 46.733500] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 46.735271] systemd[1]: Stopped target Local File Systems. machine # [ 46.737023] systemd[1]: Stopped target Remote File Systems. machine # [ 47.022619] systemd[1]: Reload requested from client PID 3156 ('.switch-to-conf') (unit backdoor.service)... machine # [ 47.024836] systemd[1]: Reloading... machine # [ 47.337268] systemd[1]: Reloading finished in 310 ms. machine # [ 47.423310] systemd[554]: Reexecution requested from client PID 3225 ('switch-to-confi')... machine # [ 47.425593] systemd[554]: Reexecuting. machine # [ 47.471499] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.577364] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.584461] systemd[554]: Reload requested from client PID 3225 ('switch-to-confi')... machine # [ 47.588181] systemd[554]: Reloading... machine # [ 47.692557] systemd[554]: Reloading finished in 105 ms. machine # [ 47.710183] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.717721] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 47.720143] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 47.722467] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 47.755843] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 47.759999] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 47.763683] systemd[1]: Stopping Reactivate sysinit units... machine # [ 47.766165] systemd[1]: Reached target Reactivate sysinit units. machine # [ 47.767141] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.770366] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 47.776401] systemd[1]: Reached target Remote File Systems. machine # [ 47.777403] systemd[1]: Reached target Local File Systems. machine # [ 47.778269] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 47.782555] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 47.783544] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 47.792685] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 47.795258] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 47.801513] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.803053] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.950721] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 47.955611] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 47.959163] systemd[1]: Starting -.service... machine # [ 47.964189] systemd[1]: Starting linger-users.service... machine # [ 48.005017] systemd[1]: Finished -.service. machine # [ 48.031148] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 48.034698] systemd[1]: Finished linger-users.service. machine # [ 48.292645] nixos[3156]: finished switching to system configuration /nix/store/ghw31aqrcmxnhil608by94k7d614k5rc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 48.545370] nixos[3298]: switching to system configuration /nix/store/4cv3n57mpd2xg7v0s91cxidiabfkd8al-nixos-system-machine-test machine # [ 48.548074] systemd[1]: Stopped target Remote File Systems. machine # [ 48.551108] systemd[1]: Stopped target Local File Systems. machine # [ 48.850414] systemd[1]: Reload requested from client PID 3298 ('.switch-to-conf') (unit backdoor.service)... machine # [ 48.852636] systemd[1]: Reloading... machine # [ 49.175957] systemd[1]: Reloading finished in 321 ms. machine # [ 49.265997] systemd[554]: Reexecution requested from client PID 3367 ('switch-to-confi')... machine # [ 49.267533] systemd[554]: Reexecuting. machine # [ 49.307285] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.430990] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.439627] systemd[554]: Reload requested from client PID 3367 ('switch-to-confi')... machine # [ 49.443444] systemd[554]: Reloading... machine # [ 49.551380] systemd[554]: Reloading finished in 109 ms. machine # [ 49.564165] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.573813] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 49.576349] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 49.578674] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 49.612410] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 49.616611] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 49.620443] systemd[1]: Stopping Reactivate sysinit units... machine # [ 49.621504] systemd[1]: Reached target Reactivate sysinit units. machine # [ 49.624487] systemd[1]: Reloading -.service... machine # [ 49.650162] systemd[1]: Reloaded -.service. machine # [ 49.653187] systemd[1]: Reached target Local File Systems. machine # [ 49.659150] systemd[1]: Reached target Remote File Systems. machine # [ 49.661866] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.664402] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 49.667932] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 49.676249] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 49.677241] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 49.678536] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 49.689596] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 49.691367] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.693120] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.893616] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 49.898555] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 49.901204] systemd[1]: Starting linger-users.service... machine # [ 49.952327] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 49.955720] systemd[1]: Finished linger-users.service. machine # [ 50.211064] nixos[3298]: finished switching to system configuration /nix/store/4cv3n57mpd2xg7v0s91cxidiabfkd8al-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.92 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 50.421864] nixos[3440]: switching to system configuration /nix/store/apxc3zffmrlddz57r02zwk2vwy9y2i57-nixos-system-machine-test machine # [ 50.425379] systemd[1]: Stopped target Local File Systems. machine # [ 50.427608] systemd[1]: Stopped target Remote File Systems. machine # [ 50.430895] systemd[1]: -.service: Deactivated successfully. machine # [ 50.431848] systemd[1]: Stopped -.service. machine # [ 50.717893] systemd[1]: Reload requested from client PID 3440 ('.switch-to-conf') (unit backdoor.service)... machine # [ 50.719911] systemd[1]: Reloading... machine # [ 51.037161] systemd[1]: Reloading finished in 315 ms. machine # [ 51.121885] systemd[554]: Reexecution requested from client PID 3509 ('switch-to-confi')... machine # [ 51.123433] systemd[554]: Reexecuting. machine # [ 51.184050] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.300571] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.307703] systemd[554]: Reload requested from client PID 3509 ('switch-to-confi')... machine # [ 51.310407] systemd[554]: Reloading... machine # [ 51.417594] systemd[554]: Reloading finished in 106 ms. machine # [ 51.432216] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.443168] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 51.444497] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 51.447572] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 51.485820] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 51.491768] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 51.495793] systemd[1]: Stopping Reactivate sysinit units... machine # [ 51.500776] systemd[1]: Reached target Reactivate sysinit units. machine # [ 51.501877] systemd[1]: Reached target Local File Systems. machine # [ 51.504444] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.506094] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 51.512913] systemd[1]: Reached target Remote File Systems. machine # [ 51.516224] systemd[1]: Starting linger-users.service... machine # [ 51.522396] systemd[1]: Starting required-service.service... machine # [ 51.529925] systemd[1]: Starting test-service.service... machine # [ 51.548296] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 51.558719] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 51.559767] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 51.567280] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 51.579551] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 51.589038] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.601142] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.627502] systemd[1]: Finished test-service.service. machine # [ 51.630214] systemd[1]: Finished required-service.service. machine # [ 51.667680] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 51.672582] systemd[1]: Finished linger-users.service. machine # [ 51.795158] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 51.798719] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 52.054692] nixos[3440]: finished switching to system configuration /nix/store/apxc3zffmrlddz57r02zwk2vwy9y2i57-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.84 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 52.286890] nixos[3584]: switching to system configuration /nix/store/f4vjlrps8w7rf1sijx0v4mzdh6wcjqns-nixos-system-machine-test machine # [ 52.289697] systemd[1]: required-service.service: Deactivated successfully. machine # [ 52.294256] systemd[1]: Stopped required-service.service. machine # [ 52.295197] systemd[1]: test-service.service: Deactivated successfully. machine # [ 52.296674] systemd[1]: Stopped test-service.service. machine # [ 52.300057] systemd[1]: Stopped target Local File Systems. machine # [ 52.300983] systemd[1]: Stopped target Remote File Systems. machine # [ 52.582877] systemd[1]: Reload requested from client PID 3584 ('.switch-to-conf') (unit backdoor.service)... machine # [ 52.585257] systemd[1]: Reloading... machine # [ 52.902317] systemd[1]: Reloading finished in 315 ms. machine # [ 52.990888] systemd[554]: Reexecution requested from client PID 3652 ('switch-to-confi')... machine # [ 52.994824] systemd[554]: Reexecuting. machine # [ 53.044146] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.161631] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.169057] systemd[554]: Reload requested from client PID 3652 ('switch-to-confi')... machine # [ 53.173274] systemd[554]: Reloading... machine # [ 53.281590] systemd[554]: Reloading finished in 109 ms. machine # [ 53.296179] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.306152] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 53.308736] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 53.311083] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 53.344743] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 53.349088] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 53.351161] systemd[1]: Stopping Reactivate sysinit units... machine # [ 53.352760] systemd[1]: Reached target Reactivate sysinit units. machine # [ 53.356863] systemd[1]: Reached target Remote File Systems. machine # [ 53.362618] systemd[1]: Starting linger-users.service... machine # [ 53.369443] systemd[1]: Starting required-service.service... machine # [ 53.370399] systemd[1]: Starting test-service.service... machine # [ 53.388976] systemd[1]: Reached target Local File Systems. machine # [ 53.389969] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 53.391541] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 53.403020] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 53.418402] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 53.434566] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 53.445639] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.455911] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.463767] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.474765] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 53.478771] systemd[1]: Finished test-service.service. machine # [ 53.479631] systemd[1]: Finished required-service.service. machine # [ 53.509429] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 53.512710] systemd[1]: Finished linger-users.service. machine # [ 53.637656] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 53.641122] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 53.898141] nixos[3584]: finished switching to system configuration /nix/store/f4vjlrps8w7rf1sijx0v4mzdh6wcjqns-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.84 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 54.118465] nixos[3728]: switching to system configuration /nix/store/5bkxpjaciq8y1mqp9ikfkcjw3xaq84rs-nixos-system-machine-test machine # [ 54.121215] systemd[1]: required-service.service: Deactivated successfully. machine # [ 54.125939] systemd[1]: Stopped required-service.service. machine # [ 54.126857] systemd[1]: test-service.service: Deactivated successfully. machine # [ 54.127811] systemd[1]: Stopped test-service.service. machine # [ 54.129010] systemd[1]: Stopped target Remote File Systems. machine # [ 54.129841] systemd[1]: Stopped target Local File Systems. machine # [ 54.391190] systemd[1]: Reload requested from client PID 3728 ('.switch-to-conf') (unit backdoor.service)... machine # [ 54.393541] systemd[1]: Reloading... machine # [ 54.788155] systemd[1]: Reloading finished in 393 ms. machine # [ 54.874144] systemd[554]: Reexecution requested from client PID 3797 ('switch-to-confi')... machine # [ 54.875574] systemd[554]: Reexecuting. machine # [ 54.935377] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.045945] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.052665] systemd[554]: Reload requested from client PID 3797 ('switch-to-confi')... machine # [ 55.056204] systemd[554]: Reloading... machine # [ 55.157386] systemd[554]: Reloading finished in 102 ms. machine # [ 55.172154] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.182416] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 55.183475] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 55.186054] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 55.214240] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 55.217955] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 55.219831] systemd[1]: Stopping Reactivate sysinit units... machine # [ 55.222126] systemd[1]: Reached target Reactivate sysinit units. machine # [ 55.226431] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.230032] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 55.231417] systemd[1]: Reached target Remote File Systems. machine # [ 55.236313] systemd[1]: Reached target Local File Systems. machine # [ 55.237201] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 55.246008] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 55.246937] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 55.252353] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 55.254683] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 55.256421] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.257798] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.405844] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 55.410828] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 55.413935] systemd[1]: Starting linger-users.service... machine # [ 55.416693] systemd[1]: Starting required-service.service... machine # [ 55.428110] systemd[1]: Starting test-service.service... machine # [ 55.472583] systemd[1]: Finished required-service.service. machine # [ 55.475036] systemd[1]: Finished test-service.service. machine # [ 55.491938] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 55.494712] systemd[1]: Finished linger-users.service. machine # [ 55.749940] nixos[3728]: finished switching to system configuration /nix/store/5bkxpjaciq8y1mqp9ikfkcjw3xaq84rs-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.85 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 55.963091] nixos[3872]: switching to system configuration /nix/store/qq3gxhbm277ag0zh17s7468m4576bg5y-nixos-system-machine-test machine # [ 55.966258] systemd[1]: Stopped target Local File Systems. machine # [ 55.968579] systemd[1]: Stopped target Remote File Systems. machine # [ 55.973217] systemd[1]: required-service.service: Deactivated successfully. machine # [ 55.974252] systemd[1]: Stopped required-service.service. machine # [ 55.975038] systemd[1]: test-service.service: Deactivated successfully. machine # [ 55.976330] systemd[1]: Stopped test-service.service. machine # [ 56.234615] systemd[1]: Reload requested from client PID 3872 ('.switch-to-conf') (unit backdoor.service)... machine # [ 56.236698] systemd[1]: Reloading... machine # [ 56.536626] systemd[1]: Reloading finished in 298 ms. machine # [ 56.619555] systemd[554]: Reexecution requested from client PID 3941 ('switch-to-confi')... machine # [ 56.622749] systemd[554]: Reexecuting. machine # [ 56.687617] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.804236] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.810505] systemd[554]: Reload requested from client PID 3941 ('switch-to-confi')... machine # [ 56.814195] systemd[554]: Reloading... machine # [ 56.913273] systemd[554]: Reloading finished in 99 ms. machine # [ 56.928173] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.938073] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 56.940435] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 56.942617] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 56.974833] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 56.979109] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 56.985271] systemd[1]: Stopping Reactivate sysinit units... machine # [ 56.986186] systemd[1]: Reached target Reactivate sysinit units. machine # [ 56.987053] systemd[1]: Reached target Local File Systems. machine # [ 56.987861] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 57.004512] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 57.005598] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 57.006880] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 57.013500] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 57.015218] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.017863] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.019171] systemd[1]: Reached target Remote File Systems. machine # [ 57.020367] systemd[1]: Created slice Slice /system/instantiated. machine # [ 57.022360] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.024369] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 57.169495] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 57.171313] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 57.175971] systemd[1]: Starting instantiated@one.service... machine # [ 57.180786] systemd[1]: Starting instantiated@two.service... machine # [ 57.188396] systemd[1]: Starting linger-users.service... machine # [ 57.234974] systemd[1]: Finished instantiated@one.service. machine # [ 57.238180] systemd[1]: Finished instantiated@two.service. machine # [ 57.255306] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 57.258260] systemd[1]: Finished linger-users.service. machine # [ 57.514260] nixos[3872]: finished switching to system configuration /nix/store/qq3gxhbm277ag0zh17s7468m4576bg5y-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.76 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 57.737741] nixos[4016]: switching to system configuration /nix/store/yxzl7si1xazgrrlm7zmgbxnrc4r4b4mk-nixos-system-machine-test machine # [ 57.742225] systemd[1]: Stopped target Local File Systems. machine # [ 57.744237] systemd[1]: Stopped target Remote File Systems. machine # [ 57.745206] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 57.746235] systemd[1]: Stopped instantiated@one.service. machine # [ 57.747064] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 57.749499] systemd[1]: Stopped instantiated@two.service. machine # [ 58.032930] systemd[1]: Reload requested from client PID 4016 ('.switch-to-conf') (unit backdoor.service)... machine # [ 58.035133] systemd[1]: Reloading... machine # [ 58.343243] systemd[1]: Reloading finished in 306 ms. machine # [ 58.435616] systemd[554]: Reexecution requested from client PID 4085 ('switch-to-confi')... machine # [ 58.438097] systemd[554]: Reexecuting. machine # [ 58.495603] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.609382] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.616103] systemd[554]: Reload requested from client PID 4085 ('switch-to-confi')... machine # [ 58.617539] systemd[554]: Reloading... machine # [ 58.725133] systemd[554]: Reloading finished in 105 ms. machine # [ 58.741907] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.749667] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 58.752051] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 58.754337] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 58.787107] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 58.790925] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 58.794063] systemd[1]: Stopping Reactivate sysinit units... machine # [ 58.794985] systemd[1]: Reached target Reactivate sysinit units. machine # [ 58.796975] systemd[1]: Reached target Remote File Systems. machine # [ 58.803659] systemd[1]: Starting instantiated@one.service... machine # [ 58.808176] systemd[1]: Starting instantiated@two.service... machine # [ 58.820267] systemd[1]: Starting linger-users.service... machine # [ 58.821260] systemd[1]: Reached target Local File Systems. machine # [ 58.833041] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.834512] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 58.839889] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 58.850456] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 58.851380] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 58.862256] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 58.874498] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 58.882298] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.883662] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.900244] systemd[1]: Finished instantiated@two.service. machine # [ 58.901307] systemd[1]: Finished instantiated@one.service. machine # [ 58.935600] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 58.938897] systemd[1]: Finished linger-users.service. machine # [ 59.069383] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 59.072657] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 59.327077] nixos[4016]: finished switching to system configuration /nix/store/yxzl7si1xazgrrlm7zmgbxnrc4r4b4mk-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.81 seconds) (finished: subtest: services, in 38.38 seconds) subtest: failing units machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 59.554732] nixos[4160]: switching to system configuration /nix/store/s3b407h36nxah08jmy7rz1m5vjysag6i-nixos-system-machine-test machine # [ 59.558105] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 59.562515] systemd[1]: Stopped instantiated@two.service. machine # [ 59.563586] systemd[1]: Stopped target Local File Systems. machine # [ 59.567076] systemd[1]: Stopped target Remote File Systems. machine # [ 59.569548] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 59.570809] systemd[1]: Stopped instantiated@one.service. machine # [ 59.838497] systemd[1]: Reload requested from client PID 4160 ('.switch-to-conf') (unit backdoor.service)... machine # [ 59.840943] systemd[1]: Reloading... machine # [ 60.142177] systemd[1]: Reloading finished in 298 ms. machine # [ 60.235659] systemd[554]: Reexecution requested from client PID 4229 ('switch-to-confi')... machine # [ 60.240929] systemd[554]: Reexecuting. machine # [ 60.300548] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.421690] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.429352] systemd[554]: Reload requested from client PID 4229 ('switch-to-confi')... machine # [ 60.432203] systemd[554]: Reloading... machine # [ 60.549417] systemd[554]: Reloading finished in 115 ms. machine # [ 60.564208] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.576100] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 60.577367] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 60.580271] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 60.613081] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 60.617183] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 60.620676] systemd[1]: Stopping Reactivate sysinit units... machine # [ 60.621648] systemd[1]: Reached target Reactivate sysinit units. machine # [ 60.622550] systemd[1]: Reached target Remote File Systems. machine # [ 60.626091] systemd[1]: Reached target Local File Systems. machine # [ 60.629849] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 60.634353] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 60.635345] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 60.646275] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 60.649104] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 60.650766] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.655396] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.659343] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.663665] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 60.854003] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 60.856376] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 60.864669] systemd[1]: Starting linger-users.service... machine # [ 60.868600] systemd[1]: Starting test.service... machine # [ 60.915805] systemd[1]: Finished test.service. machine # [ 60.939280] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 60.941623] systemd[1]: Finished linger-users.service. machine # [ 61.200128] nixos[4160]: finished switching to system configuration /nix/store/s3b407h36nxah08jmy7rz1m5vjysag6i-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.87 seconds) machine: must fail: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 61.455754] nixos[4302]: switching to system configuration /nix/store/kwyklglkx3w1bm4dlcvmi3in37q9fasm-nixos-system-machine-test machine # [ 61.458982] systemd[1]: Stopped target Remote File Systems. machine # [ 61.462861] systemd[1]: Stopped target Local File Systems. machine # [ 61.463763] systemd[1]: test.service: Deactivated successfully. machine # [ 61.465425] systemd[1]: Stopped test.service. machine # [ 61.760348] systemd[1]: Reload requested from client PID 4302 ('.switch-to-conf') (unit backdoor.service)... machine # [ 61.762534] systemd[1]: Reloading... machine # [ 62.098217] systemd[1]: Reloading finished in 334 ms. machine # [ 62.183875] systemd[554]: Reexecution requested from client PID 4371 ('switch-to-confi')... machine # [ 62.187963] systemd[554]: Reexecuting. machine # [ 62.239747] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.356179] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.362837] systemd[554]: Reload requested from client PID 4371 ('switch-to-confi')... machine # [ 62.365404] systemd[554]: Reloading... machine # [ 62.476731] systemd[554]: Reloading finished in 110 ms. machine # [ 62.492230] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.503708] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 62.506902] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 62.509383] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 62.544755] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 62.550222] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 62.555413] systemd[1]: Stopping Reactivate sysinit units... machine # [ 62.557225] systemd[1]: Reached target Reactivate sysinit units. machine # [ 62.563633] systemd[1]: Starting test.service... machine # [ 62.571516] systemd[1]: Reached target Remote File Systems. machine # [ 62.577258] systemd[1]: Starting linger-users.service... machine # [ 62.591692] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.595578] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 62.608361] systemd[1]: Reached target Local File Systems. machine # [ 62.609627] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 62.611530] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 62.630608] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 62.634418] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 62.643491] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 62.655523] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.661190] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.667685] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 62.672520] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 62.674062] systemd[1]: Failed to start test.service. machine # [ 62.699654] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 62.703008] systemd[1]: Finished linger-users.service. machine # [ 62.861305] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 62.864257] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 63.147536] nixos[4302]: switching to system configuration /nix/store/kwyklglkx3w1bm4dlcvmi3in37q9fasm-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.95 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 63.370466] nixos[4445]: switching to system configuration /nix/store/cshbpzc4idm9i7nfyxqfrzrdlc89ghiz-nixos-system-machine-test machine # [ 63.373011] systemd[1]: Stopped target Local File Systems. machine # [ 63.375447] systemd[1]: Stopped target Remote File Systems. machine # [ 63.656456] systemd[1]: Reload requested from client PID 4445 ('.switch-to-conf') (unit backdoor.service)... machine # [ 63.658623] systemd[1]: Reloading... machine # [ 63.985850] systemd[1]: Reloading finished in 325 ms. machine # [ 64.088560] systemd[554]: Reexecution requested from client PID 4513 ('switch-to-confi')... machine # [ 64.093317] systemd[554]: Reexecuting. machine # [ 64.148159] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.261261] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.267921] systemd[554]: Reload requested from client PID 4513 ('switch-to-confi')... machine # [ 64.270720] systemd[554]: Reloading... machine # [ 64.377869] systemd[554]: Reloading finished in 106 ms. machine # [ 64.392168] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.401848] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 64.404385] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 64.406675] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 64.440242] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 64.444424] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 64.447534] systemd[1]: Stopping Reactivate sysinit units... machine # [ 64.449681] systemd[1]: Reached target Reactivate sysinit units. machine # [ 64.450642] systemd[1]: Reached target Local File Systems. machine # [ 64.454533] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 64.461033] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 64.461952] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 64.463243] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 64.476658] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 64.478385] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.479722] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.483611] systemd[1]: Reached target Remote File Systems. machine # [ 64.484964] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.486381] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 64.637799] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 64.642836] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 64.646572] systemd[1]: Started autorestart.service. machine # [ 64.650490] systemd[1]: Starting linger-users.service... machine # [ 64.683482] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 64.703642] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 64.707042] systemd[1]: Finished linger-users.service. machine # [ 64.962989] nixos[4445]: finished switching to system configuration /nix/store/cshbpzc4idm9i7nfyxqfrzrdlc89ghiz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine # [ 65.004163] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 65.195324] nixos[4592]: switching to system configuration /nix/store/cshbpzc4idm9i7nfyxqfrzrdlc89ghiz-nixos-system-machine-test machine # [ 65.197995] systemd[1]: Stopped target Local File Systems. machine # [ 65.200379] systemd[1]: Stopped target Remote File Systems. machine # [ 65.463946] systemd[1]: Reload requested from client PID 4592 ('.switch-to-conf') (unit backdoor.service)... machine # [ 65.466260] systemd[1]: Reloading... machine # [ 65.826077] systemd[1]: Reloading finished in 358 ms. machine # [ 65.914295] systemd[554]: Reexecution requested from client PID 4661 ('switch-to-confi')... machine # [ 65.915892] systemd[554]: Reexecuting. machine # [ 65.975441] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.088490] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.095259] systemd[554]: Reload requested from client PID 4661 ('switch-to-confi')... machine # [ 66.097604] systemd[554]: Reloading... machine # [ 66.201921] systemd[554]: Reloading finished in 103 ms. machine # [ 66.216178] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.225676] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 66.227992] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 66.230188] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 66.260962] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 66.265744] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 66.270498] systemd[1]: Stopping Reactivate sysinit units... machine # [ 66.271566] systemd[1]: Reached target Reactivate sysinit units. machine # [ 66.278774] systemd[1]: Reached target Local File Systems. machine # [ 66.284240] systemd[1]: Reached target Remote File Systems. machine # [ 66.285328] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 66.296549] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 66.297848] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 66.299394] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 66.308564] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 66.310637] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.312170] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.313593] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.314998] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 66.473015] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 66.478069] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 66.482338] systemd[1]: Started autorestart.service. machine # [ 66.485224] systemd[1]: Starting linger-users.service... machine # [ 66.523563] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 66.545465] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 66.548540] systemd[1]: Finished linger-users.service. machine # [ 66.806231] nixos[4592]: finished switching to system configuration /nix/store/cshbpzc4idm9i7nfyxqfrzrdlc89ghiz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.80 seconds) machine # [ 66.851755] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 67.060928] nixos[4739]: switching to system configuration /nix/store/lfz64ga1bg38v7yzp7djaniynxy4p615-nixos-system-machine-test machine # [ 67.063720] systemd[1]: Stopped target Remote File Systems. machine # [ 67.065495] systemd[1]: Stopped target Local File Systems. machine # [ 67.332644] systemd[1]: Reload requested from client PID 4739 ('.switch-to-conf') (unit backdoor.service)... machine # [ 67.334949] systemd[1]: Reloading... machine # [ 67.667521] systemd[1]: Reloading finished in 331 ms. machine # [ 67.752436] systemd[554]: Reexecution requested from client PID 4808 ('switch-to-confi')... machine # [ 67.756792] systemd[554]: Reexecuting. machine # [ 67.816124] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.933517] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.940170] systemd[554]: Reload requested from client PID 4808 ('switch-to-confi')... machine # [ 67.944085] systemd[554]: Reloading... machine # [ 68.049451] systemd[554]: Reloading finished in 106 ms. machine # [ 68.066798] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.077610] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 68.080137] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 68.082747] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 68.116918] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 68.120731] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 68.123387] systemd[1]: Stopping Reactivate sysinit units... machine # [ 68.126317] systemd[1]: Reached target Reactivate sysinit units. machine # [ 68.129818] systemd[1]: Reached target Remote File Systems. machine # [ 68.132264] systemd[1]: Started autorestart.service. machine # [ 68.136286] systemd[1]: Starting linger-users.service... machine # [ 68.148190] systemd[1]: Reached target Local File Systems. machine # [ 68.153029] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 68.161364] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 68.162347] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 68.163650] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 68.188157] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 68.190080] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.191413] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.206278] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.207748] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 68.220178] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 68.221824] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 68.248922] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 68.250719] systemd[1]: Finished linger-users.service. machine # [ 68.387496] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 68.391061] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 68.670293] nixos[4739]: switching to system configuration /nix/store/lfz64ga1bg38v7yzp7djaniynxy4p615-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.82 seconds) (finished: subtest: failing units, in 9.34 seconds) subtest: unit file parser machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 68.869511] nixos[4882]: switching to system configuration /nix/store/r3yvszdzilbq30gd4r6y9cy3afzfkb29-nixos-system-machine-test machine # [ 68.872358] systemd[1]: Stopped autorestart.service. machine # [ 68.876139] systemd[1]: Stopped target Remote File Systems. machine # [ 68.877151] systemd[1]: Stopped target Local File Systems. machine # [ 69.133897] systemd[1]: Reload requested from client PID 4882 ('.switch-to-conf') (unit backdoor.service)... machine # [ 69.136330] systemd[1]: Reloading... machine # [ 69.439408] systemd[1]: Reloading finished in 301 ms. machine # [ 69.528131] systemd[554]: Reexecution requested from client PID 4951 ('switch-to-confi')... machine # [ 69.529901] systemd[554]: Reexecuting. machine # [ 69.579494] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.689900] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.696740] systemd[554]: Reload requested from client PID 4951 ('switch-to-confi')... machine # [ 69.700075] systemd[554]: Reloading... machine # [ 69.805772] systemd[554]: Reloading finished in 106 ms. machine # [ 69.820183] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.829873] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 69.832310] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 69.834621] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 69.868297] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 69.872521] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 69.875337] systemd[1]: Stopping Reactivate sysinit units... machine # [ 69.877809] systemd[1]: Reached target Reactivate sysinit units. machine # [ 69.881264] systemd[1]: Reached target Remote File Systems. machine # [ 69.886004] systemd[1]: Reached target Local File Systems. machine # [ 69.890361] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.891874] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 69.901482] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 69.903147] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 69.907728] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 69.909331] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 69.911632] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 69.914437] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.915871] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.067435] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 70.072491] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.075672] systemd[1]: Starting linger-users.service... machine # [ 70.078275] systemd[1]: Starting test.service... machine # [ 70.115427] systemd[1]: Finished test.service. machine # [ 70.132556] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 70.136116] systemd[1]: Finished linger-users.service. machine # [ 70.391379] nixos[4882]: finished switching to system configuration /nix/store/r3yvszdzilbq30gd4r6y9cy3afzfkb29-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.72 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 70.611759] nixos[5024]: switching to system configuration /nix/store/ljb3ndsaln0gg7rl9vkfkpl0wydfl8s1-nixos-system-machine-test machine # [ 70.614493] systemd[1]: Stopped target Remote File Systems. machine # [ 70.617061] systemd[1]: Stopped target Local File Systems. machine # [ 70.891642] systemd[1]: Reload requested from client PID 5024 ('.switch-to-conf') (unit backdoor.service)... machine # [ 70.893860] systemd[1]: Reloading... machine # [ 71.212814] systemd[1]: Reloading finished in 317 ms. machine # [ 71.302886] systemd[554]: Reexecution requested from client PID 5093 ('switch-to-confi')... machine # [ 71.306855] systemd[554]: Reexecuting. machine # [ 71.367559] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.489677] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.496359] systemd[554]: Reload requested from client PID 5093 ('switch-to-confi')... machine # [ 71.498922] systemd[554]: Reloading... machine # [ 71.608086] systemd[554]: Reloading finished in 107 ms. machine # [ 71.624210] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.637162] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 71.640119] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 71.642792] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 71.678734] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 71.683075] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 71.685032] systemd[1]: Stopping Reactivate sysinit units... machine # [ 71.685963] systemd[1]: Reached target Reactivate sysinit units. machine # [ 71.690325] systemd[1]: test.service: Deactivated successfully. machine # [ 71.691443] systemd[1]: Stopped test.service. machine # [ 71.692816] systemd[1]: Stopping test.service... machine # [ 71.694702] systemd[1]: Starting test.service... machine # [ 71.721911] systemd[1]: Finished test.service. machine # [ 71.727452] systemd[1]: Reached target Local File Systems. machine # [ 71.734851] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 71.744747] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 71.745714] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 71.747028] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 71.756231] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 71.758005] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.759352] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.761525] systemd[1]: Reached target Remote File Systems. machine # [ 71.762455] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.764425] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 71.917462] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 71.922721] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 71.924645] systemd[1]: Starting linger-users.service... machine # [ 71.964800] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 71.967671] systemd[1]: Finished linger-users.service. machine # [ 72.223681] nixos[5024]: finished switching to system configuration /nix/store/ljb3ndsaln0gg7rl9vkfkpl0wydfl8s1-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.83 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 72.446882] nixos[5166]: switching to system configuration /nix/store/8zfrsp3faj6c6c6j10592fsahsaf0fiw-nixos-system-machine-test machine # [ 72.449919] systemd[1]: Stopped target Local File Systems. machine # [ 72.452186] systemd[1]: Stopped target Remote File Systems. machine # [ 72.724404] systemd[1]: Reload requested from client PID 5166 ('.switch-to-conf') (unit backdoor.service)... machine # [ 72.726475] systemd[1]: Reloading... machine # [ 73.035016] systemd[1]: Reloading finished in 307 ms. machine # [ 73.122206] systemd[554]: Reexecution requested from client PID 5235 ('switch-to-confi')... machine # [ 73.125853] systemd[554]: Reexecuting. machine # [ 73.179244] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.295870] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.304178] systemd[554]: Reload requested from client PID 5235 ('switch-to-confi')... machine # [ 73.305728] systemd[554]: Reloading... machine # [ 73.413865] systemd[554]: Reloading finished in 106 ms. machine # [ 73.428191] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.437716] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 73.440131] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 73.442625] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 73.475642] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 73.480917] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 73.481918] systemd[1]: Stopping Reactivate sysinit units... machine # [ 73.482743] systemd[1]: Reached target Reactivate sysinit units. machine # [ 73.485342] systemd[1]: test.service: Deactivated successfully. machine # [ 73.488535] systemd[1]: Stopped test.service. machine # [ 73.489326] systemd[1]: Stopping test.service... machine # [ 73.491188] systemd[1]: Starting test.service... machine # [ 73.518266] systemd[1]: Finished test.service. machine # [ 73.522884] systemd[1]: Reached target Local File Systems. machine # [ 73.527372] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 73.536748] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 73.537704] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 73.538984] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 73.547310] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 73.555095] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.557248] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.560487] systemd[1]: Reached target Remote File Systems. machine # [ 73.561428] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.562755] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 73.706329] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 73.709347] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 73.713614] systemd[1]: Starting linger-users.service... machine # [ 73.751993] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 73.755235] systemd[1]: Finished linger-users.service. machine # [ 74.009617] nixos[5166]: finished switching to system configuration /nix/store/8zfrsp3faj6c6c6j10592fsahsaf0fiw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.78 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 74.219333] nixos[5308]: switching to system configuration /nix/store/r3yvszdzilbq30gd4r6y9cy3afzfkb29-nixos-system-machine-test machine # [ 74.222229] systemd[1]: Stopped target Local File Systems. machine # [ 74.225283] systemd[1]: Stopped target Remote File Systems. machine # [ 74.502868] systemd[1]: Reload requested from client PID 5308 ('.switch-to-conf') (unit backdoor.service)... machine # [ 74.505251] systemd[1]: Reloading... machine # [ 74.823868] systemd[1]: Reloading finished in 317 ms. machine # [ 74.908370] systemd[554]: Reexecution requested from client PID 5377 ('switch-to-confi')... machine # [ 74.912551] systemd[554]: Reexecuting. machine # [ 74.971861] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.087429] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.094956] systemd[554]: Reload requested from client PID 5377 ('switch-to-confi')... machine # [ 75.097972] systemd[554]: Reloading... machine # [ 75.208216] systemd[554]: Reloading finished in 109 ms. machine # [ 75.224224] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.235739] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 75.238341] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 75.240487] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 75.275226] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 75.280164] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 75.284860] systemd[1]: Stopping Reactivate sysinit units... machine # [ 75.285984] systemd[1]: Reached target Reactivate sysinit units. machine # [ 75.287092] systemd[1]: test.service: Deactivated successfully. machine # [ 75.290035] systemd[1]: Stopped test.service. machine # [ 75.290777] systemd[1]: Stopping test.service... machine # [ 75.292874] systemd[1]: Starting test.service... machine # [ 75.318884] systemd[1]: Finished test.service. machine # [ 75.323822] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.331486] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 75.333234] systemd[1]: Reached target Remote File Systems. machine # [ 75.335473] systemd[1]: Starting linger-users.service... machine # [ 75.348663] systemd[1]: Reached target Local File Systems. machine # [ 75.352453] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 75.356798] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 75.357859] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 75.359283] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 75.374839] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 75.382647] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.386343] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.423842] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 75.428222] systemd[1]: Finished linger-users.service. machine # [ 75.561796] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 75.565250] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 75.819521] nixos[5308]: finished switching to system configuration /nix/store/r3yvszdzilbq30gd4r6y9cy3afzfkb29-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 76.046992] nixos[5450]: switching to system configuration /nix/store/jy2ggjzrj4gw3b12q7kr718mv976j6a1-nixos-system-machine-test machine # [ 76.049874] systemd[1]: Stopped target Local File Systems. machine # [ 76.052364] systemd[1]: Stopped target Remote File Systems. machine # [ 76.329426] systemd[1]: Reload requested from client PID 5450 ('.switch-to-conf') (unit backdoor.service)... machine # [ 76.331451] systemd[1]: Reloading... machine # [ 76.647592] systemd[1]: Reloading finished in 314 ms. machine # [ 76.737688] systemd[554]: Reexecution requested from client PID 5519 ('switch-to-confi')... machine # [ 76.742189] systemd[554]: Reexecuting. machine # [ 76.799889] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.921275] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.928263] systemd[554]: Reload requested from client PID 5519 ('switch-to-confi')... machine # [ 76.931005] systemd[554]: Reloading... machine # [ 77.039221] systemd[554]: Reloading finished in 107 ms. machine # [ 77.057760] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.065516] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 77.067872] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 77.070271] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 77.099823] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 77.103929] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 77.106343] systemd[1]: Stopping Reactivate sysinit units... machine # [ 77.107295] systemd[1]: Reached target Reactivate sysinit units. machine # [ 77.113456] systemd[1]: Reached target Remote File Systems. machine # [ 77.114402] systemd[1]: Starting linger-users.service... machine # [ 77.124440] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.127120] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 77.133186] systemd[1]: Reached target Local File Systems. machine # [ 77.134097] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 77.144418] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 77.145679] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 77.146985] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 77.163602] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 77.165909] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.167583] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.206946] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 77.211495] systemd[1]: Finished linger-users.service. machine # [ 77.351927] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 77.355597] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 77.610147] nixos[5450]: finished switching to system configuration /nix/store/jy2ggjzrj4gw3b12q7kr718mv976j6a1-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.79 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 77.833500] nixos[5590]: switching to system configuration /nix/store/xi0mwqlv5c4qvx4m5gg9czcgyaw5igss-nixos-system-machine-test machine # [ 77.836344] systemd[1]: Stopped target Local File Systems. machine # [ 77.838954] systemd[1]: Stopped target Remote File Systems. machine # [ 78.124839] systemd[1]: Reload requested from client PID 5590 ('.switch-to-conf') (unit backdoor.service)... machine # [ 78.126926] systemd[1]: Reloading... machine # [ 78.458299] systemd[1]: Reloading finished in 329 ms. machine # [ 78.548423] systemd[554]: Reexecution requested from client PID 5659 ('switch-to-confi')... machine # [ 78.552109] systemd[554]: Reexecuting. machine # [ 78.607787] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.719704] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.726614] systemd[554]: Reload requested from client PID 5659 ('switch-to-confi')... machine # [ 78.729318] systemd[554]: Reloading... machine # [ 78.839759] systemd[554]: Reloading finished in 109 ms. machine # [ 78.856184] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.865684] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 78.868138] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 78.870543] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 78.905310] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 78.909979] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 78.915252] systemd[1]: Stopping Reactivate sysinit units... machine # [ 78.916812] systemd[1]: Reached target Reactivate sysinit units. machine # [ 78.917717] systemd[1]: test.service: Deactivated successfully. machine # [ 78.918577] systemd[1]: Stopped test.service. machine # [ 78.919242] systemd[1]: Stopping test.service... machine # [ 78.921206] systemd[1]: Starting test.service... machine # [ 78.947187] systemd[1]: Finished test.service. machine # [ 78.952160] systemd[1]: Reached target Local File Systems. machine # [ 78.960263] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 78.962173] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 78.963205] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 78.979152] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 78.984776] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 78.986564] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.987902] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.989386] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.990785] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 78.993495] systemd[1]: Reached target Remote File Systems. machine # [ 79.164257] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 79.168742] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 79.172743] systemd[1]: Starting linger-users.service... machine # [ 79.217903] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 79.221461] systemd[1]: Finished linger-users.service. machine # [ 79.475927] nixos[5590]: finished switching to system configuration /nix/store/xi0mwqlv5c4qvx4m5gg9czcgyaw5igss-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.87 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 79.712874] nixos[5732]: switching to system configuration /nix/store/9f2hz6mqwvdbxd84jr71h3mp7qfjdmdg-nixos-system-machine-test machine # [ 79.715434] systemd[1]: Stopped target Remote File Systems. machine # [ 79.718098] systemd[1]: Stopped target Local File Systems. machine # [ 80.000504] systemd[1]: Reload requested from client PID 5732 ('.switch-to-conf') (unit backdoor.service)... machine # [ 80.002501] systemd[1]: Reloading... machine # [ 80.317668] systemd[1]: Reloading finished in 313 ms. machine # [ 80.400411] systemd[554]: Reexecution requested from client PID 5801 ('switch-to-confi')... machine # [ 80.404772] systemd[554]: Reexecuting. machine # [ 80.459463] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.570095] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.576955] systemd[554]: Reload requested from client PID 5801 ('switch-to-confi')... machine # [ 80.578308] systemd[554]: Reloading... machine # [ 80.683629] systemd[554]: Reloading finished in 103 ms. machine # [ 80.700184] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.709638] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 80.712042] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 80.714155] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 80.747347] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 80.750855] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 80.755420] systemd[1]: Stopping Reactivate sysinit units... machine # [ 80.756724] systemd[1]: Reached target Reactivate sysinit units. machine # [ 80.757608] systemd[1]: test.service: Deactivated successfully. machine # [ 80.758462] systemd[1]: Stopped test.service. machine # [ 80.759115] systemd[1]: Stopping test.service... machine # [ 80.760942] systemd[1]: Starting test.service... machine # [ 80.784448] systemd[1]: Finished test.service. machine # [ 80.789133] systemd[1]: Reached target Remote File Systems. machine # [ 80.792425] systemd[1]: Reached target Local File Systems. machine # [ 80.799312] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.804819] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 80.806207] systemd[1]: Starting linger-users.service... machine # [ 80.807034] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 80.821364] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 80.822264] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 80.823528] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 80.827379] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 80.829316] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.830660] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.890269] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 80.894647] systemd[1]: Finished linger-users.service. machine # [ 81.010564] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 81.013835] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 81.267871] nixos[5732]: finished switching to system configuration /nix/store/9f2hz6mqwvdbxd84jr71h3mp7qfjdmdg-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.79 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 81.543130] nixos[5874]: switching to system configuration /nix/store/ifi4s0m12b40ki1zplbfa832gaplgxfj-nixos-system-machine-test machine # [ 81.546274] systemd[1]: Stopped target Remote File Systems. machine # [ 81.549126] systemd[1]: Stopped target Local File Systems. machine # [ 81.811464] systemd[1]: Reload requested from client PID 5874 ('.switch-to-conf') (unit backdoor.service)... machine # [ 81.813731] systemd[1]: Reloading... machine # [ 82.115469] systemd[1]: Reloading finished in 300 ms. machine # [ 82.198342] systemd[554]: Reexecution requested from client PID 5943 ('switch-to-confi')... machine # [ 82.199793] systemd[554]: Reexecuting. machine # [ 82.259246] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.369206] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.375919] systemd[554]: Reload requested from client PID 5943 ('switch-to-confi')... machine # [ 82.379470] systemd[554]: Reloading... machine # [ 82.481907] systemd[554]: Reloading finished in 102 ms. machine # [ 82.496156] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.506328] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 82.508839] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 82.510894] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 82.542666] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 82.546654] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 82.551199] systemd[1]: Stopping Reactivate sysinit units... machine # [ 82.552398] systemd[1]: Reached target Reactivate sysinit units. machine # [ 82.553361] systemd[1]: test.service: Deactivated successfully. machine # [ 82.554205] systemd[1]: Stopped test.service. machine # [ 82.554855] systemd[1]: Stopping test.service... machine # [ 82.556695] systemd[1]: Starting test.service... machine # [ 82.580378] systemd[1]: Finished test.service. machine # [ 82.583940] systemd[1]: Reached target Local File Systems. machine # [ 82.588190] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 82.594471] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 82.595415] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 82.604314] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 82.606600] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 82.613826] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.615182] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.616512] systemd[1]: Reached target Remote File Systems. machine # [ 82.617420] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.618725] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 82.765821] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 82.768157] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 82.772687] systemd[1]: Starting linger-users.service... machine # [ 82.811937] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 82.815238] systemd[1]: Finished linger-users.service. machine # [ 83.069120] nixos[5874]: finished switching to system configuration /nix/store/ifi4s0m12b40ki1zplbfa832gaplgxfj-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 1.80 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 83.266355] nixos[6016]: switching to system configuration /nix/store/r3yvszdzilbq30gd4r6y9cy3afzfkb29-nixos-system-machine-test machine # [ 83.269294] systemd[1]: Stopped target Remote File Systems. machine # [ 83.271567] systemd[1]: Stopped target Local File Systems. machine # [ 83.520196] systemd[1]: Reload requested from client PID 6016 ('.switch-to-conf') (unit backdoor.service)... machine # [ 83.522233] systemd[1]: Reloading... machine # [ 83.817305] systemd[1]: Reloading finished in 293 ms. machine # [ 83.900426] systemd[554]: Reexecution requested from client PID 6085 ('switch-to-confi')... machine # [ 83.902004] systemd[554]: Reexecuting. machine # [ 83.950727] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.054602] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.061042] systemd[554]: Reload requested from client PID 6085 ('switch-to-confi')... machine # [ 84.064154] systemd[554]: Reloading... machine # [ 84.165564] systemd[554]: Reloading finished in 101 ms. machine # [ 84.180173] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.189361] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 84.191653] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 84.194000] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 84.218795] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 84.222606] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 84.224650] systemd[1]: Stopping Reactivate sysinit units... machine # [ 84.225535] systemd[1]: Reached target Reactivate sysinit units. machine # [ 84.228486] systemd[1]: test.service: Deactivated successfully. machine # [ 84.229402] systemd[1]: Stopped test.service. machine # [ 84.230056] systemd[1]: Stopping test.service... machine # [ 84.233044] systemd[1]: Starting test.service... machine # [ 84.256084] systemd[1]: Finished test.service. machine # [ 84.261442] systemd[1]: Reached target Local File Systems. machine # [ 84.264980] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 84.269560] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 84.270452] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 84.271711] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 84.281069] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 84.282748] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.286872] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.292143] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.293556] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 84.295430] systemd[1]: Reached target Remote File Systems. machine # [ 84.441655] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 84.446444] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 84.448663] systemd[1]: Starting linger-users.service... machine # [ 84.487515] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 84.490912] systemd[1]: Finished linger-users.service. machine # [ 84.746334] nixos[6016]: finished switching to system configuration /nix/store/r3yvszdzilbq30gd4r6y9cy3afzfkb29-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.68 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 84.973869] nixos[6158]: switching to system configuration /nix/store/11xz4x8m4a7z8nz2z0p0nsy3xqg0jabp-nixos-system-machine-test machine # [ 84.976878] systemd[1]: Stopped target Local File Systems. machine # [ 84.978581] systemd[1]: Stopped target Remote File Systems. machine # [ 85.251735] systemd[1]: Reload requested from client PID 6158 ('.switch-to-conf') (unit backdoor.service)... machine # [ 85.254037] systemd[1]: Reloading... machine # [ 85.578135] systemd[1]: Reloading finished in 322 ms. machine # [ 85.668474] systemd[554]: Reexecution requested from client PID 6227 ('switch-to-confi')... machine # [ 85.673219] systemd[554]: Reexecuting. machine # [ 85.719700] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.831997] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.839903] systemd[554]: Reload requested from client PID 6227 ('switch-to-confi')... machine # [ 85.843927] systemd[554]: Reloading... machine # [ 85.952040] systemd[554]: Reloading finished in 109 ms. machine # [ 85.964210] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.974121] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 85.976717] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 85.978981] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 86.016918] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 86.021310] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 86.026283] systemd[1]: Stopping Reactivate sysinit units... machine # [ 86.027352] systemd[1]: Reached target Reactivate sysinit units. machine # [ 86.029868] systemd[1]: Reloading test.service... machine # [ 86.059426] systemd[1]: Reloaded test.service. machine # [ 86.064727] systemd[1]: Reached target Remote File Systems. machine # [ 86.070379] systemd[1]: Starting linger-users.service... machine # [ 86.084961] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.086601] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 86.092957] systemd[1]: Reached target Local File Systems. machine # [ 86.094986] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 86.104724] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 86.105750] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 86.113560] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 86.115973] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 86.126514] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.127931] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.166854] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 86.169437] systemd[1]: Finished linger-users.service. machine # [ 86.308742] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 86.312350] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 86.566887] nixos[6158]: finished switching to system configuration /nix/store/11xz4x8m4a7z8nz2z0p0nsy3xqg0jabp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.82 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 86.798707] nixos[6300]: switching to system configuration /nix/store/rh3lwzfani3laa34r2ngvch6xkibh7wj-nixos-system-machine-test machine # [ 86.801839] systemd[1]: Stopped target Remote File Systems. machine # [ 86.804267] systemd[1]: Stopped target Local File Systems. machine # [ 87.083656] systemd[1]: Reload requested from client PID 6300 ('.switch-to-conf') (unit backdoor.service)... machine # [ 87.086068] systemd[1]: Reloading... machine # [ 87.406780] systemd[1]: Reloading finished in 319 ms. machine # [ 87.493044] systemd[554]: Reexecution requested from client PID 6369 ('switch-to-confi')... machine # [ 87.497510] systemd[554]: Reexecuting. machine # [ 87.543622] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.657627] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.664615] systemd[554]: Reload requested from client PID 6369 ('switch-to-confi')... machine # [ 87.667087] systemd[554]: Reloading... machine # [ 87.775092] systemd[554]: Reloading finished in 106 ms. machine # [ 87.793809] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.801694] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 87.804044] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 87.806337] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 87.840961] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 87.846587] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 87.852315] systemd[1]: Stopping Reactivate sysinit units... machine # [ 87.853447] systemd[1]: Reached target Reactivate sysinit units. machine # [ 87.856426] systemd[1]: Reloading test.service... machine # [ 87.884695] systemd[1]: Reloaded test.service. machine # [ 87.889295] systemd[1]: Reached target Remote File Systems. machine # [ 87.892980] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.894585] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 87.901418] systemd[1]: Reached target Local File Systems. machine # [ 87.902433] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 87.906736] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 87.907757] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 87.916601] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 87.919046] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 87.927627] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.929462] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 88.084420] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 88.088690] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 88.091822] systemd[1]: Starting linger-users.service... machine # [ 88.139506] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 88.143143] systemd[1]: Finished linger-users.service. machine # [ 88.399422] nixos[6300]: finished switching to system configuration /nix/store/rh3lwzfani3laa34r2ngvch6xkibh7wj-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.83 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 88.622457] nixos[6442]: switching to system configuration /nix/store/v9mdhjvy4ilrvm1zyxghk9601f7936q7-nixos-system-machine-test machine # [ 88.627724] systemd[1]: Stopped target Local File Systems. machine # [ 88.630195] systemd[1]: Stopped target Remote File Systems. machine # [ 88.897412] systemd[1]: Reload requested from client PID 6442 ('.switch-to-conf') (unit backdoor.service)... machine # [ 88.899473] systemd[1]: Reloading... machine # [ 89.212874] systemd[1]: Reloading finished in 311 ms. machine # [ 89.293218] systemd[554]: Reexecution requested from client PID 6511 ('switch-to-confi')... machine # [ 89.297226] systemd[554]: Reexecuting. machine # [ 89.347415] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.463781] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.470701] systemd[554]: Reload requested from client PID 6511 ('switch-to-confi')... machine # [ 89.474597] systemd[554]: Reloading... machine # [ 89.578557] systemd[554]: Reloading finished in 105 ms. machine # [ 89.596169] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.606750] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 89.607887] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 89.610749] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 89.643010] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 89.646784] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 89.651500] systemd[1]: Stopping Reactivate sysinit units... machine # [ 89.652867] systemd[1]: Reached target Reactivate sysinit units. machine # [ 89.653760] systemd[1]: test.service: Deactivated successfully. machine # [ 89.654649] systemd[1]: Stopped test.service. machine # [ 89.655331] systemd[1]: Stopping test.service... machine # [ 89.660405] systemd[1]: Starting test.service... machine # [ 89.680237] systemd[1]: Finished test.service. machine # [ 89.682868] systemd[1]: Reached target Local File Systems. machine # [ 89.691853] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 89.699752] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 89.705112] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 89.706481] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 89.712218] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 89.713985] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.715296] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.716663] systemd[1]: Reached target Remote File Systems. machine # [ 89.717507] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.718831] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 89.866461] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 89.871239] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 89.873487] systemd[1]: Starting linger-users.service... machine # [ 89.911794] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 89.915165] systemd[1]: Finished linger-users.service. machine # [ 90.170045] nixos[6442]: finished switching to system configuration /nix/store/v9mdhjvy4ilrvm1zyxghk9601f7936q7-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.77 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 90.366570] nixos[6584]: switching to system configuration /nix/store/xi0mwqlv5c4qvx4m5gg9czcgyaw5igss-nixos-system-machine-test machine # [ 90.369263] systemd[1]: Stopped target Remote File Systems. machine # [ 90.372141] systemd[1]: Stopped target Local File Systems. machine # [ 90.632984] systemd[1]: Reload requested from client PID 6584 ('.switch-to-conf') (unit backdoor.service)... machine # [ 90.635095] systemd[1]: Reloading... machine # [ 90.949046] systemd[1]: Reloading finished in 311 ms. machine # [ 91.034195] systemd[554]: Reexecution requested from client PID 6653 ('switch-to-confi')... machine # [ 91.039345] systemd[554]: Reexecuting. machine # [ 91.091282] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.204988] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.211974] systemd[554]: Reload requested from client PID 6653 ('switch-to-confi')... machine # [ 91.215719] systemd[554]: Reloading... machine # [ 91.325052] systemd[554]: Reloading finished in 110 ms. machine # [ 91.340177] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.349710] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 91.352181] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 91.354506] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 91.387813] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 91.392106] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 91.395417] systemd[1]: Stopping Reactivate sysinit units... machine # [ 91.396909] systemd[1]: Reached target Reactivate sysinit units. machine # [ 91.399268] systemd[1]: Reached target Remote File Systems. machine # [ 91.404361] systemd[1]: Starting linger-users.service... machine # [ 91.412550] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.414027] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 91.420062] systemd[1]: Reached target Local File Systems. machine # [ 91.421030] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 91.432203] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 91.433373] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 91.434704] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 91.446133] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 91.447900] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.455892] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.498395] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 91.502689] systemd[1]: Finished linger-users.service. machine # [ 91.635301] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 91.638573] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 91.894736] nixos[6584]: finished switching to system configuration /nix/store/xi0mwqlv5c4qvx4m5gg9czcgyaw5igss-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.73 seconds) (finished: subtest: unit file parser, in 23.22 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 92.104110] nixos[6724]: switching to system configuration /nix/store/5wq5ssa3v3cskp0p48jbyiik1xwwwhv5-nixos-system-machine-test machine # [ 92.108804] systemd[1]: Stopped target Remote File Systems. machine # [ 92.109737] systemd[1]: Stopped target Local File Systems. machine # [ 92.373439] systemd[1]: Reload requested from client PID 6724 ('.switch-to-conf') (unit backdoor.service)... machine # [ 92.375544] systemd[1]: Reloading... machine # [ 92.686648] systemd[1]: Reloading finished in 309 ms. machine # [ 92.772754] systemd[554]: Reexecution requested from client PID 6793 ('switch-to-confi')... machine # [ 92.775426] systemd[554]: Reexecuting. machine # [ 92.822821] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.931471] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.938431] systemd[554]: Reload requested from client PID 6793 ('switch-to-confi')... machine # [ 92.941058] systemd[554]: Reloading... machine # [ 93.048419] systemd[554]: Reloading finished in 106 ms. machine # [ 93.060161] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.069501] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 93.071830] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 93.074186] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 93.103402] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 93.107532] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 93.110605] systemd[1]: Stopping Reactivate sysinit units... machine # [ 93.111532] systemd[1]: Reached target Reactivate sysinit units. machine # [ 93.114509] systemd[1]: Reached target Local File Systems. machine # [ 93.116949] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 93.123547] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 93.127942] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 93.132545] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 93.134962] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 93.143359] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.145506] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.146817] systemd[1]: Reached target Remote File Systems. machine # [ 93.147642] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.150133] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 93.299790] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 93.302029] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 93.308424] systemd[1]: Starting linger-users.service... machine # [ 93.348578] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 93.351637] systemd[1]: Finished linger-users.service. machine # [ 93.605679] nixos[6724]: finished switching to system configuration /nix/store/5wq5ssa3v3cskp0p48jbyiik1xwwwhv5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.71 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 93.843089] nixos[6864]: switching to system configuration /nix/store/9j77wpncmybxpks1na9dk8xmalyjr9fb-nixos-system-machine-test machine # [ 93.845871] systemd[1]: Stopped target Remote File Systems. machine # [ 93.849909] systemd[1]: test.service: Deactivated successfully. machine # [ 93.850902] systemd[1]: Stopped test.service. machine # [ 93.851570] systemd[1]: Stopped target Local File Systems. machine # [ 94.130932] systemd[1]: Reload requested from client PID 6864 ('.switch-to-conf') (unit backdoor.service)... machine # [ 94.133099] systemd[1]: Reloading... machine # [ 94.448906] systemd[1]: Reloading finished in 314 ms. machine # [ 94.539422] systemd[554]: Reexecution requested from client PID 6935 ('switch-to-confi')... machine # [ 94.541903] systemd[554]: Reexecuting. machine # [ 94.595074] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.704333] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.710809] systemd[554]: Reload requested from client PID 6935 ('switch-to-confi')... machine # [ 94.713207] systemd[554]: Reloading... machine # [ 94.818112] systemd[554]: Reloading finished in 104 ms. machine # [ 94.832165] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.842674] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 94.843750] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 94.846823] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 94.875487] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 94.879343] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 94.881581] systemd[1]: Stopping Reactivate sysinit units... machine # [ 94.882493] systemd[1]: Reached target Reactivate sysinit units. machine # [ 94.887906] systemd[1]: Starting simple-restart-service.service... machine # [ 94.899865] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 94.914687] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 94.922179] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 94.939260] systemd[1]: Starting simple-service.service... machine # [ 94.943308] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 94.956704] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 94.957817] systemd[1]: Reached target Local File Systems. machine # [ 94.970257] systemd[1]: Starting simple-reload-service.service... machine # [ 94.979660] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 94.995476] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 95.013611] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.015262] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 95.046914] systemd[1]: Finished simple-restart-service.service. machine # [ 95.048000] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 95.061657] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 95.063277] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 95.097565] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 95.104840] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 95.107193] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 95.120556] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.122041] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.123287] systemd[1]: Reached target Remote File Systems. machine # [ 95.129150] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 95.133051] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 95.134158] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 95.135195] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 95.138736] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 95.140632] systemd[1]: Finished simple-service.service. machine # [ 95.141438] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 95.142461] systemd[1]: Finished simple-reload-service.service. machine # [ 95.143314] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 95.278592] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 95.282998] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 95.286586] systemd[1]: Starting linger-users.service... machine # [ 95.290184] systemd[1]: Starting no-restart-service.service... machine # [ 95.300347] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 95.301434] systemd[1]: Starting reload-triggers.service... machine # [ 95.324034] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 95.325389] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 95.326409] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 95.348579] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 95.445365] systemd[1]: Finished no-restart-service.service. machine # [ 95.446380] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 95.447331] systemd[1]: Finished reload-triggers.service. machine # [ 95.454864] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 95.457784] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 95.458880] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 95.459963] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 95.476661] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 95.479654] systemd[1]: Finished linger-users.service. machine # [ 95.735221] nixos[6864]: finished switching to system configuration /nix/store/9j77wpncmybxpks1na9dk8xmalyjr9fb-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.13 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 95.981097] nixos[7034]: switching to system configuration /nix/store/9j77wpncmybxpks1na9dk8xmalyjr9fb-nixos-system-machine-test machine # [ 95.983530] systemd[1]: Stopped target Remote File Systems. machine # [ 95.986465] systemd[1]: Stopped target Local File Systems. machine # [ 96.261424] systemd[1]: Reload requested from client PID 7034 ('.switch-to-conf') (unit backdoor.service)... machine # [ 96.263489] systemd[1]: Reloading... machine # [ 96.590250] systemd[1]: Reloading finished in 325 ms. machine # [ 96.680450] systemd[554]: Reexecution requested from client PID 7105 ('switch-to-confi')... machine # [ 96.684319] systemd[554]: Reexecuting. machine # [ 96.743334] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.858858] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.865969] systemd[554]: Reload requested from client PID 7105 ('switch-to-confi')... machine # [ 96.868226] systemd[554]: Reloading... machine # [ 96.974976] systemd[554]: Reloading finished in 105 ms. machine # [ 96.988177] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.998300] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 97.000743] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 97.002933] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 97.035440] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 97.039463] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 97.042480] systemd[1]: Stopping Reactivate sysinit units... machine # [ 97.043360] systemd[1]: Reached target Reactivate sysinit units. machine # [ 97.047928] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 97.052963] systemd[1]: Reloading reload-triggers.service... machine # [ 97.064204] systemd[1]: Reloading simple-reload-service.service... machine # [ 97.065278] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 97.088947] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 97.090185] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 97.164169] systemd[1]: Reloaded reload-triggers.service. machine # [ 97.171933] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 97.174541] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 97.175697] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 97.178292] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 97.182676] systemd[1]: Reloaded simple-reload-service.service. machine # [ 97.186385] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 97.189861] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 97.190938] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 97.201088] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 97.202221] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 97.203308] systemd[1]: Stopped simple-restart-service.service. machine # [ 97.220653] systemd[1]: Stopping simple-restart-service.service... machine # [ 97.221676] systemd[1]: Starting simple-restart-service.service... machine # [ 97.222610] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 97.223611] systemd[1]: Stopped simple-service.service. machine # [ 97.247251] systemd[1]: Stopping simple-service.service... machine # [ 97.256345] systemd[1]: Starting simple-service.service... machine # [ 97.263579] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 97.279022] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 97.290314] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 97.291769] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 97.314890] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 97.323703] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 97.330606] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 97.331811] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 97.337437] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 97.338775] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 97.339794] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 97.344793] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 97.345898] systemd[1]: Finished simple-service.service. machine # [ 97.346675] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 97.347702] systemd[1]: Finished simple-restart-service.service. machine # [ 97.350782] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 97.351929] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 97.364822] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 97.365903] systemd[1]: Reached target Remote File Systems. machine # [ 97.366712] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 97.374587] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 97.376173] systemd[1]: Reached target Local File Systems. machine # [ 97.377094] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 97.378615] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 97.379431] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 97.380917] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 97.385001] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 97.386681] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 97.388780] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 97.532527] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 97.536807] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 97.539553] systemd[1]: Starting linger-users.service... machine # [ 97.579297] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 97.582469] systemd[1]: Finished linger-users.service. machine # [ 97.836636] nixos[7034]: finished switching to system configuration /nix/store/9j77wpncmybxpks1na9dk8xmalyjr9fb-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.10 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 98.103680] nixos[7200]: switching to system configuration /nix/store/z1cb1r6da8xz55rzjgrwkyygvrkx5833-nixos-system-machine-test machine # [ 98.106469] systemd[1]: Stopped target Remote File Systems. machine # [ 98.109111] systemd[1]: Stopped target Local File Systems. machine # [ 98.408511] systemd[1]: Reload requested from client PID 7200 ('.switch-to-conf') (unit backdoor.service)... machine # [ 98.410160] systemd[1]: Reloading... machine # [ 98.743608] systemd[1]: Reloading finished in 332 ms. machine # [ 98.836251] systemd[554]: Reexecution requested from client PID 7271 ('switch-to-confi')... machine # [ 98.837808] systemd[554]: Reexecuting. machine # [ 98.887171] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.995757] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.003543] systemd[554]: Reload requested from client PID 7271 ('switch-to-confi')... machine # [ 99.006803] systemd[554]: Reloading... machine # [ 99.111499] systemd[554]: Reloading finished in 105 ms. machine # [ 99.128168] systemd[554]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.138819] systemd[554]: Stopped Run user-specific NixOS activation. machine # [ 99.139979] systemd[554]: Stopping Run user-specific NixOS activation... machine # [ 99.142816] systemd[554]: Starting Run user-specific NixOS activation... machine # [ 99.175944] systemd[554]: Finished Run user-specific NixOS activation. machine # [ 99.180161] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 99.185789] systemd[1]: Stopping Reactivate sysinit units... machine # [ 99.186810] systemd[1]: Reached target Reactivate sysinit units. machine # [ 99.188673] systemd[1]: Reloading reload-triggers.service... machine # [ 99.199741] systemd[1]: Reloading simple-reload-service.service... machine # [ 99.206632] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 99.216701] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 99.255294] systemd[1]: Reloaded reload-triggers.service. machine # [ 99.265467] systemd[1]: Reloaded simple-reload-service.service. machine # [ 99.280001] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 99.283885] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 99.288744] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 99.290097] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 99.291126] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 99.298541] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 99.299682] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 99.321043] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 99.322101] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 99.323128] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 99.333851] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 99.335037] systemd[1]: Stopped simple-restart-service.service. machine # [ 99.335919] systemd[1]: Stopping simple-restart-service.service... machine # [ 99.357085] systemd[1]: Starting simple-restart-service.service... machine # [ 99.358154] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 99.359314] systemd[1]: Stopped simple-service.service. machine # [ 99.386555] systemd[1]: Stopping simple-service.service... machine # [ 99.392380] systemd[1]: Starting simple-service.service... machine # [ 99.406985] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 99.428558] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 99.449351] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 99.461672] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 99.469419] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 99.470966] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 99.486436] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 99.489068] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 99.490347] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 99.491634] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 99.494679] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 99.495975] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 99.505771] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 99.507075] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 99.517096] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 99.518257] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 99.519290] systemd[1]: Finished simple-restart-service.service. machine # [ 99.527512] systemd[1]: Finished simple-service.service. machine # [ 99.528685] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 99.529650] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 99.530651] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 99.531829] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 99.533537] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 99.534717] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 99.536546] systemd[1]: Reached target Local File Systems. machine # [ 99.538292] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 99.541598] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 99.542641] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 99.543956] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 99.547238] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 99.554239] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.556071] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.557424] systemd[1]: Reached target Remote File Systems. machine # [ 99.558291] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.559650] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 99.698916] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 99.703747] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 99.706306] systemd[1]: Starting linger-users.service... machine # [ 99.745125] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 99.747981] systemd[1]: Finished linger-users.service. machine # [ 100.004190] nixos[7200]: finished switching to system configuration /nix/store/z1cb1r6da8xz55rzjgrwkyygvrkx5833-nixos-system-machine-test machine: (finished: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.17 seconds) machine: must succeed: /nix/store/m1ki46l9yqwg45x4ccii3slsy55icrdc-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/m1ki46l9yqwg45x4ccii3slsy55icrdc-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.33 seconds) (finished: subtest: restart and reload by activation script, in 8.44 seconds) (finished: run the VM test script, in 101.16 seconds) test script finished in 101.23s cleanup kill QemuMachine (pid 45) machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14) machine # [2026-09-29T03:51:42Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-29T03:51:42Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-29T03:51:42Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.16 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