vm-test-run-switch-test-services
checks.aarch64-linux.switchTest
· build #28
· raw
1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7machine: waiting for unit multi-user.target8machine: waiting for the VM to finish booting9machine: starting vm10machine: QEMU running (pid 45)11machine # Disk image does not exist, creating the virtualisation disk image...12machine # Formatting '/build/vm-state-machine/tmp.fSY8kIjki4', fmt=raw size=107374182413machine # mke2fs 1.47.4 (6-Mar-2025)14machine # Discarding device blocks: 0/262144 done15machine # Creating filesystem with 262144 4k blocks and 65536 inodes16machine # Filesystem UUID: a17311b5-a106-4f46-b3e0-5e2df341944f17machine # Superblock backups stored on blocks:18machine # 32768, 98304, 163840, 22937619machine # 20machine # Allocating group tables: 0/8 done21machine # Writing inode tables: 0/8 done22machine # Creating journal (8192 blocks): done23machine # Writing superblocks and filesystem accounting information: 0/8 done24machine # 25machine # Virtualisation disk image created.26machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]27machine # [ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Sep 2 12:31:51 UTC 202628machine # [ 0.000000] KASLR enabled29machine # [ 0.000000] random: crng init done30machine # [ 0.000000] Machine model: linux,dummy-virt31machine # [ 0.000000] efi: UEFI not found.32machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT33machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]34machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f]35machine # [ 0.000000] Zone ranges:36machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]37machine # [ 0.000000] DMA32 empty38machine # [ 0.000000] Normal empty39machine # [ 0.000000] Device empty40machine # [ 0.000000] Movable zone start for each node41machine # [ 0.000000] Early memory node ranges42machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]43machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]44machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc0000045machine # [ 0.000000] psci: probing for conduit method from DT.46machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.47machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs48machine # [ 0.000000] psci: Trusted OS migration not required49machine # [ 0.000000] psci: SMC Calling Convention v1.150machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)51machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u31129652machine # [ 0.000000] Detected PIPT I-cache on CPU053machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)54machine # [ 0.000000] CPU features: detected: GICv3 CPU interface55machine # [ 0.000000] CPU features: detected: Spectre-v456machine # [ 0.000000] CPU features: detected: Spectre-BHB57machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_3858machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_2359machine # [ 0.000000] alternatives: applying boot alternatives60machine # [ 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/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/init regInfo=/nix/store/nz651mzmj1x1mdxq7nvq4yjffij7vmkq-closure-info/registration console=ttyAMA0,115200n8 console=tty061machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/nz651mzmj1x1mdxq7nvq4yjffij7vmkq-closure-info/registration", will be passed to user space.62machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes63machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)64machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)65machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB66machine # [ 0.000000] software IO TLB: area num 1.67machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)68machine # [ 0.000000] Fallback order for Node 0: 069machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 26214470machine # [ 0.000000] Policy zone: DMA71machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off72machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=173machine # [ 0.000000] allocated 2097152 bytes of page_ext74machine # [ 0.000000] ftrace: allocating 74886 entries in 294 pages75machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups76machine # [ 0.000000] rcu: Hierarchical RCU implementation.77machine # [ 0.000000] rcu: RCU event tracing is enabled.78machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.79machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.80machine # [ 0.000000] Rude variant of Tasks RCU enabled.81machine # [ 0.000000] Tracing variant of Tasks RCU enabled.82machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.83machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=184machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.85machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.86machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.87machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 088machine # [ 0.000000] GICv3: 256 SPIs implemented89machine # [ 0.000000] GICv3: 0 Extended SPIs implemented90machine # [ 0.000000] Root IRQ handler: gic_handle_irq91machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI92machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=093machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a000094machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]95machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)96machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)97machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d1000098machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d2000099machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.100machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns101machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).102machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns103machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns104machine # [ 0.000029] arm-pv: using stolen time PV105machine # [ 0.000402] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)106machine # [ 0.000557] Console: colour dummy device 80x25107machine # [ 0.000565] printk: legacy console [tty0] enabled108machine # [ 0.000751] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)109machine # [ 0.000758] pid_max: default: 32768 minimum: 301110machine # [ 0.000833] LSM: initializing lsm=capability,landlock,yama,bpf,ima111machine # [ 0.000954] landlock: Up and running.112machine # [ 0.000957] Yama: becoming mindful.113machine # [ 0.001418] LSM support for eBPF active114machine # [ 0.001551] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)115machine # [ 0.001577] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)116machine # [ 0.002736] cacheinfo: Unable to detect cache hierarchy for CPU 0117machine # [ 0.003540] rcu: Hierarchical SRCU implementation.118machine # [ 0.003544] rcu: Max phase no-delay instances is 1000.119machine # [ 0.004763] fsl-mc MSI: its@8080000 domain created120machine # [ 0.004849] EFI services will not be available.121machine # [ 0.004916] smp: Bringing up secondary CPUs ...122machine # [ 0.004924] smp: Brought up 1 node, 1 CPU123machine # [ 0.004927] SMP: Total of 1 processors activated.124machine # [ 0.004930] CPU: All CPU(s) started at EL1125machine # [ 0.004943] CPU features: detected: Branch Target Identification126machine # [ 0.004948] CPU features: detected: ARMv8.4 Translation Table Level127machine # [ 0.004951] CPU features: detected: Instruction cache invalidation not required for I/D coherence128machine # [ 0.004955] CPU features: detected: Data cache clean to the PoU not required for I/D coherence129machine # [ 0.004958] CPU features: detected: Common not Private translations130machine # [ 0.004961] CPU features: detected: CRC32 instructions131machine # [ 0.004964] CPU features: detected: Data cache clean to Point of Deep Persistence132machine # [ 0.004967] CPU features: detected: Data cache clean to Point of Persistence133machine # [ 0.004970] CPU features: detected: Data independent timing control (DIT)134machine # [ 0.004974] CPU features: detected: E0PD135machine # [ 0.004976] CPU features: detected: Enhanced Counter Virtualization136machine # [ 0.004979] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)137machine # [ 0.004982] CPU features: detected: Enhanced Virtualization Traps138machine # [ 0.004985] CPU features: detected: Fine Grained Traps139machine # [ 0.004989] CPU features: detected: Generic authentication (architected QARMA5 algorithm)140machine # [ 0.004994] CPU features: detected: RCpc load-acquire (LDAPR)141machine # [ 0.004997] CPU features: detected: LSE atomic instructions142machine # [ 0.004999] CPU features: detected: Privileged Access Never143machine # [ 0.005002] CPU features: detected: PMUv3144machine # [ 0.005005] CPU features: detected: RAS Extension Support145machine # [ 0.005008] CPU features: detected: RASv1p1 Extension Support146machine # [ 0.005010] CPU features: detected: Random Number Generator147machine # [ 0.005013] CPU features: detected: Speculation barrier (SB)148machine # [ 0.005015] CPU features: detected: Stage-2 Force Write-Back149machine # [ 0.005018] CPU features: detected: TLB range maintenance instructions150machine # [ 0.005022] CPU features: detected: Speculative Store Bypassing Safe (SSBS)151machine # [ 0.005060] alternatives: applying system-wide alternatives152machine # [ 0.008112] CPU features: detected: BBM Level 2 without TLB conflict abort153machine # [ 0.008259] Memory: 894848K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 112420K reserved, 32768K cma-reserved)154machine # [ 0.008603] devtmpfs: initialized155machine # [ 0.010258] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)156machine # [ 0.010281] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).157machine # [ 0.010490] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL158machine # [ 0.010494] 0 pages in range for non-PLT usage159machine # [ 0.010495] 508288 pages in range for PLT usage160machine # [ 0.010625] pinctrl core: initialized pinctrl subsystem161machine # [ 0.011402] DMI not present or invalid.162machine # [ 0.014562] NET: Registered PF_NETLINK/PF_ROUTE protocol family163machine # [ 0.016955] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations164machine # [ 0.017114] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations165machine # [ 0.017275] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations166machine # [ 0.017298] audit: initializing netlink subsys (disabled)167machine # [ 0.017876] thermal_sys: Registered thermal governor 'fair_share'168machine # [ 0.017879] thermal_sys: Registered thermal governor 'bang_bang'169machine # [ 0.017882] thermal_sys: Registered thermal governor 'step_wise'170machine # [ 0.017885] thermal_sys: Registered thermal governor 'user_space'171machine # [ 0.017891] thermal_sys: Registered thermal governor 'power_allocator'172machine # [ 0.017915] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1173machine # [ 0.017924] cpuidle: using governor ladder174machine # [ 0.017929] cpuidle: using governor menu175machine # [ 0.018117] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.176machine # [ 0.018132] ASID allocator initialised with 65536 entries177machine # [ 0.019279] Serial: AMBA PL011 UART driver178machine # [ 0.024484] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1179machine # [ 0.024604] printk: console [ttyAMA0] enabled180machine # [ 0.149724] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages181machine # [ 0.149747] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page182machine # [ 0.149753] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages183machine # [ 0.149757] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page184machine # [ 0.149762] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages185machine # [ 0.149766] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page186machine # [ 0.149770] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages187machine # [ 0.149775] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page188machine # [ 0.157375] fbcon: Taking over console189machine # [ 0.157391] ACPI: Interpreter disabled.190machine # [ 0.165206] iommu: Default domain type: Translated191machine # [ 0.165216] iommu: DMA domain TLB invalidation policy: strict mode192machine # [ 0.166943] SCSI subsystem initialized193machine # [ 0.167658] usbcore: registered new interface driver usbfs194machine # [ 0.167689] usbcore: registered new interface driver hub195machine # [ 0.167705] usbcore: registered new device driver usb196machine # [ 0.168021] pps_core: LinuxPPS API ver. 1 registered197machine # [ 0.168027] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>198machine # [ 0.168037] PTP clock support registered199machine # [ 0.168086] EDAC MC: Ver: 3.0.0200machine # [ 0.172798] scmi_core: SCMI protocol bus registered201machine # [ 0.173782] FPGA manager framework202machine # [ 0.174751] vgaarb: loaded203machine # [ 0.175395] clocksource: Switched to clocksource arch_sys_counter204machine # [ 0.180155] VFS: Disk quotas dquot_6.6.0205machine # [ 0.180193] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)206machine # [ 0.181860] netfs: FS-Cache loaded207machine # [ 0.181997] pnp: PnP ACPI: disabled208machine # [ 0.186013] NET: Registered PF_INET protocol family209machine # [ 0.186180] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)210machine # [ 0.216340] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)211machine # [ 0.216393] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)212machine # [ 0.216422] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)213machine # [ 0.216470] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)214machine # [ 0.216545] TCP: Hash tables configured (established 8192 bind 8192)215machine # [ 0.216670] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)216machine # [ 0.216720] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)217machine # [ 0.216747] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)218machine # [ 0.216833] NET: Registered PF_UNIX/PF_LOCAL protocol family219machine # [ 0.216855] NET: Registered PF_XDP protocol family220machine # [ 0.216878] PCI: CLS 0 bytes, default 64221machine # [ 0.217147] Trying to unpack rootfs image as initramfs...222machine # [ 0.233130] kvm [1]: HYP mode not available223machine # [ 0.332913] Initialise system trusted keyrings224machine # [ 0.333658] workingset: timestamp_bits=42 max_order=18 bucket_order=0225machine # [ 0.334923] squashfs: version 4.0 (2009/01/31) Phillip Lougher226machine # [ 0.343469] 9p: Installing v9fs 9p2000 file system support227machine # [ 0.363486] Key type asymmetric registered228machine # [ 0.363513] Asymmetric key parser 'x509' registered229machine # [ 0.363587] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)230machine # [ 0.365817] io scheduler mq-deadline registered231machine # [ 0.365827] io scheduler kyber registered232machine # [ 0.379576] pl061_gpio 9030000.pl061: PL061 GPIO chip registered233machine # [ 0.380256] ledtrig-cpu: registered to indicate activity on CPUs234machine # [ 0.380643] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:235machine # [ 0.380660] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000236machine # [ 0.380676] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000237machine # [ 0.380685] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000238machine # [ 0.380713] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits239machine # [ 0.380741] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]240machine # [ 0.380821] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00241machine # [ 0.380831] pci_bus 0000:00: root bus resource [bus 00-ff]242machine # [ 0.380837] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]243machine # [ 0.380842] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]244machine # [ 0.380847] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]245machine # [ 0.380965] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint246machine # [ 0.381418] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint247machine # [ 0.381604] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]248machine # [ 0.381620] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]249machine # [ 0.381650] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]250machine # [ 0.381666] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]251machine # [ 0.382131] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint252machine # [ 0.382313] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]253machine # [ 0.382329] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]254machine # [ 0.382358] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]255machine # [ 0.382840] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint256machine # [ 0.383018] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]257machine # [ 0.383034] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]258machine # [ 0.383063] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]259machine # [ 0.383535] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint260machine # [ 0.383715] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]261machine # [ 0.383730] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]262machine # [ 0.383760] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]263machine # [ 0.384224] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint264machine # [ 0.384403] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]265machine # [ 0.384419] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]266machine # [ 0.384457] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]267machine # [ 0.384895] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint268machine # [ 0.385074] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]269machine # [ 0.385089] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]270machine # [ 0.385118] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]271machine # [ 0.385557] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint272machine # [ 0.385735] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]273machine # [ 0.385751] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]274machine # [ 0.385780] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]275machine # [ 0.385796] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]276machine # [ 0.386251] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint277machine # [ 0.386435] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]278machine # [ 0.386465] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]279machine # [ 0.386938] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint280machine # [ 0.387124] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]281machine # [ 0.387154] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]282machine # [ 0.429386] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint283machine # [ 0.429570] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]284machine # [ 0.429817] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint285machine # [ 0.430105] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]286machine # [ 0.430121] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]287machine # [ 0.430150] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]288machine # [ 0.430608] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint289machine # [ 0.430788] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]290machine # [ 0.430803] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]291machine # [ 0.430832] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]292machine # [ 0.443432] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned293machine # [ 0.443453] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned294machine # [ 0.443459] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned295machine # [ 0.443526] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned296machine # [ 0.443573] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned297machine # [ 0.443618] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned298machine # [ 0.443663] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned299machine # [ 0.443709] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned300machine # [ 0.443755] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned301machine # [ 0.443801] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned302machine # [ 0.443848] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned303machine # [ 0.443894] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned304machine # [ 0.444003] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned305machine # [ 0.444050] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned306machine # [ 0.444071] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned307machine # [ 0.444092] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned308machine # [ 0.444113] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned309machine # [ 0.444134] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned310machine # [ 0.444159] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned311machine # [ 0.444180] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned312machine # [ 0.444201] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned313machine # [ 0.444223] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned314machine # [ 0.444244] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned315machine # [ 0.444267] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned316machine # [ 0.444289] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned317machine # [ 0.444310] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned318machine # [ 0.444331] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned319machine # [ 0.444352] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned320machine # [ 0.444372] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned321machine # [ 0.444393] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned322machine # [ 0.444414] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned323machine # [ 0.444435] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned324machine # [ 0.444456] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned325machine # [ 0.444477] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned326machine # [ 0.444508] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]327machine # [ 0.444518] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]328machine # [ 0.444523] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]329machine # [ 0.445669] pci 0000:00:0a.0: enabling device (0000 -> 0002)330machine # [ 0.501395] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)331machine # [ 0.507695] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)332machine # [ 0.509831] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)333machine # [ 0.520053] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)334machine # [ 0.522138] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)335machine # [ 0.533611] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)336machine # [ 0.536768] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)337machine # [ 0.538847] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)338machine # [ 0.549271] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)339machine # [ 0.551298] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)340machine # [ 0.561412] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)341machine # [ 0.572643] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled342machine # [ 0.575356] msm_serial: driver initialized343machine # [ 0.576103] SuperH (H)SCI(F) driver initialized344machine # [ 0.576160] STM32 USART driver initialized345machine # [ 0.609862] loop: module loaded346machine # [ 0.610062] virtio_blk virtio5: 1/0/0 default/read/poll queues347machine # [ 0.611005] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)348machine # [ 0.616023] megasas: 07.734.00.00-rc1349machine # [ 0.616745] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]350machine # [ 0.632661] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000351machine # [ 0.632702] Intel/Sharp Extended Query Table at 0x0031352machine # [ 0.634454] Using buffer write method353machine # [ 0.634537] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]354machine # [ 0.645733] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000355machine # [ 0.645762] Intel/Sharp Extended Query Table at 0x0031356machine # [ 0.655444] Using buffer write method357machine # [ 0.655488] Concatenating MTD devices:358machine # [ 0.655493] (0): "0.flash"359machine # [ 0.655497] (1): "0.flash"360machine # [ 0.655501] into device "0.flash"361machine # [ 0.908106] Freeing initrd memory: 25560K362machine # [ 0.914386] tun: Universal TUN/TAP device driver, 1.6363machine # [ 0.918221] thunder_xcv, ver 1.0364machine # [ 0.918270] thunder_bgx, ver 1.0365machine # [ 0.918294] nicpf, ver 1.0366machine # [ 0.918833] e1000: Intel(R) PRO/1000 Network Driver367machine # [ 0.918841] e1000: Copyright (c) 1999-2006 Intel Corporation.368machine # [ 0.918870] e1000e: Intel(R) PRO/1000 Network Driver369machine # [ 0.918879] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.370machine # [ 0.918904] igb: Intel(R) Gigabit Ethernet Network Driver371machine # [ 0.918909] igb: Copyright (c) 2007-2014 Intel Corporation.372machine # [ 0.918931] igbvf: Intel(R) Gigabit Virtual Function Network Driver373machine # [ 0.918937] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.374machine # [ 0.919065] sky2: driver version 1.30375machine # [ 0.928261] ehci-pci 0000:00:0a.0: EHCI Host Controller376machine # [ 0.928298] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1377machine # [ 0.928469] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000378machine # [ 0.931359] usbcore: registered new interface driver usb-storage379machine # [ 0.932176] usbcore: registered new interface driver usbserial_generic380machine # [ 0.932193] usbserial: USB Serial support registered for generic381machine # [ 0.932819] hv_vmbus: registering driver hyperv_keyboard382machine # [ 0.935851] rtc-pl031 9010000.pl031: registered as rtc0383machine # [ 0.935888] rtc-pl031 9010000.pl031: setting system clock to 2026-09-08T02:41:46 UTC (1788835306)384machine # [ 0.936191] i2c_dev: i2c /dev entries driver385machine # [ 0.941165] sdhci: Secure Digital Host Controller Interface driver386machine # [ 0.941175] sdhci: Copyright(c) Pierre Ossman387machine # [ 0.941436] Synopsys Designware Multimedia Card Interface Driver388machine # [ 0.941793] sdhci-pltfm: SDHCI platform and OF driver helper389machine # [ 0.946108] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00390machine # [ 0.947162] hub 1-0:1.0: USB hub found391machine # [ 0.947706] hub 1-0:1.0: 6 ports detected392machine # [ 0.948696] hid: raw HID events driver (C) Jiri Kosina393machine # [ 0.948956] usbcore: registered new interface driver usbhid394machine # [ 0.948962] usbhid: USB HID core driver395machine # [ 0.951872] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available396machine # [ 0.953349] drop_monitor: Initializing network drop monitor service397machine # [ 0.953532] NET: Registered PF_INET6 protocol family398machine # [ 0.956550] Segment Routing with IPv6399machine # [ 0.956581] In-situ OAM (IOAM) with IPv6400machine # [ 0.956609] NET: Registered PF_PACKET protocol family401machine # [ 0.958279] 9pnet: Installing 9P2000 support402machine # [ 0.960969] Key type dns_resolver registered403machine # [ 0.967164] registered taskstats version 1404machine # [ 0.967328] Loading compiled-in X.509 certificates405machine # [ 0.976157] Demotion targets for Node 0: null406machine # [ 0.976271] Key type .fscrypt registered407machine # [ 0.976278] Key type fscrypt-provisioning registered408machine # [ 0.976376] ima: No TPM chip found, activating TPM-bypass!409machine # [ 0.976396] ima: Allocated hash algorithm: sha1410machine # [ 0.976419] ima: No architecture policies found411machine # [ 0.980974] input: gpio-keys as /devices/platform/gpio-keys/input/input0412machine # [ 1.000077] clk: Disabling unused clocks413machine # [ 1.000115] PM: genpd: Disabling unused power domains414machine # [ 1.004433] Freeing unused kernel memory: 4736K415machine # [ 1.004638] Run /init as init process416machine # [ 1.021723] systemd[1]: Successfully made /usr/ read-only.417machine # [ 1.199491] usb 1-1: new high-speed USB device number 2 using ehci-pci418machine # [ 1.351935] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1419machine # [ 1.358597] systemd[1]: systemd 262-a7fc55f 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)420machine # [ 1.371457] systemd[1]: Detected virtualization qemu.421machine # [ 1.373530] systemd[1]: Detected architecture arm64.422machine # [ 1.375479] systemd[1]: Running in initrd.423machine # [ 1.378177] systemd[1]: Initializing machine ID from random generator.424machine # [ 1.381214] systemd[1]: Hostname set to <machine>.425machine # [ 1.435654] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0426machine # [ 1.505609] systemd[1]: bpf-restrict-fs: LSM BPF program attached427machine # [ 1.555446] usb 1-2: new high-speed USB device number 3 using ehci-pci428machine # [ 1.562171] systemd[1]: Queued start job for default target Initrd Default Target.429machine # [ 1.573428] systemd[1]: Created slice Slice /system/modprobe.430machine # [ 1.574460] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.431machine # [ 1.575596] systemd[1]: Expecting device /dev/disk/by-label/nixos...432machine # [ 1.576422] systemd[1]: Reached target Path Units.433machine # [ 1.577063] systemd[1]: Reached target Slice Units.434machine # [ 1.577699] systemd[1]: Reached target Swaps.435machine # [ 1.578273] systemd[1]: Reached target Timer Units.436machine # [ 1.579161] systemd[1]: Listening on D-Bus System Message Bus Socket.437machine # [ 1.580237] systemd[1]: Listening on Journal Socket (/dev/log).438machine # [ 1.581133] systemd[1]: Listening on Journal Sockets.439machine # [ 1.581887] systemd[1]: Listening on udev Kernel Socket.440machine # [ 1.582648] systemd[1]: Reached target Socket Units.441machine # [ 1.584800] systemd[1]: Starting Create List of Static Device Nodes...442machine # [ 1.594613] systemd[1]: Starting Load Kernel Module 9pnet_virtio...443machine # [ 1.595723] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs444machine # [ 1.608923] systemd[1]: Mounting Kernel Configuration File System...445machine # [ 1.627658] systemd[1]: Starting Journal Service...446machine # [ 1.635777] systemd[1]: Starting Load Kernel Modules...447machine # [ 1.636634] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os448machine # [ 1.671683] systemd[1]: Starting Coldplug All udev Devices...449machine # [ 1.686212] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.450machine # [ 1.695647] systemd[1]: Finished Create List of Static Device Nodes.451machine # [ 1.697178] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.452machine # [ 1.697500] systemd[1]: Finished Load Kernel Module 9pnet_virtio.453machine # [ 1.697733] systemd[1]: Mounted Kernel Configuration File System.454machine # [ 1.709601] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...455machine # [ 1.712525] systemd-journald[73]: Collecting audit messages is disabled.456machine # [ 1.713856] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev457machine # [ 1.718625] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2458machine # [ 1.718850] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0459machine # [ 1.738059] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0460machine # [ 1.738303] [drm] features: -virgl +edid -resource_blob -host_visible461machine # [ 1.738314] [drm] features: -context_init462machine # [ 1.739085] [drm] number of scanouts: 1463machine # [ 1.739102] [drm] number of cap sets: 0464machine # [ 1.752193] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic465machine # [ 1.752219] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0466machine # [ 1.780122] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.467machine # [ 1.788036] systemd[1]: Starting Create Static Device Nodes in /dev...468machine # [ 1.815490] Console: switching to colour frame buffer device 160x50469machine # [ 1.816201] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device470machine # [ 1.828038] systemd[1]: Finished Load Kernel Modules.471machine # [ 1.831542] systemd[1]: Starting Apply Kernel Variables...472machine # [ 1.863804] systemd[1]: Finished Create Static Device Nodes in /dev.473machine # [ 1.864090] systemd[1]: Reached target Preparation for Local File Systems.474machine # [ 1.864133] systemd[1]: Reached target Local File Systems.475machine # [ 1.871895] systemd[1]: Starting Rule-based Manager for Device Events and Files...476machine # [ 1.900233] systemd[1]: Finished Apply Kernel Variables.477machine # [ 1.898136] systemd-modules-load[74]: Inserted module 'dm_mod'478machine # [ 1.899480] systemd-modules-load[74]: Module 'virtio_balloon' is built in479machine # [ 1.916129] systemd[1]: Started Journal Service.480machine # [ 1.906396] systemd-modules-load[74]: Module 'virtio_console' is built in481machine # [ 1.920341] systemd-modules-load[74]: Inserted module 'virtio_gpu'482machine # [ 1.921537] systemd-modules-load[74]: Module 'virtio_rng' is built in483machine # [ 1.923211] systemd[1]: Starting Create System Files and Directories...484machine # [ 1.961159] systemd-udevd[81]: Using default interface naming scheme 'v261'.485machine # [ 1.977756] systemd[1]: Finished Create System Files and Directories.486machine # [ 2.002073] systemd[1]: Started Rule-based Manager for Device Events and Files.487machine # [ 2.088292] systemd[1]: Starting Virtual Console Setup...488machine # [ 2.161871] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.489machine # [ 2.165840] systemd[1]: Finished Virtual Console Setup.490machine # [ 2.776347] systemd[1]: Finished Coldplug All udev Devices.491machine # [ 2.777586] systemd[1]: Reached target System Initialization.492machine # [ 2.780098] systemd[1]: Reached target Basic System.493machine # [ 2.940321] (udev-worker)[100]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.494machine # [ 2.950107] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.495machine # [ 2.957093] (udev-worker)[100]: Network interface NamePolicy= disabled on kernel command line.496machine # [ 2.999632] systemd[1]: Found device /dev/disk/by-label/nixos.497machine # [ 3.002983] systemd[1]: Reached target Initrd Root Device.498machine # [ 3.006895] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...499machine # [ 3.058935] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks500machine # [ 3.065976] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.501machine # [ 3.072152] systemd[1]: Mounting /sysroot...502machine # [ 3.127600] EXT4-fs (vda): mounted filesystem a17311b5-a106-4f46-b3e0-5e2df341944f r/w with ordered data mode. Quota mode: none.503machine # [ 3.117218] systemd[1]: Mounted /sysroot.504machine # [ 3.119390] systemd[1]: Reached target Initrd Root File System.505machine # [ 3.124829] systemd[1]: Starting Mountpoints Configured in the Real Root...506machine # [ 3.152157] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload.507machine # [ 3.160717] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)...508machine # [ 3.162427] systemd[1]: Reloading...509machine # [ 3.363073] systemd[1]: Reloading finished in 198 ms.510machine # [ 3.399865] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace...511machine # [ 3.402875] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace...512machine # [ 3.409951] systemd[1]: Starting Load Kernel Module 9pnet_virtio...513machine # [ 3.413057] systemd[1]: initrd-parse-etc.service: Deactivated successfully.514machine # [ 3.420948] systemd[1]: Finished Mountpoints Configured in the Real Root.515machine # [ 3.421992] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.516machine # [ 3.441928] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.517machine # [ 3.444968] systemd[1]: Finished Load Kernel Module 9pnet_virtio.518machine # [ 3.663602] systemd[1]: Mounting /sysroot/nix/.ro-store...519machine # [ 3.679734] systemd[1]: Mounting /sysroot/nix/.rw-store...520machine # [ 3.685933] systemd[1]: Mounting /sysroot/run...521machine # [ 3.718885] systemd[1]: Mounting /sysroot/tmp/shared...522machine # [ 3.726458] systemd[1]: Mounting /sysroot/tmp/xchg...523machine # [ 3.763602] systemd[1]: Mounted /sysroot/nix/.rw-store.524machine # [ 3.784824] systemd[1]: Mounted /sysroot/nix/.ro-store.525machine # [ 3.786532] systemd[1]: Mounted /sysroot/run.526machine # [ 3.799444] systemd[1]: Mounted /sysroot/tmp/shared.527machine # [ 3.808341] systemd[1]: Starting rw-sysroot-nix-store.service...528machine # [ 3.811651] systemd[1]: Mounted /sysroot/tmp/xchg.529machine # [ 3.842178] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.530machine # [ 3.845203] systemd[1]: Finished rw-sysroot-nix-store.service.531machine # [ 4.346856] (udev-worker)[99]: mtd0ro: Failed to find and pin callout binary "/nix/store/al6cj5spvahmdvpsa9qpx1vsrrchbdrx-systemd-262-a7fc55f/lib/udev/mtd_probe": No such file or directory532machine # [ 4.353918] (udev-worker)[99]: mtd0ro: /nix/store/al6cj5spvahmdvpsa9qpx1vsrrchbdrx-systemd-262-a7fc55f/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory533machine # [ 4.384125] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.534machine # [ 4.386484] systemd[1]: Stopped Virtual Console Setup.535machine # [ 4.392129] systemd[1]: Stopping Virtual Console Setup...536machine # [ 4.393073] systemd[1]: Starting Virtual Console Setup...537machine # [ 4.412473] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.538machine # [ 4.414123] systemd[1]: Stopped Virtual Console Setup.539machine # [ 4.417750] systemd[1]: Starting Virtual Console Setup...540machine # [ 4.447647] systemd-vconsole-setup[156]: Configuration of first virtual console was skipped, ignoring remaining ones.541machine # [ 4.451434] systemd[1]: Finished Virtual Console Setup.542machine # [ 4.669254] systemd[1]: Mounting /sysroot/nix/store...543machine # [ 4.747445] systemd[1]: Mounted /sysroot/nix/store.544machine # [ 4.752425] systemd[1]: Reached target Initrd File Systems.545machine # [ 4.758223] systemd[1]: Starting Find NixOS closure...546machine # [ 4.768434] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...547machine # [ 4.811554] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.548machine # [ 4.816260] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.549machine # [ 4.830068] systemd[1]: Finished Find NixOS closure.550machine # [ 4.832534] systemd[1]: Reached target Initrd Default Target.551machine # [ 4.835725] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...552machine # [ 4.864544] systemd[1]: Stopped target Initrd Default Target.553machine # [ 4.866208] systemd[1]: Stopped target Basic System.554machine # [ 4.868580] systemd[1]: Stopped target Initrd Root Device.555machine # [ 4.872380] systemd[1]: Stopped target Path Units.556machine # [ 4.873374] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.557machine # [ 4.876260] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.558machine # [ 4.880162] systemd[1]: Stopped target Slice Units.559machine # [ 4.881152] systemd[1]: Stopped target Socket Units.560machine # [ 4.882967] systemd[1]: Stopped target System Initialization.561machine # [ 4.888150] systemd[1]: Stopped target Swaps.562machine # [ 4.888971] systemd[1]: Stopped target Timer Units.563machine # [ 4.889780] systemd[1]: dbus.socket: Deactivated successfully.564machine # [ 4.890706] systemd[1]: Closed D-Bus System Message Bus Socket.565machine # [ 4.891679] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.566machine # [ 4.896309] systemd[1]: Stopped Find NixOS closure.567machine # [ 4.899500] systemd[1]: Starting Load Kernel Module 9pnet_virtio...568machine # [ 4.902932] systemd[1]: Starting rw-sysroot-nix-store.service...569machine # [ 4.906955] systemd[1]: systemd-sysctl.service: Deactivated successfully.570machine # [ 4.916191] systemd[1]: Stopped Apply Kernel Variables.571machine # [ 4.920344] systemd[1]: systemd-modules-load.service: Deactivated successfully.572machine # [ 4.926754] systemd[1]: Stopped Load Kernel Modules.573machine # [ 4.932448] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.574machine # [ 4.938200] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.575machine # [ 4.939512] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.576machine # [ 4.943439] systemd[1]: Stopped Create System Files and Directories.577machine # [ 4.944704] systemd[1]: Stopped target Local File Systems.578machine # [ 4.946846] systemd[1]: Stopped target Preparation for Local File Systems.579machine # [ 4.949757] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.580machine # [ 4.951150] systemd[1]: Stopped Coldplug All udev Devices.581machine # [ 4.956298] systemd[1]: Stopping Rule-based Manager for Device Events and Files...582machine # [ 4.957480] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.583machine # [ 4.958538] systemd[1]: Stopped Virtual Console Setup.584machine # [ 4.959967] systemd[1]: initrd-cleanup.service: Deactivated successfully.585machine # [ 4.961234] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.586machine # [ 4.962218] systemd[1]: systemd-udevd.service: Deactivated successfully.587machine # [ 4.963195] systemd[1]: Stopped Rule-based Manager for Device Events and Files.588machine # [ 4.964344] systemd[1]: systemd-udevd.service: Consumed 1.502s CPU time over 3.081s wall clock time, 22.1M memory peak.589machine # [ 4.965855] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.590machine # [ 4.966926] systemd[1]: Finished Load Kernel Module 9pnet_virtio.591machine # [ 4.972113] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.592machine # [ 4.973301] systemd[1]: Finished rw-sysroot-nix-store.service.593machine # [ 4.976313] systemd[1]: Starting Cleanup udev Database...594machine # [ 4.977519] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.595machine # [ 4.980254] systemd[1]: Stopped Create Static Device Nodes in /dev.596machine # [ 4.984157] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.597machine # [ 4.985655] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.598machine # [ 4.988103] systemd[1]: kmod-static-nodes.service: Deactivated successfully.599machine # [ 4.989135] systemd[1]: Stopped Create List of Static Device Nodes.600machine # [ 5.016861] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.601machine # [ 5.018512] systemd[1]: Finished Cleanup udev Database.602machine # [ 5.020476] systemd[1]: Reached target Switch Root.603machine # [ 5.022444] systemd[1]: Starting NixOS Activation...604machine # [ 5.202663] initrd-nixos-activation-start[181]: booting system configuration /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test605machine # [ 5.272476] initrd-nixos-activation-start[181]: running activation script...606machine # [ 5.740370] initrd-nixos-activation-start[204]: setting up /etc...607machine # [ 6.021943] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.608machine # [ 6.025115] systemd[1]: Finished NixOS Activation.609machine # [ 6.028209] systemd[1]: Starting Switch Root...610machine # [ 6.054409] systemd[1]: Switching root.611machine # [ 6.251763] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).612machine # [ 6.861439] systemd[1]: systemd 262-a7fc55f 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)613machine # [ 6.874289] systemd[1]: Detected virtualization qemu.614machine # [ 6.877759] systemd[1]: Detected architecture arm64.615machine # [ 6.880921] systemd[1]: Detected first boot.616machine # [ 6.886288] systemd[1]: Initializing machine ID from random generator.617machine # [ 7.028579] systemd[1]: bpf-restrict-fs: LSM BPF program attached618machine # [ 7.201724] systemd[1]: Applying preset policy.619machine # [ 7.740293] systemd[1]: Populated /etc with preset unit settings.620machine # [ 8.284499] systemd[1]: initrd-switch-root.service: Deactivated successfully.621machine # [ 8.285888] systemd[1]: Stopped initrd-switch-root.service.622machine # [ 8.289351] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.623machine # [ 8.293614] systemd[1]: Created slice Slice /system/getty.624machine # [ 8.295974] systemd[1]: Created slice User and Session Slice.625machine # [ 8.298287] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.626machine # [ 8.299918] systemd[1]: Started Forward Password Requests to Wall Directory Watch.627machine # [ 8.301725] systemd[1]: Expecting device /dev/hvc0...628machine # [ 8.303286] systemd[1]: Expecting device /dev/ttyAMA0...629machine # [ 8.305742] systemd[1]: Reached target Local Encrypted Volumes.630machine # [ 8.307923] systemd[1]: Stopped target initrd-fs.target.631machine # [ 8.309864] systemd[1]: Stopped target initrd-root-fs.target.632machine # [ 8.312052] systemd[1]: Stopped target initrd-switch-root.target.633machine # [ 8.313210] systemd[1]: Reached target Virtual Machines and Containers.634machine # [ 8.316063] systemd[1]: Reached target Path Units.635machine # [ 8.317056] systemd[1]: Reached target Remote File Systems.636machine # [ 8.318749] systemd[1]: Reached target Slice Units.637machine # [ 8.320648] systemd[1]: Reached target Swaps.638machine # [ 8.325603] systemd[1]: Listening on Query the User Interactively for a Password.639machine # [ 8.331143] systemd[1]: Listening on Process Core Dump Socket.640machine # [ 8.335324] systemd[1]: Listening on Credential Encryption/Decryption.641machine # [ 8.339554] systemd[1]: Listening on Factory Reset Management.642machine # [ 8.340822] systemd[1]: Listening on Hostname Service Socket.643machine # [ 8.347260] systemd[1]: Starting Journal Log Access Socket...644machine # [ 8.349493] systemd[1]: Listening on Journal Audit Socket.645machine # [ 8.353702] systemd[1]: Listening on Console Output Muting Service Socket.646machine # [ 8.355320] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.647machine # [ 8.357033] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os648machine # [ 8.360246] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki649machine # [ 8.372272] systemd[1]: Listening on Disk Repartitioning Service Socket.650machine # [ 8.373787] systemd[1]: Listening on udev Varlink Socket.651machine # [ 8.379229] systemd[1]: Mounting Huge Pages File System...652machine # [ 8.385597] systemd[1]: Mounting POSIX Message Queue File System...653machine # [ 8.395301] systemd[1]: Mounting Kernel Debug File System...654machine # [ 8.407795] systemd[1]: Mounting Kernel Trace File System...655machine # [ 8.428751] systemd[1]: Starting Create List of Static Device Nodes...656machine # [ 8.447940] systemd[1]: Starting Load Kernel Module 9pnet_virtio...657machine # [ 8.449724] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs658machine # [ 8.467518] systemd[1]: Mounting Kernel Configuration File System...659machine # [ 8.471168] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm660machine # [ 8.479693] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore661machine # [ 8.553303] systemd[1]: Starting Load Kernel Module fuse...662machine # [ 8.555889] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67663machine # [ 8.599036] systemd[1]: Starting Journal Service...664machine # [ 8.623209] systemd[1]: Starting Load Kernel Modules...665machine # [ 8.653930] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...666machine # [ 8.680759] systemd[1]: Starting Remount Root and Kernel File Systems...667machine # [ 8.687373] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os668machine # [ 8.722013] fuse: init (API version 7.45)669machine # [ 8.726575] systemd[1]: Starting Coldplug All udev Devices...670machine # [ 8.754474] systemd[1]: Listening on Journal Log Access Socket.671machine # [ 8.778069] systemd-journald[276]: Collecting audit messages is enabled.672machine # [ 8.781931] systemd[1]: Queued start job for default target Multi-User System.673machine # [ 8.798655] systemd[1]: Mounted Huge Pages File System.674machine # [ 8.806004] systemd[1]: Started Journal Service.675machine # [ 8.794478] systemd[1]: systemd-journald.service: Deactivated successfully.676machine # [ 8.804575] systemd-modules-load[277]: Module 'atkbd' is built in677machine # [ 8.812895] systemd-modules-load[277]: Module 'loop' is built in678machine # [ 8.819665] systemd[1]: Mounted POSIX Message Queue File System.679machine # [ 8.828301] systemd[1]: Mounted Kernel Debug File System.680machine # [ 8.829437] systemd[1]: Mounted Kernel Trace File System.681machine # [ 8.830435] systemd[1]: Finished Create List of Static Device Nodes.682machine # [ 8.831595] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.683machine # [ 8.847179] systemd[1]: Finished Load Kernel Module 9pnet_virtio.684machine # [ 8.858067] systemd[1]: Mounted Kernel Configuration File System.685machine # [ 8.864577] systemd[1]: modprobe@fuse.service: Deactivated successfully.686machine # [ 8.869552] systemd[1]: Finished Load Kernel Module fuse.687machine # [ 8.880823] systemd[1]: Finished Load Kernel Modules.688machine # [ 8.891790] systemd[1]: Mounting FUSE Control File System...689machine # [ 8.919756] EXT4-fs (vda): re-mounted a17311b5-a106-4f46-b3e0-5e2df341944f.690machine # [ 8.910605] systemd[1]: Starting Firewall...691machine # [ 8.925650] systemd-oomd[278]: No swap; memory pressure usage will be degraded692machine # [ 8.936502] systemd[1]: Starting Apply Kernel Variables...693machine # [ 8.957792] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...694machine # [ 8.974836] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.695machine # [ 8.982934] systemd[1]: Finished Remount Root and Kernel File Systems.696machine # [ 9.022419] systemd[1]: Listening on Disk Image Download Service Socket.697machine # [ 9.044845] systemd[1]: Starting Flush Journal to Persistent Storage...698machine # [ 9.054360] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore699machine # [ 9.085666] systemd[1]: Starting Load/Save OS Random Seed...700machine # [ 9.089757] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os701machine # [ 9.153782] systemd[1]: Mounted FUSE Control File System.702machine # [ 9.159449] systemd[1]: Finished Apply Kernel Variables.703machine # [ 9.210078] systemd-journald[276]: Received client request to flush runtime journal.704machine # [ 9.282247] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.705machine # [ 9.296236] systemd[1]: Starting Create Static Device Nodes in /dev...706machine # [ 9.297960] systemd[1]: Finished Load/Save OS Random Seed.707machine # [ 9.298827] systemd[1]: Reached target First Boot Complete.708machine # [ 9.299674] systemd[1]: Finished Flush Journal to Persistent Storage.709machine # [ 9.358992] systemd[1]: Finished Create Static Device Nodes in /dev.710machine # [ 9.361618] systemd[1]: Reached target Preparation for Local File Systems.711machine # [ 9.374541] systemd[1]: Mounting /run/wrappers...712machine # [ 9.381440] systemd[1]: Starting Rule-based Manager for Device Events and Files...713machine # [ 9.457617] systemd[1]: Mounted /run/wrappers.714machine # [ 9.458806] systemd[1]: Reached target Local File Systems.715machine # [ 9.464966] systemd[1]: Listening on Boot Loader Control Service Socket.716machine # [ 9.471336] systemd[1]: Starting register-nix-paths.service...717machine # [ 9.495531] systemd[1]: Starting Create SUID/SGID Wrappers...718machine # [ 9.503054] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.719machine # [ 9.514240] systemd[1]: Starting Save Transient machine-id to Disk...720machine # [ 9.524578] systemd[1]: Starting Create System Files and Directories...721machine # [ 9.568158] systemd-udevd[318]: Using default interface naming scheme 'v261'.722machine # [ 9.652510] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.723machine # [ 9.674699] systemd[1]: Finished Save Transient machine-id to Disk.724machine # [ 9.808951] systemd[1]: Finished Create System Files and Directories.725machine # [ 9.815343] systemd[1]: Starting Rebuild Journal Catalog...726machine # [ 9.833604] systemd[1]: Starting Record System Boot/Shutdown in UTMP...727machine # [ 9.897185] systemd[1]: Started Rule-based Manager for Device Events and Files.728machine # [ 10.001123] systemd[1]: Finished Record System Boot/Shutdown in UTMP.729machine # [ 10.079652] systemd[1]: Finished Rebuild Journal Catalog.730machine # [ 10.089472] systemd[1]: Starting Update is Completed...731machine # [ 10.185126] systemd[1]: Finished Update is Completed.732machine # [ 10.565576] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.733machine # [ 10.567473] systemd[1]: Finished Create SUID/SGID Wrappers.734machine # [ 11.266878] systemd[1]: Finished Coldplug All udev Devices.735machine # [ 11.311121] systemd[1]: Finished register-nix-paths.service.736machine # [ 11.315352] systemd[1]: Reached target System Initialization.737machine # [ 11.317231] systemd[1]: Started Discard unused filesystem blocks once a week.738machine # [ 11.323867] systemd[1]: Started Daily Cleanup of Temporary Directories.739machine # [ 11.325637] systemd[1]: Reached target Timer Units.740machine # [ 11.330220] systemd[1]: Listening on D-Bus System Message Bus Socket.741machine # [ 11.336224] systemd[1]: Listening on Nix Daemon Socket.742machine # [ 11.339442] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.743machine # [ 11.346198] systemd[1]: Reached target Socket Units.744machine # [ 11.348328] systemd[1]: Reached target Basic System.745machine # [ 11.350902] systemd[1]: Starting Import lastlog data into lastlog2 database...746machine # [ 11.356146] systemd[1]: Starting Name Service Cache Daemon (nsncd)...747machine # [ 11.372168] systemd[1]: Starting Post-Boot Actions...748machine # [ 11.405866] systemd[1]: Started Reset console on configuration changes.749machine # [ 11.437818] systemd[1]: Starting resolvconf update...750machine # [ 11.526599] systemd[1]: Starting D-Bus System Message Bus...751machine # [ 11.533033] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs752machine # [ 11.544505] nsncd[474]: Sep 08 02:41:57.108 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"753machine # [ 11.555686] systemd[1]: Started Name Service Cache Daemon (nsncd).754machine # [ 11.563465] systemd[1]: Finished Post-Boot Actions.755machine # [ 11.582772] systemd[1]: Finished Firewall.756machine # [ 11.601371] systemd[1]: Finished Import lastlog data into lastlog2 database.757machine # [ 11.603862] systemd[1]: Reached target Host and Network Name Lookups.758machine # [ 11.609948] systemd[1]: Reached target User and Group Name Lookups.759machine # [ 11.620086] systemd[1]: Starting User Login Management...760machine # [ 11.770096] dbus-broker-launch[489]: Looking up NSS user entry for 'systemd-timesync'...761machine # [ 11.778362] dbus-broker-launch[489]: NSS returned no entry for 'systemd-timesync'762machine # [ 11.783988] dbus-broker-launch[489]: Invalid user-name in /nix/store/p0q5ywvkhrmap6b63w7jnsz6dv3rdl9z-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"763machine # [ 11.805777] systemd-logind[507]: New seat seat0.764machine # [ 11.812375] systemd[1]: Started User Login Management.765machine # [ 11.819112] systemd[1]: Starting linger-users.service...766machine # [ 11.841667] systemd[1]: Started D-Bus System Message Bus.767machine # [ 11.877748] systemd[1]: Stopped target Host and Network Name Lookups.768machine # [ 11.884713] systemd[1]: Stopping Host and Network Name Lookups...769machine # [ 11.888833] systemd[1]: Stopped target User and Group Name Lookups.770machine # [ 11.896596] systemd[1]: Stopping User and Group Name Lookups...771machine # [ 11.900791] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...772machine # [ 11.909885] dbus-broker-launch[489]: Ready773machine # [ 11.913287] systemd[1]: nscd.service: Deactivated successfully.774machine # [ 11.919883] systemd[1]: Stopped Name Service Cache Daemon (nsncd).775machine # [ 11.941382] systemd[1]: Starting Name Service Cache Daemon (nsncd)...776machine # [ 12.014760] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.777machine # [ 12.042670] systemd[1]: Created slice Slice /user/1001.778machine # [ 12.055262] systemd[1]: Starting User Runtime Directory /run/user/1001...779machine # [ 12.096672] systemd[1]: linger-users.service: Deactivated successfully.780machine # [ 12.097810] systemd[1]: Finished linger-users.service.781machine # [ 12.098596] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.782machine # [ 12.150530] systemd[1]: Started backdoor.service.783machine # [ 12.161201] nsncd[559]: Sep 08 02:41:57.720 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"784machine # [ 12.195449] systemd[1]: Started Name Service Cache Daemon (nsncd).785machine # [ 12.224730] systemd[1]: Reached target Host and Network Name Lookups.786machine # [ 12.249373] systemd[1]: Reached target User and Group Name Lookups.787machine # [ 12.281393] systemd[1]: Finished User Runtime Directory /run/user/1001.788machine # [ 12.311902] systemd[1]: Starting User Manager for UID 1001...789machine # [ 12.330899] systemd[1]: Finished resolvconf update.790machine # [ 12.355882] systemd[1]: Reached target Preparation for Network.791machine # [ 12.369626] systemd[1]: Starting DHCP Client...792machine # [ 12.385786] systemd[1]: Starting Extra networking commands....793machine # [ 12.405349] (udev-worker)[447]: Network interface NamePolicy= disabled on kernel command line.794machine # [ 12.441388] (systemd)[585]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0)795machine # [ 12.479726] (udev-worker)[366]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.796machine # [ 12.546991] (udev-worker)[366]: Network interface NamePolicy= disabled on kernel command line.797machine # [ 12.573127] systemd-logind[507]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'.798machine # [ 12.589853] systemd-logind[507]: Watching system buttons on /dev/input/event0 (gpio-keys)799machine # [ 12.607254] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy800machine # connecting to host...801machine # [ 12.703617] systemd[1]: Condition check resulted in Virtio network device being skipped.802machine # [ 12.715206] systemd[1]: Starting Address configuration of eth1...803machine: Guest shell says: b'Spawning backdoor root shell...\n'804machine: connected to guest root shell805machine: (connecting took 13.08 seconds)806machine: (finished: waiting for the VM to finish booting, in 13.60 seconds)807machine # [ 12.841571] systemd[585]: Queued start job for default target Main User Target.808machine # [ 12.850552] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy809machine # [ 12.869249] systemd[585]: Created slice User Application Slice.810machine # [ 12.887948] systemd[585]: Started Daily Cleanup of User's Temporary Directories.811machine # [ 12.896935] systemd[585]: Reached target Paths.812machine # [ 12.904606] systemd[585]: Reached target Timers.813machine # [ 12.923008] systemd[585]: Starting D-Bus User Message Bus Socket...814machine # [ 12.943763] systemd[585]: Starting Create User Files and Directories...815machine # [ 12.970636] systemd[585]: Finished Create User Files and Directories.816machine # [ 13.020571] systemd[585]: Listening on D-Bus User Message Bus Socket.817machine # [ 13.044758] systemd[585]: Reached target Sockets.818machine # [ 13.067453] systemd[585]: Reached target Basic System.819machine # [ 13.092813] systemd[585]: Starting Run user-specific NixOS activation...820machine # [ 13.122301] systemd[1]: Started User Manager for UID 1001.821machine # [ 13.142191] systemd[585]: Finished Run user-specific NixOS activation.822machine # [ 13.143661] network-addresses-eth1-start[603]: adding address 192.168.1.1/24... done823machine # [ 13.178348] systemd[585]: Reached target Main User Target.824machine # [ 13.179264] systemd[585]: Startup finished in 616ms.825machine # [ 13.244439] mousedev: PS/2 mouse device common for all mice826machine # [ 13.236317] network-addresses-eth1-start[603]: adding address 2001:db8:1::1/64... done827machine # [ 13.300389] systemd-logind[507]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)828machine # [ 13.316174] systemd[1]: Finished Address configuration of eth1.829machine # [ 13.325113] dhcpcd[608]: dhcpcd-10.3.2 starting830machine # [ 13.347251] dhcpcd[686]: dev: loaded udev831machine # [ 13.404758] 8021q: 802.1Q VLAN Support v1.8832machine # [ 13.405178] 8021q: adding VLAN 0 to HW filter on device eth1833machine # [ 13.497550] cfg80211: Loading compiled-in X.509 certificates for regulatory database834machine # [ 13.531869] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'835machine # [ 13.532414] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'836machine # [ 13.537828] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2837machine # [ 13.538163] cfg80211: failed to load regulatory.db838machine # [ 13.557700] systemd[1]: Finished Extra networking commands..839machine # [ 13.558645] systemd[1]: Reached target Network.840machine # [ 13.581184] systemd[1]: Starting Permit User Sessions...841machine # [ 13.828764] systemd[1]: Finished Permit User Sessions.842machine # [ 13.844276] systemd[1]: Started Getty on tty1.843machine # [ 13.855678] systemd[1]: Reached target Login Prompts.844machine # [ 13.996072] 8021q: adding VLAN 0 to HW filter on device eth0845machine # [ 13.986080] dhcpcd[686]: eth0: waiting for carrier846machine # [ 13.991738] dhcpcd[686]: eth0: carrier acquired847machine # [ 14.034697] dhcpcd[686]: DUID 00:01:00:01:32:32:32:77:52:54:00:12:34:56848machine # [ 14.035796] dhcpcd[686]: eth0: IAID 00:12:34:56849machine # [ 14.051347] dhcpcd[686]: eth0: adding address fe80::5054:ff:fe12:3456850machine # [ 14.321917] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3851machine # [ 14.701248] systemd[1]: Starting Virtual Console Setup...852machine # [ 14.718591] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.853machine # [ 14.781482] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.854machine # [ 14.782645] systemd[1]: Stopped Virtual Console Setup.855machine # [ 14.786395] systemd[1]: Starting Virtual Console Setup...856machine # [ 14.795731] systemd-logind[507]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)857machine # [ 15.139858] dhcpcd[686]: eth0: soliciting a DHCP lease858machine # [ 15.148656] dhcpcd[686]: eth0: offered 10.0.2.15 from 10.0.2.2859machine # [ 15.152238] dhcpcd[686]: eth0: probing address 10.0.2.15/24860machine # [ 15.287783] systemd-vconsole-setup[724]: Configuration of first virtual console was skipped, ignoring remaining ones.861machine # [ 15.294856] systemd[1]: Finished Virtual Console Setup.862machine # [ 16.611289] dhcpcd[686]: eth0: soliciting an IPv6 router863machine # [ 16.615710] dhcpcd[686]: eth0: Router Advertisement from fe80::2864machine # [ 16.618811] dhcpcd[686]: eth0: adding address fec0::5054:ff:fe12:3456/64865machine # [ 16.622050] dhcpcd[686]: eth0: adding route to fec0::/64866machine # [ 16.624668] dhcpcd[686]: eth0: adding default route via fe80::2867machine # [ 19.845493] dhcpcd[686]: eth0: leased 10.0.2.15 for 86400 seconds868machine # [ 19.850905] dhcpcd[686]: eth0: adding route to 10.0.2.0/24869machine # [ 19.854355] dhcpcd[686]: eth0: adding default route via 10.0.2.2870machine # [ 20.050187] systemd[1]: Started DHCP Client.871machine # [ 20.052772] systemd[1]: Reached target Multi-User System.872machine # [ 20.053730] systemd[1]: Startup finished in 993ms (kernel) + 5.369s (initrd) + 13.689s (userspace) = 20.052s.873machine: (finished: waiting for unit multi-user.target, in 21.31 seconds)874machine: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/bin/switch-to-configuration test875machine # Checking switch inhibitors... done876machine # [ 21.122784] nixos[833]: switching to system configuration /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test877machine # activating the configuration...878machine # [ 21.127739] systemd[1]: Stopped target Local File Systems.879machine # [ 21.128986] systemd[1]: Stopped target Remote File Systems.880machine # setting up /etc...881machine # [ 21.666244] systemd[1]: Reload requested from client PID 833 ('.switch-to-conf') (unit backdoor.service)...882machine # [ 21.668463] systemd[1]: Reloading...883machine # [ 22.310815] systemd[1]: Reloading finished in 639 ms.884machine # reloading user units for usertest...885machine # [ 22.370797] systemd[585]: Created slice User Core Session Slice.886machine # [ 22.374714] systemd[585]: Starting D-Bus User Message Bus...887machine # [ 22.444873] dbus-broker-launch[903]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/p0q5ywvkhrmap6b63w7jnsz6dv3rdl9z-system-path/share/dbus-1/services/org.freedesktop.import1.service'888machine # [ 22.448643] dbus-broker-launch[903]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/p0q5ywvkhrmap6b63w7jnsz6dv3rdl9z-system-path/share/dbus-1/services/org.freedesktop.machine1.service'889machine # [ 22.452121] dbus-broker-launch[903]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/p0q5ywvkhrmap6b63w7jnsz6dv3rdl9z-system-path/share/dbus-1/services/org.freedesktop.portable1.service'890machine # [ 22.455651] dbus-broker-launch[903]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/p0q5ywvkhrmap6b63w7jnsz6dv3rdl9z-system-path/share/dbus-1/services/org.freedesktop.systemd1.service'891machine # [ 22.460097] dbus-broker-launch[903]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored892machine # [ 22.461799] dbus-broker-launch[903]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored893machine # [ 22.465080] systemd[585]: Started D-Bus User Message Bus.894machine # [ 22.472973] dbus-broker-launch[903]: Ready895machine # [ 22.591981] systemd[585]: Reexecution requested from client PID 902 ('switch-to-confi')...896machine # [ 22.596271] systemd[585]: Reexecuting.897machine # [ 22.658985] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy898machine # [ 22.864824] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy899machine # [ 22.872465] systemd[585]: Reload requested from client PID 902 ('switch-to-confi')...900machine # [ 22.874755] systemd[585]: Reloading...901machine # [ 23.075641] systemd[585]: Reloading finished in 199 ms.902machine # [ 23.088169] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy903machine # restarting the following user units: nixos-activation.service904machine # [ 23.099162] systemd[585]: Stopped Run user-specific NixOS activation.905machine # [ 23.101604] systemd[585]: Stopping Run user-specific NixOS activation...906machine # [ 23.104524] systemd[585]: Starting Run user-specific NixOS activation...907machine # [ 23.155853] systemd[585]: Finished Run user-specific NixOS activation.908machine # restarting sysinit-reactivation.target909machine # [ 23.174038] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....910machine # [ 23.300137] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..911machine # [ 23.303817] systemd[1]: Reached target Reactivate sysinit units.912machine # [ 23.307193] systemd[1]: Reached target Local File Systems.913machine # [ 23.309065] systemd[1]: Reached target Remote File Systems.914machine # [ 23.313698] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os915machine # [ 23.317008] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki916machine # [ 23.322281] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore917machine # [ 23.330205] systemd[1]: Starting Create SUID/SGID Wrappers...918machine # [ 23.331136] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.919machine # [ 23.333963] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67920machine # [ 23.338330] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore921machine # [ 23.340318] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os922machine # [ 23.344200] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os923machine # [ 23.716799] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.924machine # [ 23.720136] systemd[1]: Finished Create SUID/SGID Wrappers.925machine # [ 23.725375] systemd[1]: Starting linger-users.service...926machine # [ 23.790472] systemd[1]: linger-users.service: Deactivated successfully.927machine # [ 23.792685] systemd[1]: Finished linger-users.service.928machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service929machine # [ 24.059520] nixos[833]: finished switching to system configuration /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test930machine: (finished: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/bin/switch-to-configuration test, in 3.60 seconds)931machine: must succeed: rm /etc/NIXOS932machine: (finished: must succeed: rm /etc/NIXOS, in 0.06 seconds)933machine: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/gdfq27p40xv4j5d22l0xygndbns5v258-nixos-system-other-test/bin/switch-to-configuration test934machine # this should succeed (config: /nix/store/gdfq27p40xv4j5d22l0xygndbns5v258-nixos-system-other-test, action: test)935machine # Checking switch inhibitors... done936machine # [ 24.875488] nixos[981]: switching to system configuration /nix/store/gdfq27p40xv4j5d22l0xygndbns5v258-nixos-system-other-test937machine # [ 24.878694] systemd[1]: Stopped target Remote File Systems.938machine # activating the configuration...939machine # [ 24.882368] systemd[1]: Stopped target Local File Systems.940machine # removing user ‘usertest’941machine # setting up /etc...942machine # [ 25.453065] systemd[1]: Reload requested from client PID 981 ('.switch-to-conf') (unit backdoor.service)...943machine # [ 25.455161] systemd[1]: Reloading...944machine # [ 26.185565] systemd[1]: Reloading finished in 726 ms.945machine # reloading user units for usertest...946machine # [ 26.358762] systemd[585]: Reexecution requested from client PID 1052 ('switch-to-confi')...947machine # [ 26.361041] systemd[585]: Reexecuting.948machine # [ 26.430803] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy949machine # [ 26.650054] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy950machine # [ 26.656805] systemd[585]: Reload requested from client PID 1052 ('switch-to-confi')...951machine # [ 26.659616] systemd[585]: Reloading...952machine # [ 26.855046] systemd[585]: Reloading finished in 194 ms.953machine # [ 26.880328] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy954machine # restarting the following user units: nixos-activation.service955machine # [ 26.898455] systemd[585]: Stopped Run user-specific NixOS activation.956machine # [ 26.899518] systemd[585]: Stopping Run user-specific NixOS activation...957machine # [ 26.908673] systemd[585]: Starting Run user-specific NixOS activation...958machine # [ 26.954119] systemd[585]: Finished Run user-specific NixOS activation.959machine # restarting sysinit-reactivation.target960machine # [ 26.960597] systemd[1]: Stopped target Reactivate sysinit units.961machine # reloading the following units: dbus-broker.service[ 26.963670] systemd[1]: Stopping Reactivate sysinit units...962machine # 963machine # [ 26.969748] systemd[1]: Reached target Reactivate sysinit units.964machine # [ 26.970689] systemd[1]: Reloading D-Bus System Message Bus...965machine # [ 26.971857] dbus-broker-launch[489]: Caught SIGHUP, trigger reload.966machine # [ 26.992821] dbus-broker-launch[489]: Looking up NSS user entry for 'systemd-timesync'...967machine # [ 26.995264] dbus-broker-launch[489]: NSS returned no entry for 'systemd-timesync'968machine # [ 26.996650] dbus-broker-launch[489]: Invalid user-name in /nix/store/5ami27v3498r3nf5dqfhr47ik2b9n3as-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"969machine # [ 27.035498] systemd[1]: Reloaded D-Bus System Message Bus.970machine # restarting the following units: network-addresses-eth1.service971machine # [ 27.043380] systemd[1]: Stopping Address configuration of eth1...972machine # [ 27.099555] network-addresses-eth1-pre-stop[1065]: deleting address 192.168.1.1/24... done973machine # [ 27.111701] network-addresses-eth1-pre-stop[1065]: deleting address 2001:db8:1::1/64... done974machine # [ 27.122335] systemd[1]: network-addresses-eth1.service: Deactivated successfully.975machine # [ 27.124555] systemd[1]: Stopped Address configuration of eth1.976machine # [ 27.129408] systemd[1]: Starting Address configuration of eth1...977machine # [ 27.207776] network-addresses-eth1-start[1070]: adding address 192.168.1.2/24... done978machine # [ 27.220186] network-addresses-eth1-start[1070]: adding address 2001:db8:1::2/64... done979machine # [ 27.236504] systemd[1]: Finished Address configuration of eth1.980machine # [ 27.239267] systemd[1]: Reached target Remote File Systems.981machine # [ 27.247631] systemd[1]: Starting linger-users.service...982machine # [ 27.251410] systemd[1]: Reached target Local File Systems.983machine # [ 27.261926] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os984machine # [ 27.263715] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki985machine # [ 27.270773] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore986machine # [ 27.276704] systemd[1]: Starting Create SUID/SGID Wrappers...987machine # [ 27.279048] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.988machine # [ 27.284134] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67989machine # [ 27.286383] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore990machine # [ 27.287947] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os991machine # [ 27.291489] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os992machine # [ 27.337460] linger-users-start[1084]: id: ‘usertest’: no such user993machine # [ 27.340630] linger-users-start[1081]: Removing linger for missing user usertest994machine # [ 27.354254] systemd[1]: linger-users.service: Deactivated successfully.995machine # [ 27.358661] systemd[1]: Finished linger-users.service.996machine # [ 27.743000] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.997machine # [ 27.746305] systemd[1]: Finished Create SUID/SGID Wrappers.998machine # [ 28.001751] nixos[981]: finished switching to system configuration /nix/store/gdfq27p40xv4j5d22l0xygndbns5v258-nixos-system-other-test999machine: (finished: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/gdfq27p40xv4j5d22l0xygndbns5v258-nixos-system-other-test/bin/switch-to-configuration test, in 3.87 seconds)1000subtest: services1001machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/bin/switch-to-configuration test 2>&11002machine # [ 28.646447] nixos[1148]: switching to system configuration /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test1003machine # [ 28.650024] systemd[1]: Stopped target Local File Systems.1004machine # [ 28.651580] systemd[1]: Stopped target Remote File Systems.1005machine # [ 29.129822] systemd[1]: Reload requested from client PID 1148 ('.switch-to-conf') (unit backdoor.service)...1006machine # [ 29.131548] systemd[1]: Reloading...1007machine # [ 29.745909] systemd[1]: Reloading finished in 612 ms.1008machine # [ 29.887179] systemd[585]: Reexecution requested from client PID 1216 ('switch-to-confi')...1009machine # [ 29.889676] systemd[585]: Reexecuting.1010machine # [ 29.954407] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1011machine # [ 30.148048] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1012machine # [ 30.154222] systemd[585]: Reload requested from client PID 1216 ('switch-to-confi')...1013machine # [ 30.156711] systemd[585]: Reloading...1014machine # [ 30.380885] systemd[585]: Reloading finished in 222 ms.1015machine # [ 30.396216] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1016machine # [ 30.405591] systemd[585]: Stopped Run user-specific NixOS activation.1017machine # [ 30.408103] systemd[585]: Stopping Run user-specific NixOS activation...1018machine # [ 30.411649] systemd[585]: Starting Run user-specific NixOS activation...1019machine # [ 30.460701] systemd[585]: Finished Run user-specific NixOS activation.1020machine # [ 30.464915] systemd[1]: Stopped target Reactivate sysinit units.1021machine # [ 30.469050] systemd[1]: Stopping Reactivate sysinit units...1022machine # [ 30.470294] systemd[1]: Reached target Reactivate sysinit units.1023machine # [ 30.471326] systemd[1]: Reloading D-Bus System Message Bus...1024machine # [ 30.472943] dbus-broker-launch[489]: Caught SIGHUP, trigger reload.1025machine # [ 30.486050] dbus-broker-launch[489]: Looking up NSS user entry for 'systemd-timesync'...1026machine # [ 30.488422] dbus-broker-launch[489]: NSS returned no entry for 'systemd-timesync'1027machine # [ 30.489698] dbus-broker-launch[489]: Invalid user-name in /nix/store/p0q5ywvkhrmap6b63w7jnsz6dv3rdl9z-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1028machine # [ 30.522291] systemd[1]: Reloaded D-Bus System Message Bus.1029machine # [ 30.529061] systemd[1]: Stopping Address configuration of eth1...1030machine # [ 30.581489] network-addresses-eth1-pre-stop[1230]: deleting address 192.168.1.2/24... done1031machine # [ 30.593340] network-addresses-eth1-pre-stop[1230]: deleting address 2001:db8:1::2/64... done1032machine # [ 30.602984] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1033machine # [ 30.605081] systemd[1]: Stopped Address configuration of eth1.1034machine # [ 30.609947] systemd[1]: Starting Address configuration of eth1...1035machine # [ 30.685419] network-addresses-eth1-start[1235]: adding address 192.168.1.1/24... done1036machine # [ 30.697682] network-addresses-eth1-start[1235]: adding address 2001:db8:1::1/64... done1037machine # [ 30.713974] systemd[1]: Finished Address configuration of eth1.1038machine # [ 30.719207] systemd[1]: Reached target Remote File Systems.1039machine # [ 30.724939] systemd[1]: Reached target Local File Systems.1040machine # [ 30.727937] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1041machine # [ 30.733276] systemd[1]: Starting Create SUID/SGID Wrappers...1042machine # [ 30.734187] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1043machine # [ 30.735411] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671044machine # [ 30.745577] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1045machine # [ 30.751666] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1046machine # [ 30.753135] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1047machine # [ 30.754348] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1048machine # [ 30.755628] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1049machine # [ 31.080671] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1050machine # [ 31.084311] systemd[1]: Finished Create SUID/SGID Wrappers.1051machine # [ 31.088623] systemd[1]: Starting linger-users.service...1052machine # [ 31.137660] systemd[1]: linger-users.service: Deactivated successfully.1053machine # [ 31.140389] systemd[1]: Finished linger-users.service.1054machine # [ 31.399551] nixos[1148]: finished switching to system configuration /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test1055machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.40 seconds)1056machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/bin/switch-to-configuration test 2>&11057machine # [ 32.013580] nixos[1304]: switching to system configuration /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test1058machine # [ 32.016399] systemd[1]: Stopped target Remote File Systems.1059machine # [ 32.018607] systemd[1]: Stopped target Local File Systems.1060machine # [ 32.481556] systemd[1]: Reload requested from client PID 1304 ('.switch-to-conf') (unit backdoor.service)...1061machine # [ 32.483582] systemd[1]: Reloading...1062machine # [ 33.068313] systemd[1]: Reloading finished in 581 ms.1063machine # [ 33.209740] systemd[585]: Reexecution requested from client PID 1373 ('switch-to-confi')...1064machine # [ 33.211151] systemd[585]: Reexecuting.1065machine # [ 33.273680] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1066machine # [ 33.465696] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1067machine # [ 33.472119] systemd[585]: Reload requested from client PID 1373 ('switch-to-confi')...1068machine # [ 33.474511] systemd[585]: Reloading...1069machine # [ 33.721417] systemd[585]: Reloading finished in 245 ms.1070machine # [ 33.736204] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1071machine # [ 33.746489] systemd[585]: Stopped Run user-specific NixOS activation.1072machine # [ 33.749201] systemd[585]: Stopping Run user-specific NixOS activation...1073machine # [ 33.752340] systemd[585]: Starting Run user-specific NixOS activation...1074machine # [ 33.799925] systemd[585]: Finished Run user-specific NixOS activation.1075machine # [ 33.804635] systemd[1]: Stopped target Reactivate sysinit units.1076machine # [ 33.808662] systemd[1]: Stopping Reactivate sysinit units...1077machine # [ 33.809959] systemd[1]: Reached target Reactivate sysinit units.1078machine # [ 33.812286] systemd[1]: Reached target Local File Systems.1079machine # [ 33.813124] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1080machine # [ 33.820343] systemd[1]: Starting Create SUID/SGID Wrappers...1081machine # [ 33.821219] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1082machine # [ 33.822402] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671083machine # [ 33.827459] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1084machine # [ 33.831213] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1085machine # [ 33.840325] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1086machine # [ 33.841488] systemd[1]: Reached target Remote File Systems.1087machine # [ 33.843827] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1088machine # [ 33.845410] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1089machine # [ 34.162762] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1090machine # [ 34.167617] systemd[1]: Finished Create SUID/SGID Wrappers.1091machine # [ 34.170647] systemd[1]: Starting linger-users.service...1092machine # [ 34.235085] systemd[1]: linger-users.service: Deactivated successfully.1093machine # [ 34.238032] systemd[1]: Finished linger-users.service.1094machine # [ 34.495010] nixos[1304]: finished switching to system configuration /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test1095machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.09 seconds)1096machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11097machine # [ 35.123737] nixos[1445]: switching to system configuration /nix/store/c3p1q0qmdj7q0bigja8qc3n7zsplzdx3-nixos-system-machine-test1098machine # [ 35.126522] systemd[1]: Stopped target Remote File Systems.1099machine # [ 35.129192] systemd[1]: Stopped target Local File Systems.1100machine # [ 35.655003] systemd[1]: Reload requested from client PID 1445 ('.switch-to-conf') (unit backdoor.service)...1101machine # [ 35.657242] systemd[1]: Reloading...1102machine # [ 36.314701] systemd[1]: Reloading finished in 655 ms.1103machine # [ 36.466315] systemd[585]: Reexecution requested from client PID 1514 ('switch-to-confi')...1104machine # [ 36.470083] systemd[585]: Reexecuting.1105machine # [ 36.534388] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1106machine # [ 36.734341] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1107machine # [ 36.742061] systemd[585]: Reload requested from client PID 1514 ('switch-to-confi')...1108machine # [ 36.743471] systemd[585]: Reloading...1109machine # [ 36.973735] systemd[585]: Reloading finished in 227 ms.1110machine # [ 36.988268] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1111machine # [ 36.998059] systemd[585]: Stopped Run user-specific NixOS activation.1112machine # [ 37.000554] systemd[585]: Stopping Run user-specific NixOS activation...1113machine # [ 37.003623] systemd[585]: Starting Run user-specific NixOS activation...1114machine # [ 37.051161] systemd[585]: Finished Run user-specific NixOS activation.1115machine # [ 37.055718] systemd[1]: Stopped target Reactivate sysinit units.1116machine # [ 37.057472] systemd[1]: Stopping Reactivate sysinit units...1117machine # [ 37.058307] systemd[1]: Reached target Reactivate sysinit units.1118machine # [ 37.060005] systemd[1]: Reached target Local File Systems.1119machine # [ 37.063323] systemd[1]: Reached target Remote File Systems.1120machine # [ 37.069610] systemd[1]: Starting linger-users.service...1121machine # [ 37.073682] systemd[1]: Starting test.service...1122machine # [ 37.090488] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1123machine # [ 37.091964] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1124machine # [ 37.098630] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1125machine # [ 37.102738] systemd[1]: Starting Create SUID/SGID Wrappers...1126machine # [ 37.109017] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1127machine # [ 37.114180] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671128machine # [ 37.121930] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1129machine # [ 37.124245] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1130machine # [ 37.125739] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1131machine # [ 37.155221] systemd[1]: Finished test.service.1132machine # [ 37.195068] systemd[1]: linger-users.service: Deactivated successfully.1133machine # [ 37.199148] systemd[1]: Finished linger-users.service.1134machine # [ 37.473672] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1135machine # [ 37.477061] systemd[1]: Finished Create SUID/SGID Wrappers.1136machine # [ 37.738053] nixos[1445]: finished switching to system configuration /nix/store/c3p1q0qmdj7q0bigja8qc3n7zsplzdx3-nixos-system-machine-test1137machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 3.24 seconds)1138machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11139machine # [ 38.326201] nixos[1588]: switching to system configuration /nix/store/c3p1q0qmdj7q0bigja8qc3n7zsplzdx3-nixos-system-machine-test1140machine # [ 38.329275] systemd[1]: Stopped target Remote File Systems.1141machine # [ 38.330935] systemd[1]: Stopped target Local File Systems.1142machine # [ 38.818552] systemd[1]: Reload requested from client PID 1588 ('.switch-to-conf') (unit backdoor.service)...1143machine # [ 38.820779] systemd[1]: Reloading...1144machine # [ 39.417759] systemd[1]: Reloading finished in 594 ms.1145machine # [ 39.572655] systemd[585]: Reexecution requested from client PID 1657 ('switch-to-confi')...1146machine # [ 39.576130] systemd[585]: Reexecuting.1147machine # [ 39.626733] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1148machine # [ 39.818443] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1149machine # [ 39.825769] systemd[585]: Reload requested from client PID 1657 ('switch-to-confi')...1150machine # [ 39.828403] systemd[585]: Reloading...1151machine # [ 40.024930] systemd[585]: Reloading finished in 195 ms.1152machine # [ 40.040451] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1153machine # [ 40.049789] systemd[585]: Stopped Run user-specific NixOS activation.1154machine # [ 40.052397] systemd[585]: Stopping Run user-specific NixOS activation...1155machine # [ 40.055445] systemd[585]: Starting Run user-specific NixOS activation...1156machine # [ 40.104631] systemd[585]: Finished Run user-specific NixOS activation.1157machine # [ 40.109325] systemd[1]: Stopped target Reactivate sysinit units.1158machine # [ 40.112737] systemd[1]: Stopping Reactivate sysinit units...1159machine # [ 40.113770] systemd[1]: Reached target Reactivate sysinit units.1160machine # [ 40.114637] systemd[1]: Reached target Remote File Systems.1161machine # [ 40.122086] systemd[1]: Reached target Local File Systems.1162machine # [ 40.125331] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1163machine # [ 40.132689] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1164machine # [ 40.134115] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1165machine # [ 40.142034] systemd[1]: Starting Create SUID/SGID Wrappers...1166machine # [ 40.143058] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1167machine # [ 40.145497] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671168machine # [ 40.148394] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1169machine # [ 40.150440] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1170machine # [ 40.151892] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1171machine # [ 40.499000] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1172machine # [ 40.503973] systemd[1]: Finished Create SUID/SGID Wrappers.1173machine # [ 40.506611] systemd[1]: Starting linger-users.service...1174machine # [ 40.571490] systemd[1]: linger-users.service: Deactivated successfully.1175machine # [ 40.574060] systemd[1]: Finished linger-users.service.1176machine # [ 40.829930] nixos[1588]: finished switching to system configuration /nix/store/c3p1q0qmdj7q0bigja8qc3n7zsplzdx3-nixos-system-machine-test1177machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 3.09 seconds)1178machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&11179machine # [ 41.492598] nixos[1729]: switching to system configuration /nix/store/s5p4rnl76ih1yznn58f4wa83k9lkabld-nixos-system-machine-test1180machine # [ 41.495859] systemd[1]: Stopped target Local File Systems.1181machine # [ 41.497299] systemd[1]: Stopped target Remote File Systems.1182machine # [ 42.044930] systemd[1]: Reload requested from client PID 1729 ('.switch-to-conf') (unit backdoor.service)...1183machine # [ 42.047037] systemd[1]: Reloading...1184machine # [ 42.737641] systemd[1]: Reloading finished in 687 ms.1185machine # [ 42.886076] systemd[585]: Reexecution requested from client PID 1798 ('switch-to-confi')...1186machine # [ 42.887571] systemd[585]: Reexecuting.1187machine # [ 42.954240] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1188machine # [ 43.152182] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1189machine # [ 43.159370] systemd[585]: Reload requested from client PID 1798 ('switch-to-confi')...1190machine # [ 43.162028] systemd[585]: Reloading...1191machine # [ 43.353156] systemd[585]: Reloading finished in 190 ms.1192machine # [ 43.368199] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1193machine # [ 43.377740] systemd[585]: Stopped Run user-specific NixOS activation.1194machine # [ 43.380161] systemd[585]: Stopping Run user-specific NixOS activation...1195machine # [ 43.383100] systemd[585]: Starting Run user-specific NixOS activation...1196machine # [ 43.430295] systemd[585]: Finished Run user-specific NixOS activation.1197machine # [ 43.434956] systemd[1]: Stopped target Reactivate sysinit units.1198machine # [ 43.436484] systemd[1]: Stopping Reactivate sysinit units...1199machine # [ 43.437351] systemd[1]: Reached target Reactivate sysinit units.1200machine # [ 43.442041] systemd[1]: Reached target Remote File Systems.1201machine # [ 43.447733] systemd[1]: Starting linger-users.service...1202machine # [ 43.451272] systemd[1]: Reached target Local File Systems.1203machine # [ 43.457470] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1204machine # [ 43.458802] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1205machine # [ 43.466158] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1206machine # [ 43.473482] systemd[1]: Starting Create SUID/SGID Wrappers...1207machine # [ 43.474426] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1208machine # [ 43.475694] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671209machine # [ 43.484478] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1210machine # [ 43.490282] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1211machine # [ 43.493892] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1212machine # [ 43.571940] systemd[1]: linger-users.service: Deactivated successfully.1213machine # [ 43.575969] systemd[1]: Finished linger-users.service.1214machine # [ 43.871841] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1215machine # [ 43.875246] systemd[1]: Finished Create SUID/SGID Wrappers.1216machine # [ 44.135046] nixos[1729]: finished switching to system configuration /nix/store/s5p4rnl76ih1yznn58f4wa83k9lkabld-nixos-system-machine-test1217machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 3.31 seconds)1218machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11219machine # [ 44.789899] nixos[1870]: switching to system configuration /nix/store/gy3fjq6p259m8x8mj4dzk49y6m532qkp-nixos-system-machine-test1220machine # [ 44.793942] systemd[1]: Stopped target Local File Systems.1221machine # [ 44.795753] systemd[1]: Stopped target Remote File Systems.1222machine # [ 44.797355] systemd[1]: test.service: Deactivated successfully.1223machine # [ 44.798207] systemd[1]: Stopped Test unit.1224machine # [ 45.327966] systemd[1]: Reload requested from client PID 1870 ('.switch-to-conf') (unit backdoor.service)...1225machine # [ 45.330092] systemd[1]: Reloading...1226machine # [ 45.983305] systemd[1]: Reloading finished in 650 ms.1227machine # [ 46.132547] systemd[585]: Reexecution requested from client PID 1939 ('switch-to-confi')...1228machine # [ 46.137036] systemd[585]: Reexecuting.1229machine # [ 46.190080] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1230machine # [ 46.376794] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1231machine # [ 46.383485] systemd[585]: Reload requested from client PID 1939 ('switch-to-confi')...1232machine # [ 46.387013] systemd[585]: Reloading...1233machine # [ 46.577874] systemd[585]: Reloading finished in 191 ms.1234machine # [ 46.592178] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1235machine # [ 46.601784] systemd[585]: Stopped Run user-specific NixOS activation.1236machine # [ 46.604260] systemd[585]: Stopping Run user-specific NixOS activation...1237machine # [ 46.607233] systemd[585]: Starting Run user-specific NixOS activation...1238machine # [ 46.654742] systemd[585]: Finished Run user-specific NixOS activation.1239machine # [ 46.659457] systemd[1]: Stopped target Reactivate sysinit units.1240machine # [ 46.662037] systemd[1]: Stopping Reactivate sysinit units...1241machine # [ 46.662903] systemd[1]: Reached target Reactivate sysinit units.1242machine # [ 46.663737] systemd[1]: Reached target Remote File Systems.1243machine # [ 46.666415] systemd[1]: Reached target Local File Systems.1244machine # [ 46.669995] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1245machine # [ 46.674291] systemd[1]: Starting Create SUID/SGID Wrappers...1246machine # [ 46.675219] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1247machine # [ 46.677969] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671248machine # [ 46.688391] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1249machine # [ 46.690134] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1250machine # [ 46.691375] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1251machine # [ 46.697688] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1252machine # [ 46.700619] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1253machine # [ 47.097068] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1254machine # [ 47.102439] systemd[1]: Finished Create SUID/SGID Wrappers.1255machine # [ 47.107008] systemd[1]: Starting linger-users.service...1256machine # [ 47.110349] systemd[1]: Starting test.service...1257machine # [ 47.163572] systemd[1]: Finished test.service.1258machine # [ 47.194041] systemd[1]: linger-users.service: Deactivated successfully.1259machine # [ 47.197561] systemd[1]: Finished linger-users.service.1260machine # [ 47.455585] nixos[1870]: finished switching to system configuration /nix/store/gy3fjq6p259m8x8mj4dzk49y6m532qkp-nixos-system-machine-test1261machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 3.32 seconds)1262machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&11263machine # [ 48.135547] nixos[2013]: switching to system configuration /nix/store/d0qy65pbkh24p02iya7ky7jn1dhqm4in-nixos-system-machine-test1264machine # [ 48.138448] systemd[1]: Stopped target Remote File Systems.1265machine # [ 48.140892] systemd[1]: Stopped target Local File Systems.1266machine # [ 48.658625] systemd[1]: Reload requested from client PID 2013 ('.switch-to-conf') (unit backdoor.service)...1267machine # [ 48.660950] systemd[1]: Reloading...1268machine # [ 49.342381] systemd[1]: Reloading finished in 678 ms.1269machine # [ 49.484456] systemd[585]: Reexecution requested from client PID 2082 ('switch-to-confi')...1270machine # [ 49.485894] systemd[585]: Reexecuting.1271machine # [ 49.550837] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1272machine # [ 49.746435] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1273machine # [ 49.754571] systemd[585]: Reload requested from client PID 2082 ('switch-to-confi')...1274machine # [ 49.756609] systemd[585]: Reloading...1275machine # [ 49.968558] systemd[585]: Reloading finished in 210 ms.1276machine # [ 49.984233] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1277machine # [ 49.996133] systemd[585]: Stopped Run user-specific NixOS activation.1278machine # [ 49.997373] systemd[585]: Stopping Run user-specific NixOS activation...1279machine # [ 50.001568] systemd[585]: Starting Run user-specific NixOS activation...1280machine # [ 50.057484] systemd[585]: Finished Run user-specific NixOS activation.1281machine # [ 50.062610] systemd[1]: Stopped target Reactivate sysinit units.1282machine # [ 50.065049] systemd[1]: Stopping Reactivate sysinit units...1283machine # [ 50.066543] systemd[1]: Reached target Reactivate sysinit units.1284machine # [ 50.069134] systemd[1]: test.service: Deactivated successfully.1285machine # [ 50.070130] systemd[1]: Stopped test.service.1286machine # [ 50.070884] systemd[1]: Stopping test.service...1287machine # [ 50.075806] systemd[1]: Starting test.service...1288machine # [ 50.114912] systemd[1]: Finished test.service.1289machine # [ 50.118743] systemd[1]: Reached target Local File Systems.1290machine # [ 50.119728] systemd[1]: Reached target Remote File Systems.1291machine # [ 50.127962] systemd[1]: Starting linger-users.service...1292machine # [ 50.134715] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1293machine # [ 50.140975] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1294machine # [ 50.146077] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1295machine # [ 50.152452] systemd[1]: Starting Create SUID/SGID Wrappers...1296machine # [ 50.153409] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1297machine # [ 50.154634] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671298machine # [ 50.168848] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1299machine # [ 50.172236] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1300machine # [ 50.174447] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1301machine # [ 50.241209] systemd[1]: linger-users.service: Deactivated successfully.1302machine # [ 50.242315] systemd[1]: Finished linger-users.service.1303machine # [ 50.534852] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1304machine # [ 50.538104] systemd[1]: Finished Create SUID/SGID Wrappers.1305machine # [ 50.794921] nixos[2013]: finished switching to system configuration /nix/store/d0qy65pbkh24p02iya7ky7jn1dhqm4in-nixos-system-machine-test1306machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.34 seconds)1307machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&11308machine # [ 51.477869] nixos[2155]: switching to system configuration /nix/store/dkiaf4cwif4sgw14cq69rj229f34qc9j-nixos-system-machine-test1309machine # [ 51.481494] systemd[1]: Stopped target Local File Systems.1310machine # [ 51.483108] systemd[1]: Stopped target Remote File Systems.1311machine # [ 52.034724] systemd[1]: Reload requested from client PID 2155 ('.switch-to-conf') (unit backdoor.service)...1312machine # [ 52.037077] systemd[1]: Reloading...1313machine # [ 52.726121] systemd[1]: Reloading finished in 687 ms.1314machine # [ 52.876605] systemd[585]: Reexecution requested from client PID 2224 ('switch-to-confi')...1315machine # [ 52.880907] systemd[585]: Reexecuting.1316machine # [ 52.934149] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1317machine # [ 53.131185] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1318machine # [ 53.137899] systemd[585]: Reload requested from client PID 2224 ('switch-to-confi')...1319machine # [ 53.140402] systemd[585]: Reloading...1320machine # [ 53.341616] systemd[585]: Reloading finished in 199 ms.1321machine # [ 53.356215] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1322machine # [ 53.367766] systemd[585]: Stopped Run user-specific NixOS activation.1323machine # [ 53.369029] systemd[585]: Stopping Run user-specific NixOS activation...1324machine # [ 53.372172] systemd[585]: Starting Run user-specific NixOS activation...1325machine # [ 53.426588] systemd[585]: Finished Run user-specific NixOS activation.1326machine # [ 53.431825] systemd[1]: Stopped target Reactivate sysinit units.1327machine # [ 53.436769] systemd[1]: Stopping Reactivate sysinit units...1328machine # [ 53.437669] systemd[1]: Reached target Reactivate sysinit units.1329machine # [ 53.441029] systemd[1]: Reloading test.service...1330machine # [ 53.483675] systemd[1]: Reloaded test.service.1331machine # [ 53.487420] systemd[1]: Reached target Remote File Systems.1332machine # [ 53.490216] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1333machine # [ 53.491633] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1334machine # [ 53.497255] systemd[1]: Reached target Local File Systems.1335machine # [ 53.498188] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1336machine # [ 53.503001] systemd[1]: Starting Create SUID/SGID Wrappers...1337machine # [ 53.503970] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1338machine # [ 53.510621] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671339machine # [ 53.517989] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1340machine # [ 53.519626] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1341machine # [ 53.524941] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1342machine # [ 53.856697] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1343machine # [ 53.860755] systemd[1]: Finished Create SUID/SGID Wrappers.1344machine # [ 53.864979] systemd[1]: Starting linger-users.service...1345machine # [ 53.931288] systemd[1]: linger-users.service: Deactivated successfully.1346machine # [ 53.933914] systemd[1]: Finished linger-users.service.1347machine # [ 54.192388] nixos[2155]: finished switching to system configuration /nix/store/dkiaf4cwif4sgw14cq69rj229f34qc9j-nixos-system-machine-test1348machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 3.40 seconds)1349machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&11350machine # [ 54.812529] nixos[2297]: switching to system configuration /nix/store/f5kh5ksvsw0mmvzxjly7ahqqrysj4r0q-nixos-system-machine-test1351machine # [ 54.815422] systemd[1]: Stopped target Remote File Systems.1352machine # [ 54.817819] systemd[1]: Stopped target Local File Systems.1353machine # [ 55.340118] systemd[1]: Reload requested from client PID 2297 ('.switch-to-conf') (unit backdoor.service)...1354machine # [ 55.342115] systemd[1]: Reloading...1355machine # [ 55.995310] systemd[1]: Reloading finished in 650 ms.1356machine # [ 56.136428] systemd[585]: Reexecution requested from client PID 2366 ('switch-to-confi')...1357machine # [ 56.140485] systemd[585]: Reexecuting.1358machine # [ 56.202113] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1359machine # [ 56.389261] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1360machine # [ 56.395727] systemd[585]: Reload requested from client PID 2366 ('switch-to-confi')...1361machine # [ 56.398486] systemd[585]: Reloading...1362machine # [ 56.592079] systemd[585]: Reloading finished in 192 ms.1363machine # [ 56.608186] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1364machine # [ 56.617787] systemd[585]: Stopped Run user-specific NixOS activation.1365machine # [ 56.620121] systemd[585]: Stopping Run user-specific NixOS activation...1366machine # [ 56.623139] systemd[585]: Starting Run user-specific NixOS activation...1367machine # [ 56.672776] systemd[585]: Finished Run user-specific NixOS activation.1368machine # [ 56.677112] systemd[1]: Stopped target Reactivate sysinit units.1369machine # [ 56.678389] systemd[1]: Stopping Reactivate sysinit units...1370machine # [ 56.679215] systemd[1]: Reached target Reactivate sysinit units.1371machine # [ 56.682291] systemd[1]: Reached target Remote File Systems.1372machine # [ 56.691083] systemd[1]: Starting linger-users.service...1373machine # [ 56.694403] systemd[1]: Reached target Local File Systems.1374machine # [ 56.702431] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1375machine # [ 56.706755] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1376machine # [ 56.708263] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1377machine # [ 56.716003] systemd[1]: Starting Create SUID/SGID Wrappers...1378machine # [ 56.716918] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1379machine # [ 56.718118] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671380machine # [ 56.721335] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1381machine # [ 56.723330] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1382machine # [ 56.725334] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1383machine # [ 56.785144] systemd[1]: linger-users.service: Deactivated successfully.1384machine # [ 56.788336] systemd[1]: Finished linger-users.service.1385machine # [ 57.111590] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1386machine # [ 57.115572] systemd[1]: Finished Create SUID/SGID Wrappers.1387machine # [ 57.372809] nixos[2297]: finished switching to system configuration /nix/store/f5kh5ksvsw0mmvzxjly7ahqqrysj4r0q-nixos-system-machine-test1388machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 3.18 seconds)1389machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&11390machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.76 seconds)1391machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/bin/switch-to-configuration test 2>&11392machine # [ 58.724293] nixos[2447]: switching to system configuration /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test1393machine # [ 58.728228] systemd[1]: Stopped target Local File Systems.1394machine # [ 58.729994] systemd[1]: Stopped target Remote File Systems.1395machine # [ 58.730828] systemd[1]: test.service: Deactivated successfully.1396machine # [ 58.731618] systemd[1]: Stopped test.service.1397machine # [ 59.220880] systemd[1]: Reload requested from client PID 2447 ('.switch-to-conf') (unit backdoor.service)...1398machine # [ 59.222852] systemd[1]: Reloading...1399machine # [ 59.873216] systemd[1]: Reloading finished in 648 ms.1400machine # [ 60.033402] systemd[585]: Reexecution requested from client PID 2516 ('switch-to-confi')...1401machine # [ 60.038405] systemd[585]: Reexecuting.1402machine # [ 60.086737] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1403machine # [ 60.295845] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1404machine # [ 60.303524] systemd[585]: Reload requested from client PID 2516 ('switch-to-confi')...1405machine # [ 60.306310] systemd[585]: Reloading...1406machine # [ 60.498993] systemd[585]: Reloading finished in 191 ms.1407machine # [ 60.514056] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1408machine # [ 60.524183] systemd[585]: Stopped Run user-specific NixOS activation.1409machine # [ 60.525323] systemd[585]: Stopping Run user-specific NixOS activation...1410machine # [ 60.528904] systemd[585]: Starting Run user-specific NixOS activation...1411machine # [ 60.583965] systemd[585]: Finished Run user-specific NixOS activation.1412machine # [ 60.589227] systemd[1]: Stopped target Reactivate sysinit units.1413machine # [ 60.592666] systemd[1]: Stopping Reactivate sysinit units...1414machine # [ 60.593698] systemd[1]: Reached target Reactivate sysinit units.1415machine # [ 60.596430] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1416machine # [ 60.597936] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1417machine # [ 60.601458] systemd[1]: Reached target Remote File Systems.1418machine # [ 60.611378] systemd[1]: Starting linger-users.service...1419machine # [ 60.616252] systemd[1]: Reached target Local File Systems.1420machine # [ 60.624663] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1421machine # [ 60.631833] systemd[1]: Starting Create SUID/SGID Wrappers...1422machine # [ 60.633200] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1423machine # [ 60.634463] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671424machine # [ 60.645522] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1425machine # [ 60.647267] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1426machine # [ 60.651166] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1427machine # [ 60.725988] systemd[1]: linger-users.service: Deactivated successfully.1428machine # [ 60.729355] systemd[1]: Finished linger-users.service.1429machine # [ 61.055448] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1430machine # [ 61.059513] systemd[1]: Finished Create SUID/SGID Wrappers.1431machine # [ 61.318348] nixos[2447]: finished switching to system configuration /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test1432machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.18 seconds)1433machine: must succeed: /nix/store/y6345msm3q1g03lv4hfgbwbq4zaimcbx-separate-activation-script/bin/switch-to-configuration test 2>&11434machine # [ 61.938495] nixos[2587]: switching to system configuration /nix/store/7x0f6sz4kjz6spd30mb9ljx81xks7rv7-nixos-system-machine-test1435machine # [ 61.941234] systemd[1]: Stopped target Local File Systems.1436machine # [ 61.943645] systemd[1]: Stopped target Remote File Systems.1437machine # [ 62.481707] systemd[1]: Reload requested from client PID 2587 ('.switch-to-conf') (unit backdoor.service)...1438machine # [ 62.483752] systemd[1]: Reloading...1439machine # [ 63.120237] systemd[1]: Reloading finished in 633 ms.1440machine # [ 63.289796] systemd[585]: Stopped Run user-specific NixOS activation.1441machine # [ 63.294191] systemd[585]: Reexecution requested from client PID 2656 ('switch-to-confi')...1442machine # [ 63.295704] systemd[585]: Reexecuting.1443machine # [ 63.359104] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1444machine # [ 63.567686] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1445machine # [ 63.574945] systemd[585]: Reload requested from client PID 2656 ('switch-to-confi')...1446machine # [ 63.577820] systemd[585]: Reloading...1447machine # [ 63.780848] systemd[585]: Reloading finished in 201 ms.1448machine # [ 63.796230] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1449machine # [ 63.808252] systemd[1]: Stopped target Reactivate sysinit units.1450machine # [ 63.811243] systemd[1]: Stopping Reactivate sysinit units...1451machine # [ 63.813462] systemd[1]: Reached target Reactivate sysinit units.1452machine # [ 63.817327] systemd[1]: Reached target Local File Systems.1453machine # [ 63.819757] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1454machine # [ 63.822930] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1455machine # [ 63.828159] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1456machine # [ 63.832358] systemd[1]: Starting Create SUID/SGID Wrappers...1457machine # [ 63.835650] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1458machine # [ 63.839524] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671459machine # [ 63.848274] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1460machine # [ 63.849966] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1461machine # [ 63.851325] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1462machine # [ 63.852895] systemd[1]: Reached target Remote File Systems.1463machine # [ 64.181461] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1464machine # [ 64.186624] systemd[1]: Finished Create SUID/SGID Wrappers.1465machine # [ 64.190763] systemd[1]: Starting linger-users.service...1466machine # [ 64.194083] systemd[1]: Starting test.service...1467machine # [ 64.243090] systemd[1]: Finished test.service.1468machine # [ 64.272129] systemd[1]: linger-users.service: Deactivated successfully.1469machine # [ 64.274996] systemd[1]: Finished linger-users.service.1470machine # [ 64.530984] nixos[2587]: finished switching to system configuration /nix/store/7x0f6sz4kjz6spd30mb9ljx81xks7rv7-nixos-system-machine-test1471machine: (finished: must succeed: /nix/store/y6345msm3q1g03lv4hfgbwbq4zaimcbx-separate-activation-script/bin/switch-to-configuration test 2>&1, in 3.21 seconds)1472machine: must succeed: ! test -e /run/current-system/activate1473machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.03 seconds)1474machine: must succeed: ! test -e /run/current-system/dry-activate1475machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.03 seconds)1476machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration1477machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.02 seconds)1478machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&11479machine # [ 65.263937] nixos[2735]: switching to system configuration /nix/store/4i3p90h22lm1l6s282aqgy4slkzk6xqv-nixos-system-machine-test1480machine # [ 65.269133] systemd[1]: Stopped target Local File Systems.1481machine # [ 65.270063] systemd[1]: Stopped target Remote File Systems.1482machine # [ 65.270898] systemd[1]: test.service: Deactivated successfully.1483machine # [ 65.271741] systemd[1]: Stopped test.service.1484machine # [ 65.842132] systemd[1]: Reload requested from client PID 2735 ('.switch-to-conf') (unit backdoor.service)...1485machine # [ 65.844247] systemd[1]: Reloading...1486machine # [ 66.559917] systemd[1]: Reloading finished in 713 ms.1487machine # [ 66.702613] systemd[585]: Reexecution requested from client PID 2804 ('switch-to-confi')...1488machine # [ 66.705117] systemd[585]: Reexecuting.1489machine # [ 66.766708] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1490machine # [ 66.966595] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1491machine # [ 66.974059] systemd[585]: Reload requested from client PID 2804 ('switch-to-confi')...1492machine # [ 66.976571] systemd[585]: Reloading...1493machine # [ 67.166908] systemd[585]: Reloading finished in 189 ms.1494machine # [ 67.180197] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1495machine # [ 67.190851] systemd[585]: Starting Run user-specific NixOS activation...1496machine # [ 67.240122] systemd[585]: Finished Run user-specific NixOS activation.1497machine # [ 67.245228] systemd[585]: Stopped Run user-specific NixOS activation.1498machine # [ 67.246604] systemd[585]: Stopping Run user-specific NixOS activation...1499machine # [ 67.249353] systemd[585]: Starting Run user-specific NixOS activation...1500machine # [ 67.257136] systemd[1]: Stopped target Reactivate sysinit units.1501machine # [ 67.258136] systemd[1]: Stopping Reactivate sysinit units...1502machine # [ 67.258965] systemd[1]: Reached target Reactivate sysinit units.1503machine # [ 67.263136] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1504machine # [ 67.266198] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1505machine # [ 67.270601] systemd[1]: Reached target Local File Systems.1506machine # [ 67.277574] systemd[1]: Reached target Remote File Systems.1507machine # [ 67.283629] systemd[1]: Starting linger-users.service...1508machine # [ 67.300336] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1509machine # [ 67.310006] systemd[1]: Starting Create SUID/SGID Wrappers...1510machine # [ 67.320248] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1511machine # [ 67.324127] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671512machine # [ 67.326394] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1513machine # [ 67.336816] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1514machine # [ 67.338975] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1515machine # [ 67.341460] systemd[585]: Finished Run user-specific NixOS activation.1516machine # [ 67.405021] systemd[1]: linger-users.service: Deactivated successfully.1517machine # [ 67.408881] systemd[1]: Finished linger-users.service.1518machine # [ 67.699835] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1519machine # [ 67.704663] systemd[1]: Finished Create SUID/SGID Wrappers.1520machine # [ 67.707111] systemd[1]: Started test.service.1521machine # [ 67.743924] systemd[1]: test.service: Deactivated successfully.1522machine # [ 67.966977] nixos[2735]: finished switching to system configuration /nix/store/4i3p90h22lm1l6s282aqgy4slkzk6xqv-nixos-system-machine-test1523machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 3.36 seconds)1524machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&11525machine # [ 68.643404] nixos[2880]: switching to system configuration /nix/store/cwzap0z4wrvns5rcz60i0ly8ckd0wfz3-nixos-system-machine-test1526machine # [ 68.645979] systemd[1]: Stopped target Remote File Systems.1527machine # [ 68.648450] systemd[1]: Stopped target Local File Systems.1528machine # [ 69.194363] systemd[1]: Reload requested from client PID 2880 ('.switch-to-conf') (unit backdoor.service)...1529machine # [ 69.196444] systemd[1]: Reloading...1530machine # [ 69.884995] systemd[1]: Reloading finished in 686 ms.1531machine # [ 70.035173] systemd[585]: Reexecution requested from client PID 2949 ('switch-to-confi')...1532machine # [ 70.037669] systemd[585]: Reexecuting.1533machine # [ 70.102515] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1534machine # [ 70.294616] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1535machine # [ 70.301339] systemd[585]: Reload requested from client PID 2949 ('switch-to-confi')...1536machine # [ 70.304182] systemd[585]: Reloading...1537machine # [ 70.501491] systemd[585]: Reloading finished in 196 ms.1538machine # [ 70.516190] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1539machine # [ 70.526327] systemd[585]: Stopped Run user-specific NixOS activation.1540machine # [ 70.528830] systemd[585]: Stopping Run user-specific NixOS activation...1541machine # [ 70.531914] systemd[585]: Starting Run user-specific NixOS activation...1542machine # [ 70.578884] systemd[585]: Finished Run user-specific NixOS activation.1543machine # [ 70.583535] systemd[1]: Stopped target Reactivate sysinit units.1544machine # [ 70.586456] systemd[1]: Stopping Reactivate sysinit units...1545machine # [ 70.587336] systemd[1]: Reached target Reactivate sysinit units.1546machine # [ 70.590954] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1547machine # [ 70.593427] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1548machine # [ 70.595888] systemd[1]: Reached target Remote File Systems.1549machine # [ 70.598454] systemd[1]: Reached target Local File Systems.1550machine # [ 70.602008] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1551machine # [ 70.606126] systemd[1]: Starting Create SUID/SGID Wrappers...1552machine # [ 70.607056] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1553machine # [ 70.610099] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671554machine # [ 70.620462] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1555machine # [ 70.622033] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1556machine # [ 70.623334] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1557machine # [ 70.982375] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1558machine # [ 70.987033] systemd[1]: Finished Create SUID/SGID Wrappers.1559machine # [ 70.990940] systemd[1]: Starting escaped\x2ddash.service...1560machine # [ 70.993919] systemd[1]: Starting linger-users.service...1561machine # [ 71.038974] systemd[1]: Finished escaped\x2ddash.service.1562machine # [ 71.067223] systemd[1]: linger-users.service: Deactivated successfully.1563machine # [ 71.069437] systemd[1]: Finished linger-users.service.1564machine # [ 71.330847] nixos[2880]: finished switching to system configuration /nix/store/cwzap0z4wrvns5rcz60i0ly8ckd0wfz3-nixos-system-machine-test1565machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 3.36 seconds)1566machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&11567machine # [ 71.979219] nixos[3022]: switching to system configuration /nix/store/5qa7yv1drgvyfnq8g92rb8kay4nb2v3d-nixos-system-machine-test1568machine # [ 71.983445] systemd[1]: Stopped target Local File Systems.1569machine # [ 71.985283] systemd[1]: Stopped target Remote File Systems.1570machine # [ 71.986146] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1571machine # [ 71.987155] systemd[1]: Stopped escaped\x2ddash.service.1572machine # [ 72.522157] systemd[1]: Reload requested from client PID 3022 ('.switch-to-conf') (unit backdoor.service)...1573machine # [ 72.524259] systemd[1]: Reloading...1574machine # [ 73.188905] systemd[1]: Reloading finished in 662 ms.1575machine # [ 73.338783] systemd[585]: Reexecution requested from client PID 3091 ('switch-to-confi')...1576machine # [ 73.342452] systemd[585]: Reexecuting.1577machine # [ 73.402279] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1578machine # [ 73.605294] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1579machine # [ 73.612877] systemd[585]: Reload requested from client PID 3091 ('switch-to-confi')...1580machine # [ 73.614344] systemd[585]: Reloading...1581machine # [ 73.809405] systemd[585]: Reloading finished in 193 ms.1582machine # [ 73.825616] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1583machine # [ 73.835082] systemd[585]: Stopped Run user-specific NixOS activation.1584machine # [ 73.836214] systemd[585]: Stopping Run user-specific NixOS activation...1585machine # [ 73.839274] systemd[585]: Starting Run user-specific NixOS activation...1586machine # [ 73.888563] systemd[585]: Finished Run user-specific NixOS activation.1587machine # [ 73.893292] systemd[1]: Stopped target Reactivate sysinit units.1588machine # [ 73.894352] systemd[1]: Stopping Reactivate sysinit units...1589machine # [ 73.895183] systemd[1]: Reached target Reactivate sysinit units.1590machine # [ 73.899013] systemd[1]: Reached target Remote File Systems.1591machine # [ 73.904337] systemd[1]: Starting escaped\x2ddash.service...1592machine # [ 73.909065] systemd[1]: Starting linger-users.service...1593machine # [ 73.926969] systemd[1]: Reached target Local File Systems.1594machine # [ 73.927942] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1595machine # [ 73.934612] systemd[1]: Starting Create SUID/SGID Wrappers...1596machine # [ 73.939152] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1597machine # [ 73.949608] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671598machine # [ 73.954835] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1599machine # [ 73.958772] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1600machine # [ 73.960414] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1601machine # [ 73.962780] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1602machine # [ 73.966063] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1603machine # [ 73.995664] systemd[1]: Finished escaped\x2ddash.service.1604machine # [ 74.031838] systemd[1]: linger-users.service: Deactivated successfully.1605machine # [ 74.035791] systemd[1]: Finished linger-users.service.1606machine # [ 74.334435] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1607machine # [ 74.338051] systemd[1]: Finished Create SUID/SGID Wrappers.1608machine # [ 74.595275] nixos[3022]: finished switching to system configuration /nix/store/5qa7yv1drgvyfnq8g92rb8kay4nb2v3d-nixos-system-machine-test1609machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 3.26 seconds)1610machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&11611machine # [ 75.280273] nixos[3164]: switching to system configuration /nix/store/mi95g3a9dhhbwk96m3vwrwdaffar7xdg-nixos-system-machine-test1612machine # [ 75.284577] systemd[1]: Stopped target Local File Systems.1613machine # [ 75.287528] systemd[1]: Stopped target Remote File Systems.1614machine # [ 75.288723] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1615machine # [ 75.289982] systemd[1]: Stopped escaped\x2ddash.service.1616machine # [ 75.858086] systemd[1]: Reload requested from client PID 3164 ('.switch-to-conf') (unit backdoor.service)...1617machine # [ 75.860285] systemd[1]: Reloading...1618machine # [ 76.534878] systemd[1]: Reloading finished in 672 ms.1619machine # [ 76.682885] systemd[585]: Reexecution requested from client PID 3233 ('switch-to-confi')...1620machine # [ 76.685087] systemd[585]: Reexecuting.1621machine # [ 76.746528] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1622machine # [ 76.942653] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1623machine # [ 76.949038] systemd[585]: Reload requested from client PID 3233 ('switch-to-confi')...1624machine # [ 76.951653] systemd[585]: Reloading...1625machine # [ 77.145776] systemd[585]: Reloading finished in 193 ms.1626machine # [ 77.160179] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1627machine # [ 77.170601] systemd[585]: Stopped Run user-specific NixOS activation.1628machine # [ 77.171672] systemd[585]: Stopping Run user-specific NixOS activation...1629machine # [ 77.174709] systemd[585]: Starting Run user-specific NixOS activation...1630machine # [ 77.222380] systemd[585]: Finished Run user-specific NixOS activation.1631machine # [ 77.226783] systemd[1]: Stopped target Reactivate sysinit units.1632machine # [ 77.228911] systemd[1]: Stopping Reactivate sysinit units...1633machine # [ 77.230183] systemd[1]: Reached target Reactivate sysinit units.1634machine # [ 77.233251] systemd[1]: Reached target Local File Systems.1635machine # [ 77.236430] systemd[1]: Reached target Remote File Systems.1636machine # [ 77.240360] systemd[1]: Starting -.service...1637machine # [ 77.242872] systemd[1]: Starting linger-users.service...1638machine # [ 77.252346] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1639machine # [ 77.261312] systemd[1]: Starting Create SUID/SGID Wrappers...1640machine # [ 77.269026] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1641machine # [ 77.270297] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671642machine # [ 77.278475] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1643machine # [ 77.284358] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1644machine # [ 77.286418] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1645machine # [ 77.289184] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1646machine # [ 77.291792] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1647machine # [ 77.324314] systemd[1]: Finished -.service.1648machine # [ 77.359091] systemd[1]: linger-users.service: Deactivated successfully.1649machine # [ 77.361685] systemd[1]: Finished linger-users.service.1650machine # [ 77.626330] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1651machine # [ 77.629886] systemd[1]: Finished Create SUID/SGID Wrappers.1652machine # [ 77.888373] nixos[3164]: finished switching to system configuration /nix/store/mi95g3a9dhhbwk96m3vwrwdaffar7xdg-nixos-system-machine-test1653machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 3.29 seconds)1654machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&11655machine # [ 78.539623] nixos[3306]: switching to system configuration /nix/store/a05mz2q07x1mliq98zxajcrl30a7wvyw-nixos-system-machine-test1656machine # [ 78.542563] systemd[1]: Stopped target Remote File Systems.1657machine # [ 78.544900] systemd[1]: Stopped target Local File Systems.1658machine # [ 79.091797] systemd[1]: Reload requested from client PID 3306 ('.switch-to-conf') (unit backdoor.service)...1659machine # [ 79.094266] systemd[1]: Reloading...1660machine # [ 79.770230] systemd[1]: Reloading finished in 672 ms.1661machine # [ 79.915739] systemd[585]: Reexecution requested from client PID 3375 ('switch-to-confi')...1662machine # [ 79.919436] systemd[585]: Reexecuting.1663machine # [ 79.982087] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1664machine # [ 80.177665] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1665machine # [ 80.184428] systemd[585]: Reload requested from client PID 3375 ('switch-to-confi')...1666machine # [ 80.187124] systemd[585]: Reloading...1667machine # [ 80.378842] systemd[585]: Reloading finished in 190 ms.1668machine # [ 80.396210] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1669machine # [ 80.405825] systemd[585]: Stopped Run user-specific NixOS activation.1670machine # [ 80.408228] systemd[585]: Stopping Run user-specific NixOS activation...1671machine # [ 80.411055] systemd[585]: Starting Run user-specific NixOS activation...1672machine # [ 80.459452] systemd[585]: Finished Run user-specific NixOS activation.1673machine # [ 80.465075] systemd[1]: Stopped target Reactivate sysinit units.1674machine # [ 80.468679] systemd[1]: Stopping Reactivate sysinit units...1675machine # [ 80.469652] systemd[1]: Reached target Reactivate sysinit units.1676machine # [ 80.474100] systemd[1]: Reloading -.service...1677machine # [ 80.513636] systemd[1]: Reloaded -.service.1678machine # [ 80.519244] systemd[1]: Reached target Remote File Systems.1679machine # [ 80.525987] systemd[1]: Starting linger-users.service...1680machine # [ 80.538610] systemd[1]: Reached target Local File Systems.1681machine # [ 80.540978] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1682machine # [ 80.549572] systemd[1]: Starting Create SUID/SGID Wrappers...1683machine # [ 80.550615] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1684machine # [ 80.556793] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671685machine # [ 80.565093] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1686machine # [ 80.568368] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1687machine # [ 80.572471] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1688machine # [ 80.573779] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1689machine # [ 80.575122] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1690machine # [ 80.637020] systemd[1]: linger-users.service: Deactivated successfully.1691machine # [ 80.640593] systemd[1]: Finished linger-users.service.1692machine # [ 80.937194] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1693machine # [ 80.940854] systemd[1]: Finished Create SUID/SGID Wrappers.1694machine # [ 81.198445] nixos[3306]: finished switching to system configuration /nix/store/a05mz2q07x1mliq98zxajcrl30a7wvyw-nixos-system-machine-test1695machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 3.31 seconds)1696machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&11697machine # [ 81.856364] nixos[3448]: switching to system configuration /nix/store/xvhmba0bq2rjs03xg7jppnb3d7i6b30y-nixos-system-machine-test1698machine # [ 81.858784] systemd[1]: Stopped target Local File Systems.1699machine # [ 81.861424] systemd[1]: -.service: Deactivated successfully.1700machine # [ 81.862334] systemd[1]: Stopped -.service.1701machine # [ 81.863646] systemd[1]: Stopped target Remote File Systems.1702machine # [ 82.388427] systemd[1]: Reload requested from client PID 3448 ('.switch-to-conf') (unit backdoor.service)...1703machine # [ 82.390472] systemd[1]: Reloading...1704machine # [ 83.074317] systemd[1]: Reloading finished in 681 ms.1705machine # [ 83.220230] systemd[585]: Reexecution requested from client PID 3517 ('switch-to-confi')...1706machine # [ 83.224263] systemd[585]: Reexecuting.1707machine # [ 83.286742] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1708machine # [ 83.481702] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1709machine # [ 83.488826] systemd[585]: Reload requested from client PID 3517 ('switch-to-confi')...1710machine # [ 83.491382] systemd[585]: Reloading...1711machine # [ 83.691727] systemd[585]: Reloading finished in 199 ms.1712machine # [ 83.704259] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1713machine # [ 83.715793] systemd[585]: Stopped Run user-specific NixOS activation.1714machine # [ 83.718608] systemd[585]: Stopping Run user-specific NixOS activation...1715machine # [ 83.721604] systemd[585]: Starting Run user-specific NixOS activation...1716machine # [ 83.773913] systemd[585]: Finished Run user-specific NixOS activation.1717machine # [ 83.779517] systemd[1]: Stopped target Reactivate sysinit units.1718machine # [ 83.781094] systemd[1]: Stopping Reactivate sysinit units...1719machine # [ 83.781958] systemd[1]: Reached target Reactivate sysinit units.1720machine # [ 83.787761] systemd[1]: Reached target Local File Systems.1721machine # [ 83.791019] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1722machine # [ 83.793128] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1723machine # [ 83.797195] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1724machine # [ 83.804745] systemd[1]: Starting Create SUID/SGID Wrappers...1725machine # [ 83.805722] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1726machine # [ 83.806986] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671727machine # [ 83.814224] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1728machine # [ 83.823058] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1729machine # [ 83.824577] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1730machine # [ 83.825790] systemd[1]: Reached target Remote File Systems.1731machine # [ 84.185315] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1732machine # [ 84.190947] systemd[1]: Finished Create SUID/SGID Wrappers.1733machine # [ 84.196594] systemd[1]: Starting linger-users.service...1734machine # [ 84.202676] systemd[1]: Starting required-service.service...1735machine # [ 84.208532] systemd[1]: Starting test-service.service...1736machine # [ 84.272712] systemd[1]: Finished required-service.service.1737machine # [ 84.276200] systemd[1]: Finished test-service.service.1738machine # [ 84.306421] systemd[1]: linger-users.service: Deactivated successfully.1739machine # [ 84.309477] systemd[1]: Finished linger-users.service.1740machine # [ 84.570125] nixos[3448]: finished switching to system configuration /nix/store/xvhmba0bq2rjs03xg7jppnb3d7i6b30y-nixos-system-machine-test1741machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 3.37 seconds)1742machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&11743machine # [ 85.220523] nixos[3592]: switching to system configuration /nix/store/zc1x43dmpqkigar58knxv4pha4fpr9pd-nixos-system-machine-test1744machine # [ 85.224696] systemd[1]: Stopped target Local File Systems.1745machine # [ 85.227688] systemd[1]: Stopped target Remote File Systems.1746machine # [ 85.228901] systemd[1]: required-service.service: Deactivated successfully.1747machine # [ 85.230187] systemd[1]: Stopped required-service.service.1748machine # [ 85.231162] systemd[1]: test-service.service: Deactivated successfully.1749machine # [ 85.232493] systemd[1]: Stopped test-service.service.1750machine # [ 85.758346] systemd[1]: Reload requested from client PID 3592 ('.switch-to-conf') (unit backdoor.service)...1751machine # [ 85.760509] systemd[1]: Reloading...1752machine # [ 86.462709] systemd[1]: Reloading finished in 699 ms.1753machine # [ 86.603389] systemd[585]: Reexecution requested from client PID 3661 ('switch-to-confi')...1754machine # [ 86.607154] systemd[585]: Reexecuting.1755machine # [ 86.670164] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1756machine # [ 86.874200] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1757machine # [ 86.880958] systemd[585]: Reload requested from client PID 3661 ('switch-to-confi')...1758machine # [ 86.883482] systemd[585]: Reloading...1759machine # [ 87.079817] systemd[585]: Reloading finished in 194 ms.1760machine # [ 87.096183] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1761machine # [ 87.106710] systemd[585]: Stopped Run user-specific NixOS activation.1762machine # [ 87.107792] systemd[585]: Stopping Run user-specific NixOS activation...1763machine # [ 87.110872] systemd[585]: Starting Run user-specific NixOS activation...1764machine # [ 87.158649] systemd[585]: Finished Run user-specific NixOS activation.1765machine # [ 87.162867] systemd[1]: Stopped target Reactivate sysinit units.1766machine # [ 87.164900] systemd[1]: Stopping Reactivate sysinit units...1767machine # [ 87.165911] systemd[1]: Reached target Reactivate sysinit units.1768machine # [ 87.171594] systemd[1]: Reached target Local File Systems.1769machine # [ 87.175346] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1770machine # [ 87.179689] systemd[1]: Starting Create SUID/SGID Wrappers...1771machine # [ 87.183049] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1772machine # [ 87.188369] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671773machine # [ 87.190572] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1774machine # [ 87.197088] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1775machine # [ 87.200046] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1776machine # [ 87.202424] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1777machine # [ 87.203785] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1778machine # [ 87.207227] systemd[1]: Reached target Remote File Systems.1779machine # [ 87.541085] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1780machine # [ 87.544372] systemd[1]: Finished Create SUID/SGID Wrappers.1781machine # [ 87.550639] systemd[1]: Starting linger-users.service...1782machine # [ 87.554733] systemd[1]: Starting required-service.service...1783machine # [ 87.562201] systemd[1]: Starting test-service.service...1784machine # [ 87.613372] systemd[1]: Finished test-service.service.1785machine # [ 87.616714] systemd[1]: Finished required-service.service.1786machine # [ 87.645733] systemd[1]: linger-users.service: Deactivated successfully.1787machine # [ 87.648802] systemd[1]: Finished linger-users.service.1788machine # [ 87.907137] nixos[3592]: finished switching to system configuration /nix/store/zc1x43dmpqkigar58knxv4pha4fpr9pd-nixos-system-machine-test1789machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 3.34 seconds)1790machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&11791machine # [ 88.545825] nixos[3736]: switching to system configuration /nix/store/8mm6h2jz6gp09jl8glzdirn9v47n4jgb-nixos-system-machine-test1792machine # [ 88.551589] systemd[1]: Stopped target Local File Systems.1793machine # [ 88.553726] systemd[1]: Stopped target Remote File Systems.1794machine # [ 88.554821] systemd[1]: required-service.service: Deactivated successfully.1795machine # [ 88.555977] systemd[1]: Stopped required-service.service.1796machine # [ 88.557204] systemd[1]: test-service.service: Deactivated successfully.1797machine # [ 88.558142] systemd[1]: Stopped test-service.service.1798machine # [ 89.079789] systemd[1]: Reload requested from client PID 3736 ('.switch-to-conf') (unit backdoor.service)...1799machine # [ 89.082067] systemd[1]: Reloading...1800machine # [ 89.770705] systemd[1]: Reloading finished in 686 ms.1801machine # [ 89.928455] systemd[585]: Reexecution requested from client PID 3805 ('switch-to-confi')...1802machine # [ 89.929909] systemd[585]: Reexecuting.1803machine # [ 90.003445] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1804machine # [ 90.207757] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1805machine # [ 90.214708] systemd[585]: Reload requested from client PID 3805 ('switch-to-confi')...1806machine # [ 90.217423] systemd[585]: Reloading...1807machine # [ 90.432427] systemd[585]: Reloading finished in 213 ms.1808machine # [ 90.448200] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1809machine # [ 90.458379] systemd[585]: Stopped Run user-specific NixOS activation.1810machine # [ 90.461168] systemd[585]: Stopping Run user-specific NixOS activation...1811machine # [ 90.464418] systemd[585]: Starting Run user-specific NixOS activation...1812machine # [ 90.517021] systemd[585]: Finished Run user-specific NixOS activation.1813machine # [ 90.521865] systemd[1]: Stopped target Reactivate sysinit units.1814machine # [ 90.525153] systemd[1]: Stopping Reactivate sysinit units...1815machine # [ 90.526041] systemd[1]: Reached target Reactivate sysinit units.1816machine # [ 90.526889] systemd[1]: Reached target Remote File Systems.1817machine # [ 90.535458] systemd[1]: Starting linger-users.service...1818machine # [ 90.539784] systemd[1]: Starting required-service.service...1819machine # [ 90.543675] systemd[1]: Starting test-service.service...1820machine # [ 90.561325] systemd[1]: Reached target Local File Systems.1821machine # [ 90.562271] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1822machine # [ 90.573758] systemd[1]: Starting Create SUID/SGID Wrappers...1823machine # [ 90.574764] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1824machine # [ 90.588002] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671825machine # [ 90.597253] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1826machine # [ 90.605257] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1827machine # [ 90.607203] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1828machine # [ 90.611764] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1829machine # [ 90.616437] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1830machine # [ 90.642091] systemd[1]: Finished required-service.service.1831machine # [ 90.644558] systemd[1]: Finished test-service.service.1832machine # [ 90.684719] systemd[1]: linger-users.service: Deactivated successfully.1833machine # [ 90.688369] systemd[1]: Finished linger-users.service.1834machine # [ 90.957511] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1835machine # [ 90.961201] systemd[1]: Finished Create SUID/SGID Wrappers.1836machine # [ 91.218616] nixos[3736]: finished switching to system configuration /nix/store/8mm6h2jz6gp09jl8glzdirn9v47n4jgb-nixos-system-machine-test1837machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 3.31 seconds)1838machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&11839machine # [ 91.920437] nixos[3880]: switching to system configuration /nix/store/1wnhnzkynd3bwxa90gisdfyr92sdgfll-nixos-system-machine-test1840machine # [ 91.924845] systemd[1]: Stopped target Local File Systems.1841machine # [ 91.928101] systemd[1]: Stopped target Remote File Systems.1842machine # [ 91.929024] systemd[1]: required-service.service: Deactivated successfully.1843machine # [ 91.929988] systemd[1]: Stopped required-service.service.1844machine # [ 91.930796] systemd[1]: test-service.service: Deactivated successfully.1845machine # [ 91.931695] systemd[1]: Stopped test-service.service.1846machine # [ 92.491148] systemd[1]: Reload requested from client PID 3880 ('.switch-to-conf') (unit backdoor.service)...1847machine # [ 92.493508] systemd[1]: Reloading...1848machine # [ 93.226994] systemd[1]: Reloading finished in 731 ms.1849machine # [ 93.384471] systemd[585]: Reexecution requested from client PID 3949 ('switch-to-confi')...1850machine # [ 93.387793] systemd[585]: Reexecuting.1851machine # [ 93.445819] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1852machine # [ 93.668729] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1853machine # [ 93.675969] systemd[585]: Reload requested from client PID 3949 ('switch-to-confi')...1854machine # [ 93.678554] systemd[585]: Reloading...1855machine # [ 93.885677] systemd[585]: Reloading finished in 205 ms.1856machine # [ 93.900199] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1857machine # [ 93.911787] systemd[585]: Stopped Run user-specific NixOS activation.1858machine # [ 93.914522] systemd[585]: Stopping Run user-specific NixOS activation...1859machine # [ 93.917601] systemd[585]: Starting Run user-specific NixOS activation...1860machine # [ 93.969984] systemd[585]: Finished Run user-specific NixOS activation.1861machine # [ 93.975073] systemd[1]: Stopped target Reactivate sysinit units.1862machine # [ 93.977369] systemd[1]: Stopping Reactivate sysinit units...1863machine # [ 93.980997] systemd[1]: Reached target Reactivate sysinit units.1864machine # [ 93.981996] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1865machine # [ 93.983310] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1866machine # [ 93.986229] systemd[1]: Reached target Local File Systems.1867machine # [ 93.990934] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1868machine # [ 93.995924] systemd[1]: Starting Create SUID/SGID Wrappers...1869machine # [ 93.999272] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1870machine # [ 94.004661] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671871machine # [ 94.012681] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1872machine # [ 94.014489] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1873machine # [ 94.015792] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1874machine # [ 94.022937] systemd[1]: Created slice Slice /system/instantiated.1875machine # [ 94.023907] systemd[1]: Reached target Remote File Systems.1876machine # [ 94.375612] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1877machine # [ 94.380209] systemd[1]: Finished Create SUID/SGID Wrappers.1878machine # [ 94.384313] systemd[1]: Starting instantiated@one.service...1879machine # [ 94.388361] systemd[1]: Starting instantiated@two.service...1880machine # [ 94.392764] systemd[1]: Starting linger-users.service...1881machine # [ 94.447817] systemd[1]: Finished instantiated@one.service.1882machine # [ 94.452278] systemd[1]: Finished instantiated@two.service.1883machine # [ 94.480798] systemd[1]: linger-users.service: Deactivated successfully.1884machine # [ 94.483909] systemd[1]: Finished linger-users.service.1885machine # [ 94.742231] nixos[3880]: finished switching to system configuration /nix/store/1wnhnzkynd3bwxa90gisdfyr92sdgfll-nixos-system-machine-test1886machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 3.52 seconds)1887machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&11888machine # [ 95.493244] nixos[4024]: switching to system configuration /nix/store/scb7dwbnjbhzi29fwc56kj32jkv7gcn3-nixos-system-machine-test1889machine # [ 95.497971] systemd[1]: Stopped target Local File Systems.1890machine # [ 95.501051] systemd[1]: Stopped target Remote File Systems.1891machine # [ 95.502129] systemd[1]: instantiated@one.service: Deactivated successfully.1892machine # [ 95.503243] systemd[1]: Stopped instantiated@one.service.1893machine # [ 95.504652] systemd[1]: instantiated@two.service: Deactivated successfully.1894machine # [ 95.505973] systemd[1]: Stopped instantiated@two.service.1895machine # [ 96.095274] systemd[1]: Reload requested from client PID 4024 ('.switch-to-conf') (unit backdoor.service)...1896machine # [ 96.097741] systemd[1]: Reloading...1897machine # [ 96.874157] systemd[1]: Reloading finished in 772 ms.1898machine # [ 97.071655] systemd[585]: Reexecution requested from client PID 4093 ('switch-to-confi')...1899machine # [ 97.075114] systemd[585]: Reexecuting.1900machine # [ 97.152628] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1901machine # [ 97.381795] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1902machine # [ 97.389077] systemd[585]: Reload requested from client PID 4093 ('switch-to-confi')...1903machine # [ 97.391947] systemd[585]: Reloading...1904machine # [ 97.604852] systemd[585]: Reloading finished in 211 ms.1905machine # [ 97.620202] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1906machine # [ 97.630648] systemd[585]: Stopped Run user-specific NixOS activation.1907machine # [ 97.633338] systemd[585]: Stopping Run user-specific NixOS activation...1908machine # [ 97.636768] systemd[585]: Starting Run user-specific NixOS activation...1909machine # [ 97.692653] systemd[585]: Finished Run user-specific NixOS activation.1910machine # [ 97.697248] systemd[1]: Stopped target Reactivate sysinit units.1911machine # [ 97.701011] systemd[1]: Stopping Reactivate sysinit units...1912machine # [ 97.704550] systemd[1]: Reached target Reactivate sysinit units.1913machine # [ 97.708864] systemd[1]: Starting instantiated@one.service...1914machine # [ 97.719466] systemd[1]: Reached target Remote File Systems.1915machine # [ 97.724797] systemd[1]: Starting instantiated@two.service...1916machine # [ 97.735001] systemd[1]: Starting linger-users.service...1917machine # [ 97.751739] systemd[1]: Reached target Local File Systems.1918machine # [ 97.755000] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1919machine # [ 97.771328] systemd[1]: Starting Create SUID/SGID Wrappers...1920machine # [ 97.777080] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1921machine # [ 97.783851] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671922machine # [ 97.788849] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1923machine # [ 97.791685] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1924machine # [ 97.795709] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1925machine # [ 97.800533] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1926machine # [ 97.803487] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1927machine # [ 97.821165] systemd[1]: Finished instantiated@one.service.1928machine # [ 97.844673] systemd[1]: Finished instantiated@two.service.1929machine # [ 97.885498] systemd[1]: linger-users.service: Deactivated successfully.1930machine # [ 97.889030] systemd[1]: Finished linger-users.service.1931machine # [ 98.242493] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1932machine # [ 98.246090] systemd[1]: Finished Create SUID/SGID Wrappers.1933machine # [ 98.503411] nixos[4024]: finished switching to system configuration /nix/store/scb7dwbnjbhzi29fwc56kj32jkv7gcn3-nixos-system-machine-test1934machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 3.76 seconds)1935(finished: subtest: services, in 70.51 seconds)1936subtest: failing units1937machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11938machine # [ 99.184753] nixos[4168]: switching to system configuration /nix/store/gy3fjq6p259m8x8mj4dzk49y6m532qkp-nixos-system-machine-test1939machine # [ 99.189400] systemd[1]: Stopped target Local File Systems.1940machine # [ 99.192422] systemd[1]: Stopped target Remote File Systems.1941machine # [ 99.193707] systemd[1]: instantiated@one.service: Deactivated successfully.1942machine # [ 99.194972] systemd[1]: Stopped instantiated@one.service.1943machine # [ 99.195852] systemd[1]: instantiated@two.service: Deactivated successfully.1944machine # [ 99.197397] systemd[1]: Stopped instantiated@two.service.1945machine # [ 99.701418] systemd[1]: Reload requested from client PID 4168 ('.switch-to-conf') (unit backdoor.service)...1946machine # [ 99.703412] systemd[1]: Reloading...1947machine # [ 100.354892] systemd[1]: Reloading finished in 648 ms.1948machine # [ 100.506632] systemd[585]: Reexecution requested from client PID 4237 ('switch-to-confi')...1949machine # [ 100.509168] systemd[585]: Reexecuting.1950machine # [ 100.578938] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1951machine # [ 100.776136] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1952machine # [ 100.782737] systemd[585]: Reload requested from client PID 4237 ('switch-to-confi')...1953machine # [ 100.785293] systemd[585]: Reloading...1954machine # [ 100.978737] systemd[585]: Reloading finished in 192 ms.1955machine # [ 100.992176] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1956machine # [ 101.001765] systemd[585]: Stopped Run user-specific NixOS activation.1957machine # [ 101.004342] systemd[585]: Stopping Run user-specific NixOS activation...1958machine # [ 101.007384] systemd[585]: Starting Run user-specific NixOS activation...1959machine # [ 101.053897] systemd[585]: Finished Run user-specific NixOS activation.1960machine # [ 101.058178] systemd[1]: Stopped target Reactivate sysinit units.1961machine # [ 101.060294] systemd[1]: Stopping Reactivate sysinit units...1962machine # [ 101.061473] systemd[1]: Reached target Reactivate sysinit units.1963machine # [ 101.063805] systemd[1]: Reached target Remote File Systems.1964machine # [ 101.069667] systemd[1]: Starting linger-users.service...1965machine # [ 101.073115] systemd[1]: Starting test.service...1966machine # [ 101.076977] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1967machine # [ 101.082520] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1968machine # [ 101.094683] systemd[1]: Reached target Local File Systems.1969machine # [ 101.096892] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1970machine # [ 101.105521] systemd[1]: Starting Create SUID/SGID Wrappers...1971machine # [ 101.112749] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1972machine # [ 101.114029] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671973machine # [ 101.121013] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1974machine # [ 101.123446] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1975machine # [ 101.126666] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1976machine # [ 101.151073] systemd[1]: Finished test.service.1977machine # [ 101.189043] systemd[1]: linger-users.service: Deactivated successfully.1978machine # [ 101.192332] systemd[1]: Finished linger-users.service.1979machine # [ 101.476364] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1980machine # [ 101.479624] systemd[1]: Finished Create SUID/SGID Wrappers.1981machine # [ 101.735457] nixos[4168]: finished switching to system configuration /nix/store/gy3fjq6p259m8x8mj4dzk49y6m532qkp-nixos-system-machine-test1982machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 3.22 seconds)1983machine: must fail: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&11984machine # [ 102.404951] nixos[4310]: switching to system configuration /nix/store/nsimqwqf6732vg9sda04d9alvjiia6w0-nixos-system-machine-test1985machine # [ 102.409156] systemd[1]: Stopped target Local File Systems.1986machine # [ 102.411142] systemd[1]: Stopped target Remote File Systems.1987machine # [ 102.412665] systemd[1]: test.service: Deactivated successfully.1988machine # [ 102.413829] systemd[1]: Stopped test.service.1989machine # [ 102.957670] systemd[1]: Reload requested from client PID 4310 ('.switch-to-conf') (unit backdoor.service)...1990machine # [ 102.959791] systemd[1]: Reloading...1991machine # [ 103.640574] systemd[1]: Reloading finished in 676 ms.1992machine # [ 103.794707] systemd[585]: Reexecution requested from client PID 4379 ('switch-to-confi')...1993machine # [ 103.798418] systemd[585]: Reexecuting.1994machine # [ 103.846444] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1995machine # [ 104.046407] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1996machine # [ 104.052971] systemd[585]: Reload requested from client PID 4379 ('switch-to-confi')...1997machine # [ 104.055420] systemd[585]: Reloading...1998machine # [ 104.248548] systemd[585]: Reloading finished in 191 ms.1999machine # [ 104.264192] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2000machine # [ 104.273900] systemd[585]: Stopped Run user-specific NixOS activation.2001machine # [ 104.276471] systemd[585]: Stopping Run user-specific NixOS activation...2002machine # [ 104.279708] systemd[585]: Starting Run user-specific NixOS activation...2003machine # [ 104.329064] systemd[585]: Finished Run user-specific NixOS activation.2004machine # [ 104.333805] systemd[1]: Stopped target Reactivate sysinit units.2005machine # [ 104.336921] systemd[1]: Stopping Reactivate sysinit units...2006machine # [ 104.338394] systemd[1]: Reached target Reactivate sysinit units.2007machine # [ 104.341178] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2008machine # [ 104.344639] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2009machine # [ 104.348115] systemd[1]: Reached target Remote File Systems.2010machine # [ 104.356343] systemd[1]: Starting linger-users.service...2011machine # [ 104.360663] systemd[1]: Starting test.service...2012machine # [ 104.368871] systemd[1]: Reached target Local File Systems.2013machine # [ 104.370234] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2014machine # [ 104.380536] systemd[1]: Starting Create SUID/SGID Wrappers...2015machine # [ 104.381498] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2016machine # [ 104.382736] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672017machine # [ 104.393775] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2018machine # [ 104.395498] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2019machine # [ 104.396888] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2020machine # [ 104.440640] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE2021machine # [ 104.442098] systemd[1]: test.service: Failed with result 'exit-code'.2022machine # [ 104.443384] systemd[1]: Failed to start test.service.2023machine # [ 104.482469] systemd[1]: linger-users.service: Deactivated successfully.2024machine # [ 104.485628] systemd[1]: Finished linger-users.service.2025machine # [ 104.757004] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2026machine # [ 104.759725] systemd[1]: Finished Create SUID/SGID Wrappers.2027machine # [ 105.071456] nixos[4310]: switching to system configuration /nix/store/nsimqwqf6732vg9sda04d9alvjiia6w0-nixos-system-machine-test failed (status 4)2028machine: (finished: must fail: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 3.34 seconds)2029machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12030machine # [ 105.767117] nixos[4453]: switching to system configuration /nix/store/bya5912hwb45krcw58d883f9ihiarrq7-nixos-system-machine-test2031machine # [ 105.770012] systemd[1]: Stopped target Remote File Systems.2032machine # [ 105.771220] systemd[1]: Stopped target Local File Systems.2033machine # [ 106.324615] systemd[1]: Reload requested from client PID 4453 ('.switch-to-conf') (unit backdoor.service)...2034machine # [ 106.326718] systemd[1]: Reloading...2035machine # [ 107.014727] systemd[1]: Reloading finished in 685 ms.2036machine # [ 107.172141] systemd[585]: Reexecution requested from client PID 4522 ('switch-to-confi')...2037machine # [ 107.173650] systemd[585]: Reexecuting.2038machine # [ 107.248851] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2039machine # [ 107.457836] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2040machine # [ 107.464317] systemd[585]: Reload requested from client PID 4522 ('switch-to-confi')...2041machine # [ 107.466708] systemd[585]: Reloading...2042machine # [ 107.670804] systemd[585]: Reloading finished in 202 ms.2043machine # [ 107.685552] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2044machine # [ 107.694306] systemd[585]: Stopped Run user-specific NixOS activation.2045machine # [ 107.696691] systemd[585]: Stopping Run user-specific NixOS activation...2046machine # [ 107.699777] systemd[585]: Starting Run user-specific NixOS activation...2047machine # [ 107.749112] systemd[585]: Finished Run user-specific NixOS activation.2048machine # [ 107.753544] systemd[1]: Stopped target Reactivate sysinit units.2049machine # [ 107.754860] systemd[1]: Stopping Reactivate sysinit units...2050machine # [ 107.755673] systemd[1]: Reached target Reactivate sysinit units.2051machine # [ 107.758903] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2052machine # [ 107.762099] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2053machine # [ 107.768799] systemd[1]: Reached target Local File Systems.2054machine # [ 107.772273] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2055machine # [ 107.777078] systemd[1]: Starting Create SUID/SGID Wrappers...2056machine # [ 107.777961] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2057machine # [ 107.779222] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672058machine # [ 107.781914] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2059machine # [ 107.787869] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2060machine # [ 107.794240] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2061machine # [ 107.795546] systemd[1]: Reached target Remote File Systems.2062machine # [ 108.127796] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2063machine # [ 108.132629] systemd[1]: Finished Create SUID/SGID Wrappers.2064machine # [ 108.136646] systemd[1]: Started autorestart.service.2065machine # [ 108.140565] systemd[1]: Starting linger-users.service...2066machine # [ 108.188702] systemd[1]: autorestart.service: Deactivated successfully.2067machine # [ 108.215495] systemd[1]: linger-users.service: Deactivated successfully.2068machine # [ 108.218103] systemd[1]: Finished linger-users.service.2069machine # [ 108.477613] nixos[4453]: finished switching to system configuration /nix/store/bya5912hwb45krcw58d883f9ihiarrq7-nixos-system-machine-test2070machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 3.41 seconds)2071machine # [ 108.561573] systemd[1]: Stopped autorestart.service.2072machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12073machine # [ 109.114553] nixos[4600]: switching to system configuration /nix/store/bya5912hwb45krcw58d883f9ihiarrq7-nixos-system-machine-test2074machine # [ 109.117014] systemd[1]: Stopped target Local File Systems.2075machine # [ 109.119273] systemd[1]: Stopped target Remote File Systems.2076machine # [ 109.613902] systemd[1]: Reload requested from client PID 4600 ('.switch-to-conf') (unit backdoor.service)...2077machine # [ 109.616222] systemd[1]: Reloading...2078machine # [ 110.257477] systemd[1]: Reloading finished in 640 ms.2079machine # [ 110.409583] systemd[585]: Reexecution requested from client PID 4669 ('switch-to-confi')...2080machine # [ 110.413870] systemd[585]: Reexecuting.2081machine # [ 110.478332] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2082machine # [ 110.678591] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2083machine # [ 110.686628] systemd[585]: Reload requested from client PID 4669 ('switch-to-confi')...2084machine # [ 110.688544] systemd[585]: Reloading...2085machine # [ 110.895908] systemd[585]: Reloading finished in 205 ms.2086machine # [ 110.908231] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2087machine # [ 110.920114] systemd[585]: Stopped Run user-specific NixOS activation.2088machine # [ 110.921222] systemd[585]: Stopping Run user-specific NixOS activation...2089machine # [ 110.924990] systemd[585]: Starting Run user-specific NixOS activation...2090machine # [ 110.977807] systemd[585]: Finished Run user-specific NixOS activation.2091machine # [ 110.982886] systemd[1]: Stopped target Reactivate sysinit units.2092machine # [ 110.985793] systemd[1]: Stopping Reactivate sysinit units...2093machine # [ 110.986748] systemd[1]: Reached target Reactivate sysinit units.2094machine # [ 110.988374] systemd[1]: Reached target Local File Systems.2095machine # [ 110.991319] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2096machine # [ 110.999226] systemd[1]: Starting Create SUID/SGID Wrappers...2097machine # [ 111.002175] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2098machine # [ 111.005720] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672099machine # [ 111.009751] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2100machine # [ 111.011392] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2101machine # [ 111.017779] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2102machine # [ 111.019108] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2103machine # [ 111.027900] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2104machine # [ 111.029607] systemd[1]: Reached target Remote File Systems.2105machine # [ 111.382355] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2106machine # [ 111.384801] systemd[1]: Finished Create SUID/SGID Wrappers.2107machine # [ 111.392575] systemd[1]: Started autorestart.service.2108machine # [ 111.395646] systemd[1]: Starting linger-users.service...2109machine # [ 111.444116] systemd[1]: autorestart.service: Deactivated successfully.2110machine # [ 111.471697] systemd[1]: linger-users.service: Deactivated successfully.2111machine # [ 111.474514] systemd[1]: Finished linger-users.service.2112machine # [ 111.736591] nixos[4600]: finished switching to system configuration /nix/store/bya5912hwb45krcw58d883f9ihiarrq7-nixos-system-machine-test2113machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 3.18 seconds)2114machine # [ 111.819893] systemd[1]: Stopped autorestart.service.2115machine: must fail: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&12116machine # [ 112.440549] nixos[4747]: switching to system configuration /nix/store/cxhfhm17way0z5kcblql44avghhn12jf-nixos-system-machine-test2117machine # [ 112.443340] systemd[1]: Stopped target Local File Systems.2118machine # [ 112.445747] systemd[1]: Stopped target Remote File Systems.2119machine # [ 113.016908] systemd[1]: Reload requested from client PID 4747 ('.switch-to-conf') (unit backdoor.service)...2120machine # [ 113.019008] systemd[1]: Reloading...2121machine # [ 113.741193] systemd[1]: Reloading finished in 718 ms.2122machine # [ 113.895251] systemd[585]: Reexecution requested from client PID 4816 ('switch-to-confi')...2123machine # [ 113.898915] systemd[585]: Reexecuting.2124machine # [ 113.954361] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2125machine # [ 114.152929] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2126machine # [ 114.159508] systemd[585]: Reload requested from client PID 4816 ('switch-to-confi')...2127machine # [ 114.163249] systemd[585]: Reloading...2128machine # [ 114.358616] systemd[585]: Reloading finished in 196 ms.2129machine # [ 114.376167] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2130machine # [ 114.386627] systemd[585]: Stopped Run user-specific NixOS activation.2131machine # [ 114.389128] systemd[585]: Stopping Run user-specific NixOS activation...2132machine # [ 114.392274] systemd[585]: Starting Run user-specific NixOS activation...2133machine # [ 114.439329] systemd[585]: Finished Run user-specific NixOS activation.2134machine # [ 114.444104] systemd[1]: Stopped target Reactivate sysinit units.2135machine # [ 114.445077] systemd[1]: Stopping Reactivate sysinit units...2136machine # [ 114.445862] systemd[1]: Reached target Reactivate sysinit units.2137machine # [ 114.448893] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2138machine # [ 114.451492] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2139machine # [ 114.455110] systemd[1]: Reached target Local File Systems.2140machine # [ 114.457700] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2141machine # [ 114.465113] systemd[1]: Starting Create SUID/SGID Wrappers...2142machine # [ 114.466049] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2143machine # [ 114.467299] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672144machine # [ 114.469948] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2145machine # [ 114.476630] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2146machine # [ 114.480150] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2147machine # [ 114.484203] systemd[1]: Reached target Remote File Systems.2148machine # [ 114.811710] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2149machine # [ 114.816449] systemd[1]: Finished Create SUID/SGID Wrappers.2150machine # [ 114.820332] systemd[1]: Started autorestart.service.2151machine # [ 114.824579] systemd[1]: Starting linger-users.service...2152machine # [ 114.870714] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE2153machine # [ 114.874291] systemd[1]: autorestart.service: Failed with result 'exit-code'.2154machine # [ 114.899593] systemd[1]: linger-users.service: Deactivated successfully.2155machine # [ 114.902585] systemd[1]: Finished linger-users.service.2156machine # [ 115.224883] nixos[4747]: switching to system configuration /nix/store/cxhfhm17way0z5kcblql44avghhn12jf-nixos-system-machine-test failed (status 4)2157machine: (finished: must fail: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 3.40 seconds)2158(finished: subtest: failing units, in 16.72 seconds)2159subtest: unit file parser2160machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12161machine # [ 115.807764] nixos[4890]: switching to system configuration /nix/store/d0qy65pbkh24p02iya7ky7jn1dhqm4in-nixos-system-machine-test2162machine # [ 115.810544] systemd[1]: Stopped autorestart.service.2163machine # [ 115.814346] systemd[1]: Stopped target Local File Systems.2164machine # [ 115.815469] systemd[1]: Stopped target Remote File Systems.2165machine # [ 116.260502] systemd[1]: Reload requested from client PID 4890 ('.switch-to-conf') (unit backdoor.service)...2166machine # [ 116.262464] systemd[1]: Reloading...2167machine # [ 116.865921] systemd[1]: Reloading finished in 601 ms.2168machine # [ 117.028473] systemd[585]: Reexecution requested from client PID 4959 ('switch-to-confi')...2169machine # [ 117.032549] systemd[585]: Reexecuting.2170machine # [ 117.085986] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2171machine # [ 117.286652] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2172machine # [ 117.294830] systemd[585]: Reload requested from client PID 4959 ('switch-to-confi')...2173machine # [ 117.298095] systemd[585]: Reloading...2174machine # [ 117.501018] systemd[585]: Reloading finished in 203 ms.2175machine # [ 117.516198] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2176machine # [ 117.526829] systemd[585]: Stopped Run user-specific NixOS activation.2177machine # [ 117.527918] systemd[585]: Stopping Run user-specific NixOS activation...2178machine # [ 117.531172] systemd[585]: Starting Run user-specific NixOS activation...2179machine # [ 117.583261] systemd[585]: Finished Run user-specific NixOS activation.2180machine # [ 117.587435] systemd[1]: Stopped target Reactivate sysinit units.2181machine # [ 117.589366] systemd[1]: Stopping Reactivate sysinit units...2182machine # [ 117.590228] systemd[1]: Reached target Reactivate sysinit units.2183machine # [ 117.594651] systemd[1]: Reached target Remote File Systems.2184machine # [ 117.598277] systemd[1]: Reached target Local File Systems.2185machine # [ 117.601824] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2186machine # [ 117.606604] systemd[1]: Starting Create SUID/SGID Wrappers...2187machine # [ 117.607457] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2188machine # [ 117.612062] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672189machine # [ 117.620330] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2190machine # [ 117.621920] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2191machine # [ 117.623198] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2192machine # [ 117.626658] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2193machine # [ 117.627970] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2194machine # [ 117.936443] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2195machine # [ 117.940687] systemd[1]: Finished Create SUID/SGID Wrappers.2196machine # [ 117.944395] systemd[1]: Starting linger-users.service...2197machine # [ 117.948927] systemd[1]: Starting test.service...2198machine # [ 117.996978] systemd[1]: Finished test.service.2199machine # [ 118.023715] systemd[1]: linger-users.service: Deactivated successfully.2200machine # [ 118.026322] systemd[1]: Finished linger-users.service.2201machine # [ 118.284959] nixos[4890]: finished switching to system configuration /nix/store/d0qy65pbkh24p02iya7ky7jn1dhqm4in-nixos-system-machine-test2202machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.06 seconds)2203machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&12204machine # [ 118.963064] nixos[5032]: switching to system configuration /nix/store/qm73rnkc3sy9l9kbr1w60qy9hckpr73p-nixos-system-machine-test2205machine # [ 118.966977] systemd[1]: Stopped target Local File Systems.2206machine # [ 118.968571] systemd[1]: Stopped target Remote File Systems.2207machine # [ 119.516096] systemd[1]: Reload requested from client PID 5032 ('.switch-to-conf') (unit backdoor.service)...2208machine # [ 119.518077] systemd[1]: Reloading...2209machine # [ 120.205258] systemd[1]: Reloading finished in 683 ms.2210machine # [ 120.378302] systemd[585]: Reexecution requested from client PID 5101 ('switch-to-confi')...2211machine # [ 120.379677] systemd[585]: Reexecuting.2212machine # [ 120.450498] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2213machine # [ 120.654966] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2214machine # [ 120.661420] systemd[585]: Reload requested from client PID 5101 ('switch-to-confi')...2215machine # [ 120.663750] systemd[585]: Reloading...2216machine # [ 120.846720] systemd[585]: Reloading finished in 181 ms.2217machine # [ 120.860310] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2218machine # [ 120.869840] systemd[585]: Stopped Run user-specific NixOS activation.2219machine # [ 120.872151] systemd[585]: Stopping Run user-specific NixOS activation...2220machine # [ 120.876245] systemd[585]: Starting Run user-specific NixOS activation...2221machine # [ 120.928118] systemd[585]: Finished Run user-specific NixOS activation.2222machine # [ 120.932625] systemd[1]: Stopped target Reactivate sysinit units.2223machine # [ 120.936478] systemd[1]: Stopping Reactivate sysinit units...2224machine # [ 120.937404] systemd[1]: Reached target Reactivate sysinit units.2225machine # [ 120.938275] systemd[1]: test.service: Deactivated successfully.2226machine # [ 120.939086] systemd[1]: Stopped test.service.2227machine # [ 120.939708] systemd[1]: Stopping test.service...2228machine # [ 120.944307] systemd[1]: Starting test.service...2229machine # [ 120.984920] systemd[1]: Finished test.service.2230machine # [ 120.988766] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2231machine # [ 120.991722] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2232machine # [ 120.996579] systemd[1]: Reached target Remote File Systems.2233machine # [ 120.999427] systemd[1]: Reached target Local File Systems.2234machine # [ 121.006602] systemd[1]: Starting linger-users.service...2235machine # [ 121.009396] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2236machine # [ 121.020879] systemd[1]: Starting Create SUID/SGID Wrappers...2237machine # [ 121.021824] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2238machine # [ 121.023133] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672239machine # [ 121.032530] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2240machine # [ 121.034214] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2241machine # [ 121.035427] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2242machine # [ 121.104230] systemd[1]: linger-users.service: Deactivated successfully.2243machine # [ 121.107908] systemd[1]: Finished linger-users.service.2244machine # [ 121.372648] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2245machine # [ 121.375880] systemd[1]: Finished Create SUID/SGID Wrappers.2246machine # [ 121.632818] nixos[5032]: finished switching to system configuration /nix/store/qm73rnkc3sy9l9kbr1w60qy9hckpr73p-nixos-system-machine-test2247machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 3.35 seconds)2248machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&12249machine # [ 122.254638] nixos[5174]: switching to system configuration /nix/store/z4nmm814dvi0b60wanb0g4lh9hcc8k3f-nixos-system-machine-test2250machine # [ 122.257271] systemd[1]: Stopped target Remote File Systems.2251machine # [ 122.259637] systemd[1]: Stopped target Local File Systems.2252machine # [ 122.786596] systemd[1]: Reload requested from client PID 5174 ('.switch-to-conf') (unit backdoor.service)...2253machine # [ 122.788592] systemd[1]: Reloading...2254machine # [ 123.453862] systemd[1]: Reloading finished in 663 ms.2255machine # [ 123.612488] systemd[585]: Reexecution requested from client PID 5243 ('switch-to-confi')...2256machine # [ 123.616481] systemd[585]: Reexecuting.2257machine # [ 123.678057] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2258machine # [ 123.875526] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2259machine # [ 123.882093] systemd[585]: Reload requested from client PID 5243 ('switch-to-confi')...2260machine # [ 123.884516] systemd[585]: Reloading...2261machine # [ 124.068939] systemd[585]: Reloading finished in 183 ms.2262machine # [ 124.084183] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2263machine # [ 124.093921] systemd[585]: Stopped Run user-specific NixOS activation.2264machine # [ 124.096351] systemd[585]: Stopping Run user-specific NixOS activation...2265machine # [ 124.099240] systemd[585]: Starting Run user-specific NixOS activation...2266machine # [ 124.144711] systemd[585]: Finished Run user-specific NixOS activation.2267machine # [ 124.149046] systemd[1]: Stopped target Reactivate sysinit units.2268machine # [ 124.152485] systemd[1]: Stopping Reactivate sysinit units...2269machine # [ 124.153362] systemd[1]: Reached target Reactivate sysinit units.2270machine # [ 124.154261] systemd[1]: test.service: Deactivated successfully.2271machine # [ 124.155103] systemd[1]: Stopped test.service.2272machine # [ 124.155767] systemd[1]: Stopping test.service...2273machine # [ 124.159415] systemd[1]: Starting test.service...2274machine # [ 124.196605] systemd[1]: Finished test.service.2275machine # [ 124.200473] systemd[1]: Reached target Local File Systems.2276machine # [ 124.203126] systemd[1]: Reached target Remote File Systems.2277machine # [ 124.211903] systemd[1]: Starting linger-users.service...2278machine # [ 124.215191] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2279machine # [ 124.226859] systemd[1]: Starting Create SUID/SGID Wrappers...2280machine # [ 124.232528] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2281machine # [ 124.234132] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672282machine # [ 124.239192] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2283machine # [ 124.240936] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2284machine # [ 124.242170] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2285machine # [ 124.243372] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2286machine # [ 124.246475] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2287machine # [ 124.305122] systemd[1]: linger-users.service: Deactivated successfully.2288machine # [ 124.308340] systemd[1]: Finished linger-users.service.2289machine # [ 124.577113] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2290machine # [ 124.580463] systemd[1]: Finished Create SUID/SGID Wrappers.2291machine # [ 124.838980] nixos[5174]: finished switching to system configuration /nix/store/z4nmm814dvi0b60wanb0g4lh9hcc8k3f-nixos-system-machine-test2292machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 3.21 seconds)2293machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12294machine # [ 125.422874] nixos[5316]: switching to system configuration /nix/store/d0qy65pbkh24p02iya7ky7jn1dhqm4in-nixos-system-machine-test2295machine # [ 125.425819] systemd[1]: Stopped target Local File Systems.2296machine # [ 125.428464] systemd[1]: Stopped target Remote File Systems.2297machine # [ 125.895655] systemd[1]: Reload requested from client PID 5316 ('.switch-to-conf') (unit backdoor.service)...2298machine # [ 125.897956] systemd[1]: Reloading...2299machine # [ 126.466163] systemd[1]: Reloading finished in 564 ms.2300machine # [ 126.611534] systemd[585]: Reexecution requested from client PID 5385 ('switch-to-confi')...2301machine # [ 126.614016] systemd[585]: Reexecuting.2302machine # [ 126.682523] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2303machine # [ 126.886621] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2304machine # [ 126.894440] systemd[585]: Reload requested from client PID 5385 ('switch-to-confi')...2305machine # [ 126.896421] systemd[585]: Reloading...2306machine # [ 127.088977] systemd[585]: Reloading finished in 192 ms.2307machine # [ 127.104187] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2308machine # [ 127.114447] systemd[585]: Stopped Run user-specific NixOS activation.2309machine # [ 127.117063] systemd[585]: Stopping Run user-specific NixOS activation...2310machine # [ 127.120106] systemd[585]: Starting Run user-specific NixOS activation...2311machine # [ 127.167281] systemd[585]: Finished Run user-specific NixOS activation.2312machine # [ 127.171596] systemd[1]: Stopped target Reactivate sysinit units.2313machine # [ 127.173685] systemd[1]: Stopping Reactivate sysinit units...2314machine # [ 127.174555] systemd[1]: Reached target Reactivate sysinit units.2315machine # [ 127.178683] systemd[1]: test.service: Deactivated successfully.2316machine # [ 127.179605] systemd[1]: Stopped test.service.2317machine # [ 127.180597] systemd[1]: Stopping test.service...2318machine # [ 127.182975] systemd[1]: Starting test.service...2319machine # [ 127.220926] systemd[1]: Finished test.service.2320machine # [ 127.227432] systemd[1]: Reached target Local File Systems.2321machine # [ 127.231531] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2322machine # [ 127.236534] systemd[1]: Starting Create SUID/SGID Wrappers...2323machine # [ 127.242412] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2324machine # [ 127.248619] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672325machine # [ 127.250856] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2326machine # [ 127.254794] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2327machine # [ 127.258770] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2328machine # [ 127.259974] systemd[1]: Reached target Remote File Systems.2329machine # [ 127.260958] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2330machine # [ 127.262216] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2331machine # [ 127.584362] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2332machine # [ 127.588782] systemd[1]: Finished Create SUID/SGID Wrappers.2333machine # [ 127.593438] systemd[1]: Starting linger-users.service...2334machine # [ 127.664143] systemd[1]: linger-users.service: Deactivated successfully.2335machine # [ 127.667714] systemd[1]: Finished linger-users.service.2336machine # [ 127.924933] nixos[5316]: finished switching to system configuration /nix/store/d0qy65pbkh24p02iya7ky7jn1dhqm4in-nixos-system-machine-test2337machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.09 seconds)2338machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&12339machine # [ 128.582816] nixos[5458]: switching to system configuration /nix/store/pgwina1zqa7ah0vn1dbr1wncqxwsr3h9-nixos-system-machine-test2340machine # [ 128.586383] systemd[1]: Stopped target Local File Systems.2341machine # [ 128.587810] systemd[1]: Stopped target Remote File Systems.2342machine # [ 129.117359] systemd[1]: Reload requested from client PID 5458 ('.switch-to-conf') (unit backdoor.service)...2343machine # [ 129.119314] systemd[1]: Reloading...2344machine # [ 129.770302] systemd[1]: Reloading finished in 648 ms.2345machine # [ 129.931394] systemd[585]: Reexecution requested from client PID 5527 ('switch-to-confi')...2346machine # [ 129.933474] systemd[585]: Reexecuting.2347machine # [ 129.984847] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2348machine # [ 130.185405] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2349machine # [ 130.192529] systemd[585]: Reload requested from client PID 5527 ('switch-to-confi')...2350machine # [ 130.194851] systemd[585]: Reloading...2351machine # [ 130.384851] systemd[585]: Reloading finished in 188 ms.2352machine # [ 130.400192] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2353machine # [ 130.410620] systemd[585]: Stopped Run user-specific NixOS activation.2354machine # [ 130.411645] systemd[585]: Stopping Run user-specific NixOS activation...2355machine # [ 130.414869] systemd[585]: Starting Run user-specific NixOS activation...2356machine # [ 130.462771] systemd[585]: Finished Run user-specific NixOS activation.2357machine # [ 130.467075] systemd[1]: Stopped target Reactivate sysinit units.2358machine # [ 130.469623] systemd[1]: Stopping Reactivate sysinit units...2359machine # [ 130.471086] systemd[1]: Reached target Reactivate sysinit units.2360machine # [ 130.477246] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2361machine # [ 130.479729] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2362machine # [ 130.484312] systemd[1]: Reached target Remote File Systems.2363machine # [ 130.487772] systemd[1]: Starting linger-users.service...2364machine # [ 130.490408] systemd[1]: Reached target Local File Systems.2365machine # [ 130.493565] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2366machine # [ 130.505404] systemd[1]: Starting Create SUID/SGID Wrappers...2367machine # [ 130.506364] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2368machine # [ 130.507646] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672369machine # [ 130.511784] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2370machine # [ 130.517525] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2371machine # [ 130.520883] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2372machine # [ 130.578559] systemd[1]: linger-users.service: Deactivated successfully.2373machine # [ 130.582262] systemd[1]: Finished linger-users.service.2374machine # [ 130.854560] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2375machine # [ 130.857872] systemd[1]: Finished Create SUID/SGID Wrappers.2376machine # [ 131.116645] nixos[5458]: finished switching to system configuration /nix/store/pgwina1zqa7ah0vn1dbr1wncqxwsr3h9-nixos-system-machine-test2377machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 3.19 seconds)2378machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&12379machine # [ 131.763306] nixos[5598]: switching to system configuration /nix/store/3krcf7hrh31iiwqhkgf742jy06qhcd97-nixos-system-machine-test2380machine # [ 131.766593] systemd[1]: Stopped target Local File Systems.2381machine # [ 131.768079] systemd[1]: Stopped target Remote File Systems.2382machine # [ 132.283752] systemd[1]: Reload requested from client PID 5598 ('.switch-to-conf') (unit backdoor.service)...2383machine # [ 132.285935] systemd[1]: Reloading...2384machine # [ 132.949642] systemd[1]: Reloading finished in 660 ms.2385machine # [ 133.096623] systemd[585]: Reexecution requested from client PID 5667 ('switch-to-confi')...2386machine # [ 133.100412] systemd[585]: Reexecuting.2387machine # [ 133.150506] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2388machine # [ 133.343973] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2389machine # [ 133.350574] systemd[585]: Reload requested from client PID 5667 ('switch-to-confi')...2390machine # [ 133.353004] systemd[585]: Reloading...2391machine # [ 133.544450] systemd[585]: Reloading finished in 190 ms.2392machine # [ 133.560189] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2393machine # [ 133.570940] systemd[585]: Stopped Run user-specific NixOS activation.2394machine # [ 133.573414] systemd[585]: Stopping Run user-specific NixOS activation...2395machine # [ 133.576462] systemd[585]: Starting Run user-specific NixOS activation...2396machine # [ 133.622017] systemd[585]: Finished Run user-specific NixOS activation.2397machine # [ 133.626480] systemd[1]: Stopped target Reactivate sysinit units.2398machine # [ 133.631240] systemd[1]: Stopping Reactivate sysinit units...2399machine # [ 133.632762] systemd[1]: Reached target Reactivate sysinit units.2400machine # [ 133.633856] systemd[1]: test.service: Deactivated successfully.2401machine # [ 133.634853] systemd[1]: Stopped test.service.2402machine # [ 133.636829] systemd[1]: Stopping test.service...2403machine # [ 133.637828] systemd[1]: Starting test.service...2404machine # [ 133.676963] systemd[1]: Finished test.service.2405machine # [ 133.680543] systemd[1]: Reached target Remote File Systems.2406machine # [ 133.685679] systemd[1]: Starting linger-users.service...2407machine # [ 133.689367] systemd[1]: Reached target Local File Systems.2408machine # [ 133.693291] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2409machine # [ 133.697935] systemd[1]: Starting Create SUID/SGID Wrappers...2410machine # [ 133.698917] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2411machine # [ 133.705421] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672412machine # [ 133.707651] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2413machine # [ 133.720815] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2414machine # [ 133.722198] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2415machine # [ 133.723382] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2416machine # [ 133.726307] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2417machine # [ 133.790823] systemd[1]: linger-users.service: Deactivated successfully.2418machine # [ 133.793774] systemd[1]: Finished linger-users.service.2419machine # [ 134.067999] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2420machine # [ 134.071587] systemd[1]: Finished Create SUID/SGID Wrappers.2421machine # [ 134.328751] nixos[5598]: finished switching to system configuration /nix/store/3krcf7hrh31iiwqhkgf742jy06qhcd97-nixos-system-machine-test2422machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 3.21 seconds)2423machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&12424machine # [ 134.996946] nixos[5740]: switching to system configuration /nix/store/vm1pjgr4d1ihrksdrr9jhsqamx1g6zhx-nixos-system-machine-test2425machine # [ 135.000681] systemd[1]: Stopped target Local File Systems.2426machine # [ 135.002212] systemd[1]: Stopped target Remote File Systems.2427machine # [ 135.529945] systemd[1]: Reload requested from client PID 5740 ('.switch-to-conf') (unit backdoor.service)...2428machine # [ 135.532061] systemd[1]: Reloading...2429machine # [ 136.202701] systemd[1]: Reloading finished in 666 ms.2430machine # [ 136.353020] systemd[585]: Reexecution requested from client PID 5809 ('switch-to-confi')...2431machine # [ 136.356718] systemd[585]: Reexecuting.2432machine # [ 136.423069] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2433machine # [ 136.623819] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2434machine # [ 136.631102] systemd[585]: Reload requested from client PID 5809 ('switch-to-confi')...2435machine # [ 136.633993] systemd[585]: Reloading...2436machine # [ 136.831340] systemd[585]: Reloading finished in 196 ms.2437machine # [ 136.848185] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2438machine # [ 136.858488] systemd[585]: Stopped Run user-specific NixOS activation.2439machine # [ 136.861070] systemd[585]: Stopping Run user-specific NixOS activation...2440machine # [ 136.864204] systemd[585]: Starting Run user-specific NixOS activation...2441machine # [ 136.913040] systemd[585]: Finished Run user-specific NixOS activation.2442machine # [ 136.917380] systemd[1]: Stopped target Reactivate sysinit units.2443machine # [ 136.919638] systemd[1]: Stopping Reactivate sysinit units...2444machine # [ 136.921669] systemd[1]: Reached target Reactivate sysinit units.2445machine # [ 136.924488] systemd[1]: test.service: Deactivated successfully.2446machine # [ 136.925464] systemd[1]: Stopped test.service.2447machine # [ 136.926147] systemd[1]: Stopping test.service...2448machine # [ 136.929676] systemd[1]: Starting test.service...2449machine # [ 136.969756] systemd[1]: Finished test.service.2450machine # [ 136.976150] systemd[1]: Reached target Local File Systems.2451machine # [ 136.979777] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2452machine # [ 136.984365] systemd[1]: Starting Create SUID/SGID Wrappers...2453machine # [ 136.985266] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2454machine # [ 136.986471] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672455machine # [ 136.989927] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2456machine # [ 137.001208] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2457machine # [ 137.002545] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2458machine # [ 137.003712] systemd[1]: Reached target Remote File Systems.2459machine # [ 137.007595] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2460machine # [ 137.009081] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2461machine # [ 137.330102] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2462machine # [ 137.334725] systemd[1]: Finished Create SUID/SGID Wrappers.2463machine # [ 137.337480] systemd[1]: Starting linger-users.service...2464machine # [ 137.400823] systemd[1]: linger-users.service: Deactivated successfully.2465machine # [ 137.403474] systemd[1]: Finished linger-users.service.2466machine # [ 137.662463] nixos[5740]: finished switching to system configuration /nix/store/vm1pjgr4d1ihrksdrr9jhsqamx1g6zhx-nixos-system-machine-test2467machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 3.34 seconds)2468machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&12469machine # [ 138.397759] nixos[5882]: switching to system configuration /nix/store/ig3xvd4c5r8jxknz5w4ww7rr145yr4g5-nixos-system-machine-test2470machine # [ 138.401960] systemd[1]: Stopped target Local File Systems.2471machine # [ 138.403767] systemd[1]: Stopped target Remote File Systems.2472machine # [ 138.993621] systemd[1]: Reload requested from client PID 5882 ('.switch-to-conf') (unit backdoor.service)...2473machine # [ 138.995891] systemd[1]: Reloading...2474machine # [ 139.764482] systemd[1]: Reloading finished in 765 ms.2475machine # [ 139.933304] systemd[585]: Reexecution requested from client PID 5951 ('switch-to-confi')...2476machine # [ 139.937980] systemd[585]: Reexecuting.2477machine # [ 140.007373] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2478machine # [ 140.237877] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2479machine # [ 140.245251] systemd[585]: Reload requested from client PID 5951 ('switch-to-confi')...2480machine # [ 140.248099] systemd[585]: Reloading...2481machine # [ 140.472423] systemd[585]: Reloading finished in 222 ms.2482machine # [ 140.488224] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2483machine # [ 140.498388] systemd[585]: Stopped Run user-specific NixOS activation.2484machine # [ 140.500952] systemd[585]: Stopping Run user-specific NixOS activation...2485machine # [ 140.504076] systemd[585]: Starting Run user-specific NixOS activation...2486machine # [ 140.550780] systemd[585]: Finished Run user-specific NixOS activation.2487machine # [ 140.555311] systemd[1]: Stopped target Reactivate sysinit units.2488machine # [ 140.556736] systemd[1]: Stopping Reactivate sysinit units...2489machine # [ 140.557582] systemd[1]: Reached target Reactivate sysinit units.2490machine # [ 140.559987] systemd[1]: test.service: Deactivated successfully.2491machine # [ 140.563344] systemd[1]: Stopped test.service.2492machine # [ 140.564212] systemd[1]: Stopping test.service...2493machine # [ 140.566597] systemd[1]: Starting test.service...2494machine # [ 140.603571] systemd[1]: Finished test.service.2495machine # [ 140.607013] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2496machine # [ 140.609958] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2497machine # [ 140.614430] systemd[1]: Reached target Local File Systems.2498machine # [ 140.618231] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2499machine # [ 140.622336] systemd[1]: Starting Create SUID/SGID Wrappers...2500machine # [ 140.623241] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2501machine # [ 140.632685] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672502machine # [ 140.634939] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2503machine # [ 140.639834] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2504machine # [ 140.642932] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2505machine # [ 140.644584] systemd[1]: Reached target Remote File Systems.2506machine # [ 140.959188] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2507machine # [ 140.963514] systemd[1]: Finished Create SUID/SGID Wrappers.2508machine # [ 140.966386] systemd[1]: Starting linger-users.service...2509machine # [ 141.028392] systemd[1]: linger-users.service: Deactivated successfully.2510machine # [ 141.031438] systemd[1]: Finished linger-users.service.2511machine # [ 141.288644] nixos[5882]: finished switching to system configuration /nix/store/ig3xvd4c5r8jxknz5w4ww7rr145yr4g5-nixos-system-machine-test2512machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 3.63 seconds)2513machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12514machine # [ 141.899372] nixos[6024]: switching to system configuration /nix/store/d0qy65pbkh24p02iya7ky7jn1dhqm4in-nixos-system-machine-test2515machine # [ 141.902154] systemd[1]: Stopped target Remote File Systems.2516machine # [ 141.904528] systemd[1]: Stopped target Local File Systems.2517machine # [ 142.359088] systemd[1]: Reload requested from client PID 6024 ('.switch-to-conf') (unit backdoor.service)...2518machine # [ 142.361229] systemd[1]: Reloading...2519machine # [ 142.960947] systemd[1]: Reloading finished in 597 ms.2520machine # [ 143.110972] systemd[585]: Reexecution requested from client PID 6093 ('switch-to-confi')...2521machine # [ 143.113431] systemd[585]: Reexecuting.2522machine # [ 143.178090] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2523machine # [ 143.369124] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2524machine # [ 143.375912] systemd[585]: Reload requested from client PID 6093 ('switch-to-confi')...2525machine # [ 143.379133] systemd[585]: Reloading...2526machine # [ 143.565214] systemd[585]: Reloading finished in 187 ms.2527machine # [ 143.580168] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2528machine # [ 143.589790] systemd[585]: Stopped Run user-specific NixOS activation.2529machine # [ 143.592119] systemd[585]: Stopping Run user-specific NixOS activation...2530machine # [ 143.595083] systemd[585]: Starting Run user-specific NixOS activation...2531machine # [ 143.640196] systemd[585]: Finished Run user-specific NixOS activation.2532machine # [ 143.645010] systemd[1]: Stopped target Reactivate sysinit units.2533machine # [ 143.645945] systemd[1]: Stopping Reactivate sysinit units...2534machine # [ 143.646783] systemd[1]: Reached target Reactivate sysinit units.2535machine # [ 143.649148] systemd[1]: test.service: Deactivated successfully.2536machine # [ 143.652210] systemd[1]: Stopped test.service.2537machine # [ 143.653077] systemd[1]: Stopping test.service...2538machine # [ 143.655278] systemd[1]: Starting test.service...2539machine # [ 143.691107] systemd[1]: Finished test.service.2540machine # [ 143.696435] systemd[1]: Reached target Remote File Systems.2541machine # [ 143.701664] systemd[1]: Starting linger-users.service...2542machine # [ 143.704975] systemd[1]: Reached target Local File Systems.2543machine # [ 143.713662] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2544machine # [ 143.715078] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2545machine # [ 143.719821] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2546machine # [ 143.729561] systemd[1]: Starting Create SUID/SGID Wrappers...2547machine # [ 143.730483] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2548machine # [ 143.731714] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672549machine # [ 143.735125] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2550machine # [ 143.737499] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2551machine # [ 143.739114] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2552machine # [ 143.803395] systemd[1]: linger-users.service: Deactivated successfully.2553machine # [ 143.806440] systemd[1]: Finished linger-users.service.2554machine # [ 144.101443] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2555machine # [ 144.104796] systemd[1]: Finished Create SUID/SGID Wrappers.2556machine # [ 144.363296] nixos[6024]: finished switching to system configuration /nix/store/d0qy65pbkh24p02iya7ky7jn1dhqm4in-nixos-system-machine-test2557machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.07 seconds)2558machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&12559machine # [ 145.001054] nixos[6166]: switching to system configuration /nix/store/rlla9fkk2jafr014cg9chfmc8knhgq51-nixos-system-machine-test2560machine # [ 145.004650] systemd[1]: Stopped target Local File Systems.2561machine # [ 145.006098] systemd[1]: Stopped target Remote File Systems.2562machine # [ 145.503690] systemd[1]: Reload requested from client PID 6166 ('.switch-to-conf') (unit backdoor.service)...2563machine # [ 145.506017] systemd[1]: Reloading...2564machine # [ 146.153984] systemd[1]: Reloading finished in 645 ms.2565machine # [ 146.301775] systemd[585]: Reexecution requested from client PID 6235 ('switch-to-confi')...2566machine # [ 146.306449] systemd[585]: Reexecuting.2567machine # [ 146.366025] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2568machine # [ 146.559782] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2569machine # [ 146.567177] systemd[585]: Reload requested from client PID 6235 ('switch-to-confi')...2570machine # [ 146.568748] systemd[585]: Reloading...2571machine # [ 146.755973] systemd[585]: Reloading finished in 186 ms.2572machine # [ 146.772166] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2573machine # [ 146.781359] systemd[585]: Stopped Run user-specific NixOS activation.2574machine # [ 146.783809] systemd[585]: Stopping Run user-specific NixOS activation...2575machine # [ 146.786751] systemd[585]: Starting Run user-specific NixOS activation...2576machine # [ 146.834383] systemd[585]: Finished Run user-specific NixOS activation.2577machine # [ 146.838535] systemd[1]: Stopped target Reactivate sysinit units.2578machine # [ 146.842679] systemd[1]: Stopping Reactivate sysinit units...2579machine # [ 146.843830] systemd[1]: Reached target Reactivate sysinit units.2580machine # [ 146.846321] systemd[1]: Reloading test.service...2581machine # [ 146.883420] systemd[1]: Reloaded test.service.2582machine # [ 146.890754] systemd[1]: Reached target Local File Systems.2583machine # [ 146.894327] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2584machine # [ 146.899044] systemd[1]: Starting Create SUID/SGID Wrappers...2585machine # [ 146.899952] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2586machine # [ 146.903224] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672587machine # [ 146.912600] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2588machine # [ 146.914222] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2589machine # [ 146.915489] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2590machine # [ 146.919337] systemd[1]: Reached target Remote File Systems.2591machine # [ 146.921204] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2592machine # [ 146.922534] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2593machine # [ 147.251679] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2594machine # [ 147.256820] systemd[1]: Finished Create SUID/SGID Wrappers.2595machine # [ 147.259577] systemd[1]: Starting linger-users.service...2596machine # [ 147.322023] systemd[1]: linger-users.service: Deactivated successfully.2597machine # [ 147.324655] systemd[1]: Finished linger-users.service.2598machine # [ 147.582812] nixos[6166]: finished switching to system configuration /nix/store/rlla9fkk2jafr014cg9chfmc8knhgq51-nixos-system-machine-test2599machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 3.22 seconds)2600machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&12601machine # [ 148.201605] nixos[6308]: switching to system configuration /nix/store/ws8jncql3yvpa6cp225alagyd6bam0jn-nixos-system-machine-test2602machine # [ 148.204390] systemd[1]: Stopped target Remote File Systems.2603machine # [ 148.206077] systemd[1]: Stopped target Local File Systems.2604machine # [ 148.702598] systemd[1]: Reload requested from client PID 6308 ('.switch-to-conf') (unit backdoor.service)...2605machine # [ 148.704650] systemd[1]: Reloading...2606machine # [ 149.335266] systemd[1]: Reloading finished in 628 ms.2607machine # [ 149.479829] systemd[585]: Reexecution requested from client PID 6377 ('switch-to-confi')...2608machine # [ 149.481989] systemd[585]: Reexecuting.2609machine # [ 149.549893] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2610machine # [ 149.739366] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2611machine # [ 149.746061] systemd[585]: Reload requested from client PID 6377 ('switch-to-confi')...2612machine # [ 149.748213] systemd[585]: Reloading...2613machine # [ 149.931695] systemd[585]: Reloading finished in 182 ms.2614machine # [ 149.944149] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2615machine # [ 149.953406] systemd[585]: Stopped Run user-specific NixOS activation.2616machine # [ 149.955705] systemd[585]: Stopping Run user-specific NixOS activation...2617machine # [ 149.958519] systemd[585]: Starting Run user-specific NixOS activation...2618machine # [ 150.005086] systemd[585]: Finished Run user-specific NixOS activation.2619machine # [ 150.009666] systemd[1]: Stopped target Reactivate sysinit units.2620machine # [ 150.010580] systemd[1]: Stopping Reactivate sysinit units...2621machine # [ 150.011348] systemd[1]: Reached target Reactivate sysinit units.2622machine # [ 150.016875] systemd[1]: Reloading test.service...2623machine # [ 150.050266] systemd[1]: Reloaded test.service.2624machine # [ 150.056008] systemd[1]: Reached target Local File Systems.2625machine # [ 150.058243] systemd[1]: Reached target Remote File Systems.2626machine # [ 150.062807] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2627machine # [ 150.066361] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2628machine # [ 150.069966] systemd[1]: Starting linger-users.service...2629machine # [ 150.074185] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2630machine # [ 150.078937] systemd[1]: Starting Create SUID/SGID Wrappers...2631machine # [ 150.079836] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2632machine # [ 150.081385] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672633machine # [ 150.088248] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2634machine # [ 150.092223] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2635machine # [ 150.093518] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2636machine # [ 150.160997] systemd[1]: linger-users.service: Deactivated successfully.2637machine # [ 150.163809] systemd[1]: Finished linger-users.service.2638machine # [ 150.421349] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2639machine # [ 150.424684] systemd[1]: Finished Create SUID/SGID Wrappers.2640machine # [ 150.682876] nixos[6308]: finished switching to system configuration /nix/store/ws8jncql3yvpa6cp225alagyd6bam0jn-nixos-system-machine-test2641machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 3.10 seconds)2642machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&12643machine # [ 151.295837] nixos[6450]: switching to system configuration /nix/store/c5k1jr5as9rsc328yd8jf5c2q2417v04-nixos-system-machine-test2644machine # [ 151.298596] systemd[1]: Stopped target Remote File Systems.2645machine # [ 151.300819] systemd[1]: Stopped target Local File Systems.2646machine # [ 151.792123] systemd[1]: Reload requested from client PID 6450 ('.switch-to-conf') (unit backdoor.service)...2647machine # [ 151.794101] systemd[1]: Reloading...2648machine # [ 152.421941] systemd[1]: Reloading finished in 625 ms.2649machine # [ 152.562986] systemd[585]: Reexecution requested from client PID 6519 ('switch-to-confi')...2650machine # [ 152.565210] systemd[585]: Reexecuting.2651machine # [ 152.634049] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2652machine # [ 152.823971] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2653machine # [ 152.830366] systemd[585]: Reload requested from client PID 6519 ('switch-to-confi')...2654machine # [ 152.832803] systemd[585]: Reloading...2655machine # [ 153.016270] systemd[585]: Reloading finished in 182 ms.2656machine # [ 153.032172] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2657machine # [ 153.041128] systemd[585]: Stopped Run user-specific NixOS activation.2658machine # [ 153.043435] systemd[585]: Stopping Run user-specific NixOS activation...2659machine # [ 153.046309] systemd[585]: Starting Run user-specific NixOS activation...2660machine # [ 153.092627] systemd[585]: Finished Run user-specific NixOS activation.2661machine # [ 153.096690] systemd[1]: Stopped target Reactivate sysinit units.2662machine # [ 153.098633] systemd[1]: Stopping Reactivate sysinit units...2663machine # [ 153.102420] systemd[1]: Reached target Reactivate sysinit units.2664machine # [ 153.103549] systemd[1]: test.service: Deactivated successfully.2665machine # [ 153.105856] systemd[1]: Stopped test.service.2666machine # [ 153.106531] systemd[1]: Stopping test.service...2667machine # [ 153.107157] systemd[1]: Starting test.service...2668machine # [ 153.142458] systemd[1]: Finished test.service.2669machine # [ 153.147289] systemd[1]: Reached target Remote File Systems.2670machine # [ 153.152605] systemd[1]: Starting linger-users.service...2671machine # [ 153.160419] systemd[1]: Reached target Local File Systems.2672machine # [ 153.165250] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2673machine # [ 153.170981] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2674machine # [ 153.173134] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2675machine # [ 153.176837] systemd[1]: Starting Create SUID/SGID Wrappers...2676machine # [ 153.184675] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2677machine # [ 153.185958] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672678machine # [ 153.191693] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2679machine # [ 153.194116] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2680machine # [ 153.195676] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2681machine # [ 153.245812] systemd[1]: linger-users.service: Deactivated successfully.2682machine # [ 153.249129] systemd[1]: Finished linger-users.service.2683machine # [ 153.516702] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2684machine # [ 153.519965] systemd[1]: Finished Create SUID/SGID Wrappers.2685machine # [ 153.778787] nixos[6450]: finished switching to system configuration /nix/store/c5k1jr5as9rsc328yd8jf5c2q2417v04-nixos-system-machine-test2686machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 3.10 seconds)2687machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&12688machine # [ 154.340359] nixos[6592]: switching to system configuration /nix/store/3krcf7hrh31iiwqhkgf742jy06qhcd97-nixos-system-machine-test2689machine # [ 154.342774] systemd[1]: Stopped target Remote File Systems.2690machine # [ 154.345017] systemd[1]: Stopped target Local File Systems.2691machine # [ 154.781724] systemd[1]: Reload requested from client PID 6592 ('.switch-to-conf') (unit backdoor.service)...2692machine # [ 154.783686] systemd[1]: Reloading...2693machine # [ 155.366484] systemd[1]: Reloading finished in 580 ms.2694machine # [ 155.503611] systemd[585]: Reexecution requested from client PID 6661 ('switch-to-confi')...2695machine # [ 155.507199] systemd[585]: Reexecuting.2696machine # [ 155.565941] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2697machine # [ 155.750611] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2698machine # [ 155.757083] systemd[585]: Reload requested from client PID 6661 ('switch-to-confi')...2699machine # [ 155.759240] systemd[585]: Reloading...2700machine # [ 155.942039] systemd[585]: Reloading finished in 181 ms.2701machine # [ 155.956168] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2702machine # [ 155.964813] systemd[585]: Stopped Run user-specific NixOS activation.2703machine # [ 155.967075] systemd[585]: Stopping Run user-specific NixOS activation...2704machine # [ 155.969899] systemd[585]: Starting Run user-specific NixOS activation...2705machine # [ 156.017804] systemd[585]: Finished Run user-specific NixOS activation.2706machine # [ 156.022140] systemd[1]: Stopped target Reactivate sysinit units.2707machine # [ 156.023053] systemd[1]: Stopping Reactivate sysinit units...2708machine # [ 156.025213] systemd[1]: Reached target Reactivate sysinit units.2709machine # [ 156.028540] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2710machine # [ 156.029810] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2711machine # [ 156.033282] systemd[1]: Reached target Local File Systems.2712machine # [ 156.036424] systemd[1]: Reached target Remote File Systems.2713machine # [ 156.037381] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2714machine # [ 156.042027] systemd[1]: Starting Create SUID/SGID Wrappers...2715machine # [ 156.042944] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2716machine # [ 156.045433] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672717machine # [ 156.051275] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2718machine # [ 156.056839] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2719machine # [ 156.058103] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2720machine # [ 156.363364] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2721machine # [ 156.366058] systemd[1]: Finished Create SUID/SGID Wrappers.2722machine # [ 156.371344] systemd[1]: Starting linger-users.service...2723machine # [ 156.431561] systemd[1]: linger-users.service: Deactivated successfully.2724machine # [ 156.433891] systemd[1]: Finished linger-users.service.2725machine # [ 156.691833] nixos[6592]: finished switching to system configuration /nix/store/3krcf7hrh31iiwqhkgf742jy06qhcd97-nixos-system-machine-test2726machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 2.91 seconds)2727(finished: subtest: unit file parser, in 41.47 seconds)2728subtest: restart and reload by activation script2729machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&12730machine # [ 157.274903] nixos[6732]: switching to system configuration /nix/store/f5kh5ksvsw0mmvzxjly7ahqqrysj4r0q-nixos-system-machine-test2731machine # [ 157.277542] systemd[1]: Stopped target Remote File Systems.2732machine # [ 157.279740] systemd[1]: Stopped target Local File Systems.2733machine # [ 157.712760] systemd[1]: Reload requested from client PID 6732 ('.switch-to-conf') (unit backdoor.service)...2734machine # [ 157.714678] systemd[1]: Reloading...2735machine # [ 158.288954] systemd[1]: Reloading finished in 571 ms.2736machine # [ 158.426535] systemd[585]: Reexecution requested from client PID 6800 ('switch-to-confi')...2737machine # [ 158.427872] systemd[585]: Reexecuting.2738machine # [ 158.493660] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2739machine # [ 158.677511] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2740machine # [ 158.684066] systemd[585]: Reload requested from client PID 6800 ('switch-to-confi')...2741machine # [ 158.685939] systemd[585]: Reloading...2742machine # [ 158.865676] systemd[585]: Reloading finished in 178 ms.2743machine # [ 158.884134] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2744machine # [ 158.893357] systemd[585]: Stopped Run user-specific NixOS activation.2745machine # [ 158.895553] systemd[585]: Stopping Run user-specific NixOS activation...2746machine # [ 158.898253] systemd[585]: Starting Run user-specific NixOS activation...2747machine # [ 158.943392] systemd[585]: Finished Run user-specific NixOS activation.2748machine # [ 158.947335] systemd[1]: Stopped target Reactivate sysinit units.2749machine # [ 158.949124] systemd[1]: Stopping Reactivate sysinit units...2750machine # [ 158.949939] systemd[1]: Reached target Reactivate sysinit units.2751machine # [ 158.953080] systemd[1]: Reached target Remote File Systems.2752machine # [ 158.957409] systemd[1]: Starting linger-users.service...2753machine # [ 158.961256] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2754machine # [ 158.966201] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2755machine # [ 158.969669] systemd[1]: Reached target Local File Systems.2756machine # [ 158.980586] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2757machine # [ 158.982181] systemd[1]: Starting Create SUID/SGID Wrappers...2758machine # [ 158.983009] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2759machine # [ 158.986851] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672760machine # [ 158.993642] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2761machine # [ 158.995791] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2762machine # [ 158.998360] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2763machine # [ 159.053385] systemd[1]: linger-users.service: Deactivated successfully.2764machine # [ 159.056488] systemd[1]: Finished linger-users.service.2765machine # [ 159.312078] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2766machine # [ 159.314861] systemd[1]: Finished Create SUID/SGID Wrappers.2767machine # [ 159.573994] nixos[6732]: finished switching to system configuration /nix/store/f5kh5ksvsw0mmvzxjly7ahqqrysj4r0q-nixos-system-machine-test2768machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 2.88 seconds)2769machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12770machine # [ 160.174771] nixos[6872]: switching to system configuration /nix/store/4cqqxp58hhnhckxc6mpa1h1d4sqi7cg4-nixos-system-machine-test2771machine # [ 160.177219] systemd[1]: test.service: Deactivated successfully.2772machine # [ 160.180434] systemd[1]: Stopped test.service.2773machine # [ 160.181260] systemd[1]: Stopped target Remote File Systems.2774machine # [ 160.182160] systemd[1]: Stopped target Local File Systems.2775machine # [ 160.675527] systemd[1]: Reload requested from client PID 6872 ('.switch-to-conf') (unit backdoor.service)...2776machine # [ 160.677689] systemd[1]: Reloading...2777machine # [ 161.321146] systemd[1]: Reloading finished in 641 ms.2778machine # [ 161.459340] systemd[585]: Reexecution requested from client PID 6943 ('switch-to-confi')...2779machine # [ 161.462666] systemd[585]: Reexecuting.2780machine # [ 161.517532] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2781machine # [ 161.698179] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2782machine # [ 161.704085] systemd[585]: Reload requested from client PID 6943 ('switch-to-confi')...2783machine # [ 161.706357] systemd[585]: Reloading...2784machine # [ 161.887672] systemd[585]: Reloading finished in 180 ms.2785machine # [ 161.900151] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2786machine # [ 161.908712] systemd[585]: Stopped Run user-specific NixOS activation.2787machine # [ 161.910902] systemd[585]: Stopping Run user-specific NixOS activation...2788machine # [ 161.913625] systemd[585]: Starting Run user-specific NixOS activation...2789machine # [ 161.958445] systemd[585]: Finished Run user-specific NixOS activation.2790machine # [ 161.962417] systemd[1]: Stopped target Reactivate sysinit units.2791machine # [ 161.964244] systemd[1]: Stopping Reactivate sysinit units...2792machine # [ 161.965247] systemd[1]: Reached target Reactivate sysinit units.2793machine # [ 161.973587] systemd[1]: Created slice Slice /system/templated-simple-reload-service.2794machine # [ 161.978558] systemd[1]: Starting templated-simple-reload-service@instance.service...2795machine # [ 161.993700] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as.2796machine # [ 161.998680] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2797machine # [ 162.004495] systemd[1]: Reached target Remote File Systems.2798machine # [ 162.015358] systemd[1]: Starting simple-restart-service.service...2799machine # [ 162.026829] systemd[1]: Created slice Slice /system/templated-reload-triggers.2800machine # [ 162.027955] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart.2801machine # [ 162.035120] systemd[1]: Starting linger-users.service...2802machine # [ 162.043641] systemd[1]: Starting reload-triggers-and-restart.service...2803machine # [ 162.056303] systemd[1]: Starting reload-triggers.service...2804machine # [ 162.057101] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2805machine # [ 162.076492] systemd[1]: Starting templated-reload-triggers@instance.service...2806machine # [ 162.091762] systemd[1]: Reached target Local File Systems.2807machine # [ 162.108729] systemd[1]: Starting simple-reload-service.service...2808machine # [ 162.116495] systemd[1]: Finished templated-simple-reload-service@instance.service.2809machine # [ 162.121344] systemd[1]: Created slice Slice /system/templated-simple-restart-service.2810machine # [ 162.140259] systemd[1]: Created slice Slice /system/templated-simple-service.2811machine # [ 162.156813] systemd[1]: Starting templated-simple-restart-service@instance.service...2812machine # [ 162.182612] systemd[1]: Starting templated-simple-service@instance.service...2813machine # [ 162.183684] systemd[1]: Created slice Slice /system/templated-no-restart-service.2814machine # [ 162.219207] systemd[1]: Starting templated-no-restart-service@instance.service...2815machine # [ 162.238124] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2816machine # [ 162.239240] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2817machine # [ 162.266599] systemd[1]: Starting simple-service.service...2818machine # [ 162.281647] systemd[1]: Starting no-restart-service.service...2819machine # [ 162.295931] systemd[1]: Finished simple-restart-service.service.2820machine # [ 162.311006] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2821machine # [ 162.320877] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2822machine # [ 162.332257] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2823machine # [ 162.336409] systemd[1]: Starting Create SUID/SGID Wrappers...2824machine # [ 162.337696] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2825machine # [ 162.340327] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672826machine # [ 162.344542] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2827machine # [ 162.350102] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2828machine # [ 162.351942] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2829machine # [ 162.354670] systemd[1]: Finished reload-triggers-and-restart.service.2830machine # [ 162.359116] systemd[1]: Finished reload-triggers.service.2831machine # [ 162.359903] systemd[1]: Finished templated-reload-triggers@instance.service.2832machine # [ 162.363269] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2833machine # [ 162.367166] systemd[1]: Finished simple-reload-service.service.2834machine # [ 162.369259] systemd[1]: Finished templated-simple-restart-service@instance.service.2835machine # [ 162.371556] systemd[1]: Finished templated-simple-service@instance.service.2836machine # [ 162.374605] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2837machine # [ 162.375896] systemd[1]: Finished templated-no-restart-service@instance.service.2838machine # [ 162.377614] systemd[1]: Finished simple-service.service.2839machine # [ 162.378359] systemd[1]: Finished no-restart-service.service.2840machine # [ 162.379108] systemd[1]: linger-users.service: Deactivated successfully.2841machine # [ 162.379956] systemd[1]: Finished linger-users.service.2842machine # [ 162.647497] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2843machine # [ 162.650416] systemd[1]: Finished Create SUID/SGID Wrappers.2844machine # [ 162.909858] nixos[6872]: finished switching to system configuration /nix/store/4cqqxp58hhnhckxc6mpa1h1d4sqi7cg4-nixos-system-machine-test2845machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.34 seconds)2846machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12847machine # [ 163.596915] nixos[7042]: switching to system configuration /nix/store/4cqqxp58hhnhckxc6mpa1h1d4sqi7cg4-nixos-system-machine-test2848machine # [ 163.599855] systemd[1]: Stopped target Local File Systems.2849machine # [ 163.601659] systemd[1]: Stopped target Remote File Systems.2850machine # [ 164.073728] systemd[1]: Reload requested from client PID 7042 ('.switch-to-conf') (unit backdoor.service)...2851machine # [ 164.075588] systemd[1]: Reloading...2852machine # [ 164.672907] systemd[1]: Reloading finished in 595 ms.2853machine # [ 164.814543] systemd[585]: Reexecution requested from client PID 7112 ('switch-to-confi')...2854machine # [ 164.818132] systemd[585]: Reexecuting.2855machine # [ 164.877634] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2856machine # [ 165.061381] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2857machine # [ 165.067503] systemd[585]: Reload requested from client PID 7112 ('switch-to-confi')...2858machine # [ 165.069906] systemd[585]: Reloading...2859machine # [ 165.248054] systemd[585]: Reloading finished in 177 ms.2860machine # [ 165.264135] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2861machine # [ 165.272672] systemd[585]: Stopped Run user-specific NixOS activation.2862machine # [ 165.274765] systemd[585]: Stopping Run user-specific NixOS activation...2863machine # [ 165.277293] systemd[585]: Starting Run user-specific NixOS activation...2864machine # [ 165.318236] systemd[585]: Finished Run user-specific NixOS activation.2865machine # [ 165.321872] systemd[1]: Stopped target Reactivate sysinit units.2866machine # [ 165.324410] systemd[1]: Stopping Reactivate sysinit units...2867machine # [ 165.325239] systemd[1]: Reached target Reactivate sysinit units.2868machine # [ 165.330542] systemd[1]: Reloading reload-triggers-and-restart.service...2869machine # [ 165.335099] systemd[1]: Reloading reload-triggers.service...2870machine # [ 165.343258] systemd[1]: Reloading simple-reload-service.service...2871machine # [ 165.351713] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service...2872machine # [ 165.359358] systemd[1]: Reloading templated-reload-triggers@instance.service...2873machine # [ 165.371921] systemd[1]: Reloading templated-simple-reload-service@instance.service...2874machine # [ 165.427095] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service.2875machine # [ 165.432400] systemd[1]: Reloaded reload-triggers-and-restart.service.2876machine # [ 165.433295] systemd[1]: Reloaded reload-triggers.service.2877machine # [ 165.434049] systemd[1]: Reloaded simple-reload-service.service.2878machine # [ 165.435828] systemd[1]: Reloaded templated-reload-triggers@instance.service.2879machine # [ 165.446246] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2880machine # [ 165.449810] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2881machine # [ 165.451206] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2882machine # [ 165.454013] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2883machine # [ 165.454967] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2884machine # [ 165.458097] systemd[1]: simple-restart-service.service: Deactivated successfully.2885machine # [ 165.459848] systemd[1]: Stopped simple-restart-service.service.2886machine # [ 165.464460] systemd[1]: Stopping simple-restart-service.service...2887machine # [ 165.468388] systemd[1]: Starting simple-restart-service.service...2888machine # [ 165.469573] systemd[1]: simple-service.service: Deactivated successfully.2889machine # [ 165.476481] systemd[1]: Stopped simple-service.service.2890machine # [ 165.477262] systemd[1]: Stopping simple-service.service...2891machine # [ 165.478029] systemd[1]: Starting simple-service.service...2892machine # [ 165.478753] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2893machine # [ 165.479999] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2894machine # [ 165.485858] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2895machine # [ 165.492170] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2896machine # [ 165.498936] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2897machine # [ 165.504489] systemd[1]: Stopped templated-simple-restart-service@instance.service.2898machine # [ 165.505629] systemd[1]: Stopping templated-simple-restart-service@instance.service...2899machine # [ 165.506840] systemd[1]: Starting templated-simple-restart-service@instance.service...2900machine # [ 165.507868] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2901machine # [ 165.514813] systemd[1]: Stopped templated-simple-service@instance.service.2902machine # [ 165.523727] systemd[1]: Stopping templated-simple-service@instance.service...2903machine # [ 165.528143] systemd[1]: Starting templated-simple-service@instance.service...2904machine # [ 165.554071] systemd[1]: Finished simple-service.service.2905machine # [ 165.567392] systemd[1]: Finished simple-restart-service.service.2906machine # [ 165.571131] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2907machine # [ 165.577390] systemd[1]: Finished templated-simple-restart-service@instance.service.2908machine # [ 165.583393] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2909machine # [ 165.586335] systemd[1]: Finished templated-simple-service@instance.service.2910machine # [ 165.590365] systemd[1]: Reached target Local File Systems.2911machine # [ 165.593617] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2912machine # [ 165.598162] systemd[1]: Starting Create SUID/SGID Wrappers...2913machine # [ 165.601007] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2914machine # [ 165.603779] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672915machine # [ 165.613110] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2916machine # [ 165.614687] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2917machine # [ 165.615914] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2918machine # [ 165.617896] systemd[1]: Reached target Remote File Systems.2919machine # [ 165.619371] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2920machine # [ 165.621662] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2921machine # [ 165.914733] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2922machine # [ 165.918223] systemd[1]: Finished Create SUID/SGID Wrappers.2923machine # [ 165.921082] systemd[1]: Starting linger-users.service...2924machine # [ 165.974325] systemd[1]: linger-users.service: Deactivated successfully.2925machine # [ 165.976566] systemd[1]: Finished linger-users.service.2926machine # [ 166.234633] nixos[7042]: finished switching to system configuration /nix/store/4cqqxp58hhnhckxc6mpa1h1d4sqi7cg4-nixos-system-machine-test2927machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.33 seconds)2928machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&12929machine # [ 166.988320] nixos[7208]: switching to system configuration /nix/store/f72890181b2wbz5714rxwhfxsyiycr9y-nixos-system-machine-test2930machine # [ 166.991559] systemd[1]: Stopped target Local File Systems.2931machine # [ 166.992774] systemd[1]: Stopped target Remote File Systems.2932machine # [ 167.526798] systemd[1]: Reload requested from client PID 7208 ('.switch-to-conf') (unit backdoor.service)...2933machine # [ 167.528823] systemd[1]: Reloading...2934machine # [ 168.178798] systemd[1]: Reloading finished in 647 ms.2935machine # [ 168.318545] systemd[585]: Reexecution requested from client PID 7278 ('switch-to-confi')...2936machine # [ 168.322014] systemd[585]: Reexecuting.2937machine # [ 168.377489] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2938machine # [ 168.559701] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2939machine # [ 168.566536] systemd[585]: Reload requested from client PID 7278 ('switch-to-confi')...2940machine # [ 168.568817] systemd[585]: Reloading...2941machine # [ 168.747886] systemd[585]: Reloading finished in 178 ms.2942machine # [ 168.760129] systemd[585]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2943machine # [ 168.768955] systemd[585]: Stopped Run user-specific NixOS activation.2944machine # [ 168.771065] systemd[585]: Stopping Run user-specific NixOS activation...2945machine # [ 168.773611] systemd[585]: Starting Run user-specific NixOS activation...2946machine # [ 168.809783] systemd[585]: Finished Run user-specific NixOS activation.2947machine # [ 168.813314] systemd[1]: Stopped target Reactivate sysinit units.2948machine # [ 168.817652] systemd[1]: Stopping Reactivate sysinit units...2949machine # [ 168.818519] systemd[1]: Reached target Reactivate sysinit units.2950machine # [ 168.821167] systemd[1]: Reloading reload-triggers.service...2951machine # [ 168.825695] systemd[1]: Reloading simple-reload-service.service...2952machine # [ 168.833691] systemd[1]: Reloading templated-reload-triggers@instance.service...2953machine # [ 168.847202] systemd[1]: Reloading templated-simple-reload-service@instance.service...2954machine # [ 168.889211] systemd[1]: Reloaded reload-triggers.service.2955machine # [ 168.892743] systemd[1]: Reloaded simple-reload-service.service.2956machine # [ 168.893574] systemd[1]: Reloaded templated-reload-triggers@instance.service.2957machine # [ 168.898411] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2958machine # [ 168.901049] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2959machine # [ 168.904360] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2960machine # [ 168.905648] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2961machine # [ 168.907841] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2962machine # [ 168.911543] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully.2963machine # [ 168.913315] systemd[1]: Stopped reload-triggers-and-restart.service.2964machine # [ 168.917247] systemd[1]: Stopping reload-triggers-and-restart.service...2965machine # [ 168.918163] systemd[1]: Starting reload-triggers-and-restart.service...2966machine # [ 168.922744] systemd[1]: simple-restart-service.service: Deactivated successfully.2967machine # [ 168.924836] systemd[1]: Stopped simple-restart-service.service.2968machine # [ 168.932825] systemd[1]: Stopping simple-restart-service.service...2969machine # [ 168.934515] systemd[1]: Starting simple-restart-service.service...2970machine # [ 168.943808] systemd[1]: simple-service.service: Deactivated successfully.2971machine # [ 168.958983] systemd[1]: Stopped simple-service.service.2972machine # [ 168.959822] systemd[1]: Stopping simple-service.service...2973machine # [ 168.962402] systemd[1]: Starting simple-service.service...2974machine # [ 168.975782] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2975machine # [ 168.992198] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2976machine # [ 169.002399] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2977machine # [ 169.011292] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2978machine # [ 169.026648] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully.2979machine # [ 169.039574] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service.2980machine # [ 169.045842] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service...2981machine # [ 169.056416] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2982machine # [ 169.061804] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2983machine # [ 169.069062] systemd[1]: Stopped templated-simple-restart-service@instance.service.2984machine # [ 169.070110] systemd[1]: Stopping templated-simple-restart-service@instance.service...2985machine # [ 169.071144] systemd[1]: Starting templated-simple-restart-service@instance.service...2986machine # [ 169.073285] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2987machine # [ 169.075716] systemd[1]: Stopped templated-simple-service@instance.service.2988machine # [ 169.077142] systemd[1]: Stopping templated-simple-service@instance.service...2989machine # [ 169.078209] systemd[1]: Starting templated-simple-service@instance.service...2990machine # [ 169.079321] systemd[1]: Finished reload-triggers-and-restart.service.2991machine # [ 169.080819] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2992machine # [ 169.081867] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2993machine # [ 169.083203] systemd[1]: Finished simple-service.service.2994machine # [ 169.084096] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2995machine # [ 169.085251] systemd[1]: Finished simple-restart-service.service.2996machine # [ 169.086442] systemd[1]: Finished templated-simple-restart-service@instance.service.2997machine # [ 169.093084] systemd[1]: Finished templated-simple-service@instance.service.2998machine # [ 169.095357] systemd[1]: Reached target Remote File Systems.2999machine # [ 169.099705] systemd[1]: Starting linger-users.service...3000machine # [ 169.102797] systemd[1]: Reached target Local File Systems.3001machine # [ 169.109126] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os3002machine # [ 169.110736] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki3003machine # [ 169.117898] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore3004machine # [ 169.124688] systemd[1]: Starting Create SUID/SGID Wrappers...3005machine # [ 169.126380] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.3006machine # [ 169.128142] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc673007machine # [ 169.130792] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore3008machine # [ 169.133011] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3009machine # [ 169.135316] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3010machine # [ 169.187823] systemd[1]: linger-users.service: Deactivated successfully.3011machine # [ 169.190112] systemd[1]: Finished linger-users.service.3012machine # [ 169.451014] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.3013machine # [ 169.454173] systemd[1]: Finished Create SUID/SGID Wrappers.3014machine # [ 169.710901] nixos[7208]: finished switching to system configuration /nix/store/f72890181b2wbz5714rxwhfxsyiycr9y-nixos-system-machine-test3015machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 3.48 seconds)3016machine: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&13017machine: (finished: must succeed: /nix/store/x9q2y8ymwisgq2js3a8w98a5h79dfqi2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.84 seconds)3018(finished: subtest: restart and reload by activation script, in 13.87 seconds)3019(finished: run the VM test script, in 171.40 seconds)3020test script finished in 171.45s3021cleanup3022kill QemuMachine (pid 45)3023machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)3024(finished: cleanup, in 0.19 seconds)3025additionally exposed symbols:3026 machine, other,3027 vlan1,3028 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