vm-test-run-switch-test-services
checks.aarch64-linux.switchTest
· build #19
· 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.BY55tZq4qV', 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: 6448a60d-6085-4438-b36e-3dd60c9ed69f17machine # 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.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Aug 28 06:22:54 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/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/init regInfo=/nix/store/86cg28g8lmd42wnkqq75wqak6wp6i6dd-closure-info/registration console=ttyAMA0,115200n8 console=tty061machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/86cg28g8lmd42wnkqq75wqak6wp6i6dd-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.000033] arm-pv: using stolen time PV105machine # [ 0.000482] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)106machine # [ 0.000639] Console: colour dummy device 80x25107machine # [ 0.000648] printk: legacy console [tty0] enabled108machine # [ 0.000853] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)109machine # [ 0.000860] pid_max: default: 32768 minimum: 301110machine # [ 0.000942] LSM: initializing lsm=capability,landlock,yama,bpf,ima111machine # [ 0.001127] landlock: Up and running.112machine # [ 0.001130] Yama: becoming mindful.113machine # [ 0.001634] LSM support for eBPF active114machine # [ 0.001765] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)115machine # [ 0.001788] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)116machine # [ 0.003250] cacheinfo: Unable to detect cache hierarchy for CPU 0117machine # [ 0.003957] rcu: Hierarchical SRCU implementation.118machine # [ 0.003962] rcu: Max phase no-delay instances is 1000.119machine # [ 0.005186] fsl-mc MSI: its@8080000 domain created120machine # [ 0.005279] EFI services will not be available.121machine # [ 0.005362] smp: Bringing up secondary CPUs ...122machine # [ 0.005370] smp: Brought up 1 node, 1 CPU123machine # [ 0.005373] SMP: Total of 1 processors activated.124machine # [ 0.005375] CPU: All CPU(s) started at EL1125machine # [ 0.005389] CPU features: detected: Branch Target Identification126machine # [ 0.005394] CPU features: detected: ARMv8.4 Translation Table Level127machine # [ 0.005397] CPU features: detected: Instruction cache invalidation not required for I/D coherence128machine # [ 0.005401] CPU features: detected: Data cache clean to the PoU not required for I/D coherence129machine # [ 0.005404] CPU features: detected: Common not Private translations130machine # [ 0.005408] CPU features: detected: CRC32 instructions131machine # [ 0.005411] CPU features: detected: Data cache clean to Point of Deep Persistence132machine # [ 0.005414] CPU features: detected: Data cache clean to Point of Persistence133machine # [ 0.005417] CPU features: detected: Data independent timing control (DIT)134machine # [ 0.005420] CPU features: detected: E0PD135machine # [ 0.005423] CPU features: detected: Enhanced Counter Virtualization136machine # [ 0.005426] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)137machine # [ 0.005429] CPU features: detected: Enhanced Virtualization Traps138machine # [ 0.005432] CPU features: detected: Fine Grained Traps139machine # [ 0.005436] CPU features: detected: Generic authentication (architected QARMA5 algorithm)140machine # [ 0.005440] CPU features: detected: RCpc load-acquire (LDAPR)141machine # [ 0.005443] CPU features: detected: LSE atomic instructions142machine # [ 0.005446] CPU features: detected: Privileged Access Never143machine # [ 0.005449] CPU features: detected: PMUv3144machine # [ 0.005452] CPU features: detected: RAS Extension Support145machine # [ 0.005454] CPU features: detected: RASv1p1 Extension Support146machine # [ 0.005457] CPU features: detected: Random Number Generator147machine # [ 0.005460] CPU features: detected: Speculation barrier (SB)148machine # [ 0.005462] CPU features: detected: Stage-2 Force Write-Back149machine # [ 0.005465] CPU features: detected: TLB range maintenance instructions150machine # [ 0.005470] CPU features: detected: Speculative Store Bypassing Safe (SSBS)151machine # [ 0.005508] alternatives: applying system-wide alternatives152machine # [ 0.008548] CPU features: detected: BBM Level 2 without TLB conflict abort153machine # [ 0.008719] Memory: 894692K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 112596K reserved, 32768K cma-reserved)154machine # [ 0.009121] devtmpfs: initialized155machine # [ 0.010985] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)156machine # [ 0.011008] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).157machine # [ 0.011195] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL158machine # [ 0.011199] 0 pages in range for non-PLT usage159machine # [ 0.011200] 508288 pages in range for PLT usage160machine # [ 0.011332] pinctrl core: initialized pinctrl subsystem161machine # [ 0.012158] DMI not present or invalid.162machine # [ 0.015305] NET: Registered PF_NETLINK/PF_ROUTE protocol family163machine # [ 0.017587] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations164machine # [ 0.017744] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations165machine # [ 0.017910] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations166machine # [ 0.017933] audit: initializing netlink subsys (disabled)167machine # [ 0.018589] thermal_sys: Registered thermal governor 'fair_share'168machine # [ 0.018591] thermal_sys: Registered thermal governor 'bang_bang'169machine # [ 0.018594] thermal_sys: Registered thermal governor 'step_wise'170machine # [ 0.018597] thermal_sys: Registered thermal governor 'user_space'171machine # [ 0.018603] thermal_sys: Registered thermal governor 'power_allocator'172machine # [ 0.018651] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1173machine # [ 0.018660] cpuidle: using governor ladder174machine # [ 0.018665] cpuidle: using governor menu175machine # [ 0.018896] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.176machine # [ 0.018912] ASID allocator initialised with 65536 entries177machine # [ 0.020079] Serial: AMBA PL011 UART driver178machine # [ 0.025439] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1179machine # [ 0.025601] printk: console [ttyAMA0] enabled180machine # [ 0.150231] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages181machine # [ 0.150254] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page182machine # [ 0.150260] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages183machine # [ 0.150265] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page184machine # [ 0.150269] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages185machine # [ 0.150274] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page186machine # [ 0.150280] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages187machine # [ 0.150284] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page188machine # [ 0.157877] fbcon: Taking over console189machine # [ 0.157895] ACPI: Interpreter disabled.190machine # [ 0.159772] iommu: Default domain type: Translated191machine # [ 0.159783] iommu: DMA domain TLB invalidation policy: strict mode192machine # [ 0.165968] SCSI subsystem initialized193machine # [ 0.166670] usbcore: registered new interface driver usbfs194machine # [ 0.166701] usbcore: registered new interface driver hub195machine # [ 0.166717] usbcore: registered new device driver usb196machine # [ 0.167041] pps_core: LinuxPPS API ver. 1 registered197machine # [ 0.167048] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>198machine # [ 0.167058] PTP clock support registered199machine # [ 0.167116] EDAC MC: Ver: 3.0.0200machine # [ 0.171768] scmi_core: SCMI protocol bus registered201machine # [ 0.172758] FPGA manager framework202machine # [ 0.173700] vgaarb: loaded203machine # [ 0.174364] clocksource: Switched to clocksource arch_sys_counter204machine # [ 0.180845] VFS: Disk quotas dquot_6.6.0205machine # [ 0.180906] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)206machine # [ 0.182617] netfs: FS-Cache loaded207machine # [ 0.182793] pnp: PnP ACPI: disabled208machine # [ 0.186880] NET: Registered PF_INET protocol family209machine # [ 0.187058] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)210machine # [ 0.218332] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)211machine # [ 0.219668] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)212machine # [ 0.219707] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)213machine # [ 0.219762] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)214machine # [ 0.219837] TCP: Hash tables configured (established 8192 bind 8192)215machine # [ 0.219974] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)216machine # [ 0.220037] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)217machine # [ 0.220098] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)218machine # [ 0.220218] NET: Registered PF_UNIX/PF_LOCAL protocol family219machine # [ 0.220273] NET: Registered PF_XDP protocol family220machine # [ 0.220296] PCI: CLS 0 bytes, default 64221machine # [ 0.220554] Trying to unpack rootfs image as initramfs...222machine # [ 0.242434] kvm [1]: HYP mode not available223machine # [ 0.358518] Initialise system trusted keyrings224machine # [ 0.359311] workingset: timestamp_bits=42 max_order=18 bucket_order=0225machine # [ 0.360586] squashfs: version 4.0 (2009/01/31) Phillip Lougher226machine # [ 0.366420] 9p: Installing v9fs 9p2000 file system support227machine # [ 0.386544] Key type asymmetric registered228machine # [ 0.386570] Asymmetric key parser 'x509' registered229machine # [ 0.386647] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)230machine # [ 0.394440] io scheduler mq-deadline registered231machine # [ 0.394464] io scheduler kyber registered232machine # [ 0.399695] pl061_gpio 9030000.pl061: PL061 GPIO chip registered233machine # [ 0.400980] ledtrig-cpu: registered to indicate activity on CPUs234machine # [ 0.401354] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:235machine # [ 0.401370] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000236machine # [ 0.401384] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000237machine # [ 0.401394] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000238machine # [ 0.401416] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits239machine # [ 0.401439] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]240machine # [ 0.401512] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00241machine # [ 0.401522] pci_bus 0000:00: root bus resource [bus 00-ff]242machine # [ 0.401528] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]243machine # [ 0.401534] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]244machine # [ 0.401540] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]245machine # [ 0.401598] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint246machine # [ 0.402032] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint247machine # [ 0.402217] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]248machine # [ 0.402234] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]249machine # [ 0.402264] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]250machine # [ 0.402280] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]251machine # [ 0.422890] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint252machine # [ 0.423101] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]253machine # [ 0.423120] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]254machine # [ 0.423151] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]255machine # [ 0.423622] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint256machine # [ 0.423809] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]257machine # [ 0.423826] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]258machine # [ 0.423855] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]259machine # [ 0.424307] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint260machine # [ 0.424488] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]261machine # [ 0.424508] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]262machine # [ 0.424537] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]263machine # [ 0.424998] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint264machine # [ 0.425179] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]265machine # [ 0.425196] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]266machine # [ 0.425226] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]267machine # [ 0.425692] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint268machine # [ 0.425875] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]269machine # [ 0.425892] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]270machine # [ 0.425922] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]271machine # [ 0.446450] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint272machine # [ 0.446662] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]273machine # [ 0.446681] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]274machine # [ 0.446711] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]275machine # [ 0.446728] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]276machine # [ 0.447313] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint277machine # [ 0.447508] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]278machine # [ 0.447539] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]279machine # [ 0.447995] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint280machine # [ 0.448185] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]281machine # [ 0.448216] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]282machine # [ 0.448608] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint283machine # [ 0.448789] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]284machine # [ 0.449050] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint285machine # [ 0.449349] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]286machine # [ 0.449368] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]287machine # [ 0.449398] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]288machine # [ 0.449868] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint289machine # [ 0.450055] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]290machine # [ 0.450071] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]291machine # [ 0.450102] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]292machine # [ 0.467712] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned293machine # [ 0.467732] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned294machine # [ 0.467739] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned295machine # [ 0.467785] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned296machine # [ 0.467834] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned297machine # [ 0.467882] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned298machine # [ 0.467930] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned299machine # [ 0.467979] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned300machine # [ 0.468028] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned301machine # [ 0.468078] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned302machine # [ 0.468126] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned303machine # [ 0.468172] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned304machine # [ 0.468297] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned305machine # [ 0.468346] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned306machine # [ 0.468368] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned307machine # [ 0.468389] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned308machine # [ 0.468411] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned309machine # [ 0.468434] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned310machine # [ 0.468460] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned311machine # [ 0.468482] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned312machine # [ 0.468505] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned313machine # [ 0.468528] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned314machine # [ 0.468551] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned315machine # [ 0.468574] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned316machine # [ 0.468597] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned317machine # [ 0.468621] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned318machine # [ 0.468642] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned319machine # [ 0.468664] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned320machine # [ 0.468686] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned321machine # [ 0.468708] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned322machine # [ 0.468730] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned323machine # [ 0.468752] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned324machine # [ 0.468776] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned325machine # [ 0.468798] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned326machine # [ 0.468827] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]327machine # [ 0.468837] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]328machine # [ 0.468842] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]329machine # [ 0.470015] pci 0000:00:0a.0: enabling device (0000 -> 0002)330machine # [ 0.506520] pci 0000:00:0a.0: quirk_usb_early_handoff+0x0/0xa60 took 35652 usecs331machine # [ 0.527192] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)332machine # [ 0.529379] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)333machine # [ 0.540045] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)334machine # [ 0.542073] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)335machine # [ 0.553383] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)336machine # [ 0.559796] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)337machine # [ 0.562003] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)338machine # [ 0.576073] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)339machine # [ 0.578224] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)340machine # [ 0.581999] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)341machine # [ 0.590103] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)342machine # [ 0.606649] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled343machine # [ 0.609343] msm_serial: driver initialized344machine # [ 0.609492] SuperH (H)SCI(F) driver initialized345machine # [ 0.609545] STM32 USART driver initialized346machine # [ 0.643516] loop: module loaded347machine # [ 0.643701] virtio_blk virtio5: 1/0/0 default/read/poll queues348machine # [ 0.644521] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)349machine # [ 0.655198] megasas: 07.734.00.00-rc1350machine # [ 0.655924] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]351machine # [ 0.660058] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000352machine # [ 0.660135] Intel/Sharp Extended Query Table at 0x0031353machine # [ 0.661840] Using buffer write method354machine # [ 0.661918] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]355machine # [ 0.675696] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000356machine # [ 0.675757] Intel/Sharp Extended Query Table at 0x0031357machine # [ 0.677427] Using buffer write method358machine # [ 0.677469] Concatenating MTD devices:359machine # [ 0.677474] (0): "0.flash"360machine # [ 0.677478] (1): "0.flash"361machine # [ 0.677482] into device "0.flash"362machine # [ 0.976472] Freeing initrd memory: 25736K363machine # [ 0.983044] tun: Universal TUN/TAP device driver, 1.6364machine # [ 0.987095] thunder_xcv, ver 1.0365machine # [ 0.987145] thunder_bgx, ver 1.0366machine # [ 0.987169] nicpf, ver 1.0367machine # [ 0.987730] e1000: Intel(R) PRO/1000 Network Driver368machine # [ 0.987738] e1000: Copyright (c) 1999-2006 Intel Corporation.369machine # [ 0.987769] e1000e: Intel(R) PRO/1000 Network Driver370machine # [ 0.987780] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.371machine # [ 0.987804] igb: Intel(R) Gigabit Ethernet Network Driver372machine # [ 0.987810] igb: Copyright (c) 2007-2014 Intel Corporation.373machine # [ 0.987832] igbvf: Intel(R) Gigabit Virtual Function Network Driver374machine # [ 0.987839] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.375machine # [ 0.987970] sky2: driver version 1.30376machine # [ 0.989547] usbcore: registered new interface driver usb-storage377machine # [ 0.989599] usbcore: registered new interface driver usbserial_generic378machine # [ 0.989613] usbserial: USB Serial support registered for generic379machine # [ 0.990202] hv_vmbus: registering driver hyperv_keyboard380machine # [ 0.991175] ehci-pci 0000:00:0a.0: EHCI Host Controller381machine # [ 0.991209] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1382machine # [ 0.991385] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000383machine # [ 1.002492] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00384machine # [ 1.002977] hub 1-0:1.0: USB hub found385machine # [ 1.002993] hub 1-0:1.0: 6 ports detected386machine # [ 1.006494] rtc-pl031 9010000.pl031: registered as rtc0387machine # [ 1.006526] rtc-pl031 9010000.pl031: setting system clock to 2026-09-03T02:36:20 UTC (1788402980)388machine # [ 1.006855] i2c_dev: i2c /dev entries driver389machine # [ 1.011731] sdhci: Secure Digital Host Controller Interface driver390machine # [ 1.011743] sdhci: Copyright(c) Pierre Ossman391machine # [ 1.012019] Synopsys Designware Multimedia Card Interface Driver392machine # [ 1.012383] sdhci-pltfm: SDHCI platform and OF driver helper393machine # [ 1.014094] hid: raw HID events driver (C) Jiri Kosina394machine # [ 1.014345] usbcore: registered new interface driver usbhid395machine # [ 1.014353] usbhid: USB HID core driver396machine # [ 1.019821] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available397machine # [ 1.021350] drop_monitor: Initializing network drop monitor service398machine # [ 1.021539] NET: Registered PF_INET6 protocol family399machine # [ 1.024635] Segment Routing with IPv6400machine # [ 1.024653] In-situ OAM (IOAM) with IPv6401machine # [ 1.024683] NET: Registered PF_PACKET protocol family402machine # [ 1.026291] 9pnet: Installing 9P2000 support403machine # [ 1.029333] Key type dns_resolver registered404machine # [ 1.035969] registered taskstats version 1405machine # [ 1.036129] Loading compiled-in X.509 certificates406machine # [ 1.044877] Demotion targets for Node 0: null407machine # [ 1.044998] Key type .fscrypt registered408machine # [ 1.045007] Key type fscrypt-provisioning registered409machine # [ 1.045112] ima: No TPM chip found, activating TPM-bypass!410machine # [ 1.045133] ima: Allocated hash algorithm: sha1411machine # [ 1.045156] ima: No architecture policies found412machine # [ 1.049422] input: gpio-keys as /devices/platform/gpio-keys/input/input0413machine # [ 1.068469] clk: Disabling unused clocks414machine # [ 1.068513] PM: genpd: Disabling unused power domains415machine # [ 1.072883] Freeing unused kernel memory: 4736K416machine # [ 1.073106] Run /init as init process417machine # [ 1.088739] systemd[1]: Successfully made /usr/ read-only.418machine # [ 1.254517] usb 1-1: new high-speed USB device number 2 using ehci-pci419machine # [ 1.407089] 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/input1420machine # [ 1.423771] systemd[1]: systemd 262-2451b1a 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)421machine # [ 1.435959] systemd[1]: Detected virtualization qemu.422machine # [ 1.437999] systemd[1]: Detected architecture arm64.423machine # [ 1.440144] systemd[1]: Running in initrd.424machine # [ 1.443112] systemd[1]: Initializing machine ID from random generator.425machine # [ 1.446444] systemd[1]: Hostname set to <machine>.426machine # [ 1.498667] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0427machine # [ 1.594332] systemd[1]: bpf-restrict-fs: LSM BPF program attached428machine # [ 1.622480] usb 1-2: new high-speed USB device number 3 using ehci-pci429machine # [ 1.652882] systemd[1]: Queued start job for default target Initrd Default Target.430machine # [ 1.660827] systemd[1]: Created slice Slice /system/modprobe.431machine # [ 1.662013] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.432machine # [ 1.663264] systemd[1]: Expecting device /dev/disk/by-label/nixos...433machine # [ 1.664119] systemd[1]: Reached target Path Units.434machine # [ 1.664761] systemd[1]: Reached target Slice Units.435machine # [ 1.665818] systemd[1]: Reached target Swaps.436machine # [ 1.666488] systemd[1]: Reached target Timer Units.437machine # [ 1.667296] systemd[1]: Listening on D-Bus System Message Bus Socket.438machine # [ 1.668351] systemd[1]: Listening on Journal Socket (/dev/log).439machine # [ 1.669261] systemd[1]: Listening on Journal Sockets.440machine # [ 1.670019] systemd[1]: Listening on udev Kernel Socket.441machine # [ 1.670787] systemd[1]: Reached target Socket Units.442machine # [ 1.673494] systemd[1]: Starting Create List of Static Device Nodes...443machine # [ 1.682605] systemd[1]: Starting Load Kernel Module 9pnet_virtio...444machine # [ 1.682711] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs445machine # [ 1.690777] systemd[1]: Mounting Kernel Configuration File System...446machine # [ 1.722666] systemd[1]: Starting Journal Service...447machine # [ 1.730557] systemd[1]: Starting Load Kernel Modules...448machine # [ 1.731448] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os449machine # [ 1.738708] systemd[1]: Starting Coldplug All udev Devices...450machine # [ 1.759315] systemd[1]: Finished Create List of Static Device Nodes.451machine # [ 1.760444] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.452machine # [ 1.760752] systemd[1]: Finished Load Kernel Module 9pnet_virtio.453machine # [ 1.761022] systemd[1]: Mounted Kernel Configuration File System.454machine # [ 1.775027] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...455machine # [ 1.796463] 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/input2456machine # [ 1.798249] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0457machine # [ 1.809093] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.458machine # [ 1.816580] systemd-journald[73]: Collecting audit messages is disabled.459machine # [ 1.834457] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev460machine # [ 1.842403] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0461machine # [ 1.842650] [drm] features: -virgl +edid -resource_blob -host_visible462machine # [ 1.842661] [drm] features: -context_init463machine # [ 1.843448] [drm] number of scanouts: 1464machine # [ 1.843466] [drm] number of cap sets: 0465machine # [ 1.850564] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.466machine # [ 1.854843] systemd[1]: Starting Create Static Device Nodes in /dev...467machine # [ 1.866757] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic468machine # [ 1.866780] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0469machine # [ 1.898841] Console: switching to colour frame buffer device 160x50470machine # [ 1.905878] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device471machine # [ 1.932563] systemd[1]: Finished Load Kernel Modules.472machine # [ 1.936543] systemd[1]: Starting Apply Kernel Variables...473machine # [ 1.954850] systemd[1]: Finished Create Static Device Nodes in /dev.474machine # [ 1.955447] systemd[1]: Reached target Preparation for Local File Systems.475machine # [ 1.955498] systemd[1]: Reached target Local File Systems.476machine # [ 1.971031] systemd[1]: Starting Rule-based Manager for Device Events and Files...477machine # [ 2.010876] systemd[1]: Finished Apply Kernel Variables.478machine # [ 2.000635] systemd-modules-load[74]: Inserted module 'dm_mod'479machine # [ 2.016431] systemd[1]: Started Journal Service.480machine # [ 2.006380] systemd-modules-load[74]: Module 'virtio_balloon' is built in481machine # [ 2.007678] systemd-modules-load[74]: Module 'virtio_console' is built in482machine # [ 2.017910] systemd-modules-load[74]: Inserted module 'virtio_gpu'483machine # [ 2.019047] systemd-modules-load[74]: Module 'virtio_rng' is built in484machine # [ 2.028469] systemd[1]: Starting Create System Files and Directories...485machine # [ 2.086599] systemd-udevd[81]: Using default interface naming scheme 'v261'.486machine # [ 2.104810] systemd[1]: Finished Create System Files and Directories.487machine # [ 2.129849] systemd[1]: Started Rule-based Manager for Device Events and Files.488machine # [ 2.214725] systemd[1]: Starting Virtual Console Setup...489machine # [ 2.293876] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.490machine # [ 2.297826] systemd[1]: Finished Virtual Console Setup.491machine # [ 2.917775] systemd[1]: Finished Coldplug All udev Devices.492machine # [ 2.918797] systemd[1]: Reached target System Initialization.493machine # [ 2.919637] systemd[1]: Reached target Basic System.494machine # [ 3.078774] (udev-worker)[101]: Network interface NamePolicy= disabled on kernel command line.495machine # [ 3.104744] (udev-worker)[93]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.496machine # [ 3.109774] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.497machine # [ 3.168308] systemd[1]: Found device /dev/disk/by-label/nixos.498machine # [ 3.171654] systemd[1]: Reached target Initrd Root Device.499machine # [ 3.174192] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...500machine # [ 3.230416] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks501machine # [ 3.239003] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.502machine # [ 3.253199] systemd[1]: Mounting /sysroot...503machine # [ 3.304162] EXT4-fs (vda): mounted filesystem 6448a60d-6085-4438-b36e-3dd60c9ed69f r/w with ordered data mode. Quota mode: none.504machine # [ 3.298318] systemd[1]: Mounted /sysroot.505machine # [ 3.300952] systemd[1]: Reached target Initrd Root File System.506machine # [ 3.305485] systemd[1]: Starting Mountpoints Configured in the Real Root...507machine # [ 3.340338] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload.508machine # [ 3.348168] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)...509machine # [ 3.355950] systemd[1]: Reloading...510machine # [ 3.588521] systemd[1]: Reloading finished in 240 ms.511machine # [ 3.625302] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace...512machine # [ 3.632341] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace...513machine # [ 3.636260] systemd[1]: Starting Load Kernel Module 9pnet_virtio...514machine # [ 3.643074] systemd[1]: initrd-parse-etc.service: Deactivated successfully.515machine # [ 3.651812] systemd[1]: Finished Mountpoints Configured in the Real Root.516machine # [ 3.653220] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.517machine # [ 3.681336] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.518machine # [ 3.683114] systemd[1]: Finished Load Kernel Module 9pnet_virtio.519machine # [ 3.744135] systemd[1]: Mounting /sysroot/nix/.ro-store...520machine # [ 3.755194] systemd[1]: Mounting /sysroot/nix/.rw-store...521machine # [ 3.775214] systemd[1]: Mounting /sysroot/run...522machine # [ 3.794716] systemd[1]: Mounting /sysroot/tmp/shared...523machine # [ 3.817010] systemd[1]: Mounting /sysroot/tmp/xchg...524machine # [ 3.862826] systemd[1]: Mounted /sysroot/nix/.rw-store.525machine # [ 3.882682] systemd[1]: Mounted /sysroot/nix/.ro-store.526machine # [ 3.891494] systemd[1]: Mounted /sysroot/run.527machine # [ 3.914140] systemd[1]: Starting rw-sysroot-nix-store.service...528machine # [ 3.919729] systemd[1]: Mounted /sysroot/tmp/shared.529machine # [ 3.928173] systemd[1]: Mounted /sysroot/tmp/xchg.530machine # [ 3.958248] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.531machine # [ 3.959855] systemd[1]: Finished rw-sysroot-nix-store.service.532machine # [ 4.711628] (udev-worker)[97]: mtd0ro: Failed to find and pin callout binary "/nix/store/krwx79xsq3b46gvcq3lzvpwa02cqpcr6-systemd-262-2451b1a/lib/udev/mtd_probe": No such file or directory533machine # [ 4.714497] (udev-worker)[97]: mtd0ro: /nix/store/krwx79xsq3b46gvcq3lzvpwa02cqpcr6-systemd-262-2451b1a/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 directory534machine # [ 4.749824] systemd[1]: Mounting /sysroot/nix/store...535machine # [ 4.766425] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.536machine # [ 4.772261] systemd[1]: Stopped Virtual Console Setup.537machine # [ 4.773212] systemd[1]: Stopping Virtual Console Setup...538machine # [ 4.775478] systemd[1]: Starting Virtual Console Setup...539machine # [ 4.806806] systemd[1]: Mounted /sysroot/nix/store.540machine # [ 4.811451] systemd[1]: Reached target Initrd File Systems.541machine # [ 4.817578] systemd[1]: Starting Find NixOS closure...542machine # [ 4.835784] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...543machine # [ 4.838687] systemd-vconsole-setup[155]: Configuration of first virtual console was skipped, ignoring remaining ones.544machine # [ 4.855186] systemd[1]: Finished Virtual Console Setup.545machine # [ 4.856194] systemd[1]: sysroot-run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully.546machine # [ 4.871594] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.547machine # [ 4.885116] systemd[1]: Finished Find NixOS closure.548machine # [ 4.888372] systemd[1]: Reached target Initrd Default Target.549machine # [ 4.889308] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...550machine # [ 4.915827] systemd[1]: Stopped target Initrd Default Target.551machine # [ 4.917579] systemd[1]: Stopped target Basic System.552machine # [ 4.918598] systemd[1]: Stopped target Initrd Root Device.553machine # [ 4.920705] systemd[1]: Stopped target Path Units.554machine # [ 4.924481] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.555machine # [ 4.925638] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.556machine # [ 4.927411] systemd[1]: Stopped target Slice Units.557machine # [ 4.930233] systemd[1]: Stopped target Socket Units.558machine # [ 4.931047] systemd[1]: Stopped target System Initialization.559machine # [ 4.936225] systemd[1]: Stopped target Swaps.560machine # [ 4.937066] systemd[1]: Stopped target Timer Units.561machine # [ 4.937801] systemd[1]: dbus.socket: Deactivated successfully.562machine # [ 4.938626] systemd[1]: Closed D-Bus System Message Bus Socket.563machine # [ 4.939467] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.564machine # [ 4.945941] systemd[1]: Stopped Find NixOS closure.565machine # [ 4.946705] systemd[1]: Starting Load Kernel Module 9pnet_virtio...566machine # [ 4.948782] systemd[1]: Starting rw-sysroot-nix-store.service...567machine # [ 4.950564] systemd[1]: systemd-sysctl.service: Deactivated successfully.568machine # [ 4.952966] systemd[1]: Stopped Apply Kernel Variables.569machine # [ 4.955132] systemd[1]: systemd-modules-load.service: Deactivated successfully.570machine # [ 4.957042] systemd[1]: Stopped Load Kernel Modules.571machine # [ 4.972303] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.572machine # [ 4.975761] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.573machine # [ 4.984380] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.574machine # [ 4.994022] systemd[1]: Stopped Create System Files and Directories.575machine # [ 4.996588] systemd[1]: Stopped target Local File Systems.576machine # [ 5.000183] systemd[1]: Stopped target Preparation for Local File Systems.577machine # [ 5.002689] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.578machine # [ 5.005041] systemd[1]: Stopped Coldplug All udev Devices.579machine # [ 5.006997] systemd[1]: Stopping Rule-based Manager for Device Events and Files...580machine # [ 5.009291] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.581machine # [ 5.011545] systemd[1]: Stopped Virtual Console Setup.582machine # [ 5.015540] systemd[1]: initrd-cleanup.service: Deactivated successfully.583machine # [ 5.016855] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.584machine # [ 5.018151] systemd[1]: systemd-udevd.service: Deactivated successfully.585machine # [ 5.020224] systemd[1]: Stopped Rule-based Manager for Device Events and Files.586machine # [ 5.024217] systemd[1]: systemd-udevd.service: Consumed 1.680s CPU time over 3.048s wall clock time, 22.1M memory peak.587machine # [ 5.025813] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.588machine # [ 5.028183] systemd[1]: Finished Load Kernel Module 9pnet_virtio.589machine # [ 5.030017] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.590machine # [ 5.031166] systemd[1]: Finished rw-sysroot-nix-store.service.591machine # [ 5.032002] systemd[1]: Starting Cleanup udev Database...592machine # [ 5.033106] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.593machine # [ 5.034162] systemd[1]: Stopped Create Static Device Nodes in /dev.594machine # [ 5.035065] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.595machine # [ 5.040325] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.596machine # [ 5.042734] systemd[1]: kmod-static-nodes.service: Deactivated successfully.597machine # [ 5.048289] systemd[1]: Stopped Create List of Static Device Nodes.598machine # [ 5.083604] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.599machine # [ 5.087686] systemd[1]: Finished Cleanup udev Database.600machine # [ 5.088859] systemd[1]: Reached target Switch Root.601machine # [ 5.092323] systemd[1]: Starting NixOS Activation...602machine # [ 5.290785] initrd-nixos-activation-start[179]: booting system configuration /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test603machine # [ 5.371887] initrd-nixos-activation-start[179]: running activation script...604machine # [ 5.749144] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.605machine # [ 5.849199] initrd-nixos-activation-start[202]: setting up /etc...606machine # [ 6.156942] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.607machine # [ 6.160141] systemd[1]: Finished NixOS Activation.608machine # [ 6.161419] systemd[1]: Starting Switch Root...609machine # [ 6.186661] systemd[1]: Switching root.610machine # [ 6.376534] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).611machine # [ 7.023748] systemd[1]: systemd 262-2451b1a 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)612machine # [ 7.037584] systemd[1]: Detected virtualization qemu.613machine # [ 7.037782] systemd[1]: Detected architecture arm64.614machine # [ 7.038019] systemd[1]: Detected first boot.615machine # [ 7.049981] systemd[1]: Initializing machine ID from random generator.616machine # [ 7.239339] systemd[1]: bpf-restrict-fs: LSM BPF program attached617machine # [ 7.425635] systemd[1]: Applying preset policy.618machine # [ 7.976781] systemd[1]: Populated /etc with preset unit settings.619machine # [ 8.553221] systemd[1]: initrd-switch-root.service: Deactivated successfully.620machine # [ 8.554829] systemd[1]: Stopped initrd-switch-root.service.621machine # [ 8.558088] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.622machine # [ 8.560881] systemd[1]: Created slice Slice /system/getty.623machine # [ 8.563965] systemd[1]: Created slice User and Session Slice.624machine # [ 8.565311] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.625machine # [ 8.568349] systemd[1]: Started Forward Password Requests to Wall Directory Watch.626machine # [ 8.569794] systemd[1]: Expecting device /dev/hvc0...627machine # [ 8.571354] systemd[1]: Expecting device /dev/ttyAMA0...628machine # [ 8.573663] systemd[1]: Reached target Local Encrypted Volumes.629machine # [ 8.574917] systemd[1]: Stopped target initrd-fs.target.630machine # [ 8.576422] systemd[1]: Stopped target initrd-root-fs.target.631machine # [ 8.577988] systemd[1]: Stopped target initrd-switch-root.target.632machine # [ 8.579787] systemd[1]: Reached target Virtual Machines and Containers.633machine # [ 8.582216] systemd[1]: Reached target Path Units.634machine # [ 8.583296] systemd[1]: Reached target Remote File Systems.635machine # [ 8.584846] systemd[1]: Reached target Slice Units.636machine # [ 8.587192] systemd[1]: Reached target Swaps.637machine # [ 8.591208] systemd[1]: Listening on Query the User Interactively for a Password.638machine # [ 8.596428] systemd[1]: Listening on Process Core Dump Socket.639machine # [ 8.600770] systemd[1]: Listening on Credential Encryption/Decryption.640machine # [ 8.605213] systemd[1]: Listening on Factory Reset Management.641machine # [ 8.607557] systemd[1]: Listening on Hostname Service Socket.642machine # [ 8.613563] systemd[1]: Starting Journal Log Access Socket...643machine # [ 8.616899] systemd[1]: Listening on Journal Audit Socket.644machine # [ 8.621507] systemd[1]: Listening on Console Output Muting Service Socket.645machine # [ 8.624353] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.646machine # [ 8.626984] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os647machine # [ 8.629542] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki648machine # [ 8.643604] systemd[1]: Listening on Disk Repartitioning Service Socket.649machine # [ 8.645081] systemd[1]: Listening on udev Varlink Socket.650machine # [ 8.650019] systemd[1]: Mounting Huge Pages File System...651machine # [ 8.656204] systemd[1]: Mounting POSIX Message Queue File System...652machine # [ 8.665880] systemd[1]: Mounting Kernel Debug File System...653machine # [ 8.683557] systemd[1]: Mounting Kernel Trace File System...654machine # [ 8.699251] systemd[1]: Starting Create List of Static Device Nodes...655machine # [ 8.712398] systemd[1]: Starting Load Kernel Module 9pnet_virtio...656machine # [ 8.713991] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs657machine # [ 8.729956] systemd[1]: Mounting Kernel Configuration File System...658machine # [ 8.735825] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm659machine # [ 8.745627] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore660machine # [ 8.825679] systemd[1]: Starting Load Kernel Module fuse...661machine # [ 8.835407] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67662machine # [ 8.867787] systemd[1]: Starting Journal Service...663machine # [ 8.899634] systemd[1]: Starting Load Kernel Modules...664machine # [ 8.927719] fuse: init (API version 7.45)665machine # [ 8.932737] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...666machine # [ 8.958638] systemd[1]: Starting Remount Root and Kernel File Systems...667machine # [ 8.965067] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os668machine # [ 8.997513] systemd[1]: Starting Coldplug All udev Devices...669machine # [ 9.009341] systemd[1]: Listening on Journal Log Access Socket.670machine # [ 9.023747] systemd-journald[274]: Collecting audit messages is enabled.671machine # [ 9.021834] systemd[1]: Queued start job for default target Multi-User System.672machine # [ 9.038825] systemd[1]: Mounted Huge Pages File System.673machine # [ 9.040550] systemd[1]: Started Journal Service.674machine # [ 9.031513] systemd[1]: systemd-journald.service: Deactivated successfully.675machine # [ 9.041508] systemd-modules-load[275]: Module 'atkbd' is built in676machine # [ 9.044346] systemd-modules-load[275]: Module 'loop' is built in677machine # [ 9.050566] systemd[1]: Mounted POSIX Message Queue File System.678machine # [ 9.056982] systemd[1]: Mounted Kernel Debug File System.679machine # [ 9.059798] systemd[1]: Mounted Kernel Trace File System.680machine # [ 9.068275] systemd[1]: Finished Create List of Static Device Nodes.681machine # [ 9.072797] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.682machine # [ 9.090524] EXT4-fs (vda): re-mounted 6448a60d-6085-4438-b36e-3dd60c9ed69f.683machine # [ 9.084005] systemd[1]: Finished Load Kernel Module 9pnet_virtio.684machine # [ 9.088440] systemd[1]: Mounted Kernel Configuration File System.685machine # [ 9.092370] systemd[1]: modprobe@fuse.service: Deactivated successfully.686machine # [ 9.097967] systemd[1]: Finished Load Kernel Module fuse.687machine # [ 9.100874] systemd[1]: Finished Load Kernel Modules.688machine # [ 9.104899] systemd[1]: Finished Remount Root and Kernel File Systems.689machine # [ 9.111209] systemd[1]: Listening on Disk Image Download Service Socket.690machine # [ 9.116649] systemd[1]: Mounting FUSE Control File System...691machine # [ 9.131963] systemd-oomd[276]: No swap; memory pressure usage will be degraded692machine # [ 9.141630] systemd[1]: Starting Firewall...693machine # [ 9.151164] systemd[1]: Starting Flush Journal to Persistent Storage...694machine # [ 9.152348] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore695machine # [ 9.159027] systemd[1]: Starting Load/Save OS Random Seed...696machine # [ 9.173264] systemd[1]: Starting Apply Kernel Variables...697machine # [ 9.208932] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...698machine # [ 9.211612] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os699machine # [ 9.225567] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.700machine # [ 9.333560] systemd-journald[274]: Received client request to flush runtime journal.701machine # [ 9.399536] systemd[1]: Mounted FUSE Control File System.702machine # [ 9.408916] systemd[1]: Finished Load/Save OS Random Seed.703machine # [ 9.412139] systemd[1]: Reached target First Boot Complete.704machine # [ 9.417153] systemd[1]: Finished Apply Kernel Variables.705machine # [ 9.420778] systemd[1]: Finished Flush Journal to Persistent Storage.706machine # [ 9.443894] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.707machine # [ 9.452530] systemd[1]: Starting Create Static Device Nodes in /dev...708machine # [ 9.579178] systemd[1]: Finished Create Static Device Nodes in /dev.709machine # [ 9.582379] systemd[1]: Reached target Preparation for Local File Systems.710machine # [ 9.591311] systemd[1]: Mounting /run/wrappers...711machine # [ 9.605396] systemd[1]: Starting Rule-based Manager for Device Events and Files...712machine # [ 9.687795] systemd[1]: Mounted /run/wrappers.713machine # [ 9.689430] systemd[1]: Reached target Local File Systems.714machine # [ 9.695690] systemd[1]: Listening on Boot Loader Control Service Socket.715machine # [ 9.708413] systemd[1]: Starting register-nix-paths.service...716machine # [ 9.733011] systemd[1]: Starting Create SUID/SGID Wrappers...717machine # [ 9.742932] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.718machine # [ 9.774825] systemd[1]: Starting Save Transient machine-id to Disk...719machine # [ 9.811331] systemd[1]: Starting Create System Files and Directories...720machine # [ 9.845262] systemd-udevd[319]: Using default interface naming scheme 'v261'.721machine # [ 9.933302] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.722machine # [ 9.944252] systemd[1]: Finished Save Transient machine-id to Disk.723machine # [ 10.058777] systemd[1]: Finished Create System Files and Directories.724machine # [ 10.072242] systemd[1]: Starting Rebuild Journal Catalog...725machine # [ 10.077722] systemd[1]: Starting Record System Boot/Shutdown in UTMP...726machine # [ 10.177042] systemd[1]: Started Rule-based Manager for Device Events and Files.727machine # [ 10.243002] systemd[1]: Finished Record System Boot/Shutdown in UTMP.728machine # [ 10.333318] systemd[1]: Finished Rebuild Journal Catalog.729machine # [ 10.348121] systemd[1]: Starting Update is Completed...730machine # [ 10.438012] systemd[1]: Finished Update is Completed.731machine # [ 10.725141] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.732machine # [ 10.731580] systemd[1]: Finished Create SUID/SGID Wrappers.733machine # [ 11.399633] systemd[1]: Finished Coldplug All udev Devices.734machine # [ 11.475866] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs735machine # [ 11.538857] systemd[1]: Finished register-nix-paths.service.736machine # [ 11.542066] systemd[1]: Reached target System Initialization.737machine # [ 11.548775] systemd[1]: Started Discard unused filesystem blocks once a week.738machine # [ 11.551153] systemd[1]: Started Daily Cleanup of Temporary Directories.739machine # [ 11.556573] systemd[1]: Reached target Timer Units.740machine # [ 11.558361] systemd[1]: Listening on D-Bus System Message Bus Socket.741machine # [ 11.563147] systemd[1]: Listening on Nix Daemon Socket.742machine # [ 11.565788] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.743machine # [ 11.571813] systemd[1]: Reached target Socket Units.744machine # [ 11.575918] systemd[1]: Reached target Basic System.745machine # [ 11.581332] systemd[1]: Starting Import lastlog data into lastlog2 database...746machine # [ 11.583951] systemd[1]: Starting Name Service Cache Daemon (nsncd)...747machine # [ 11.592530] systemd[1]: Starting Post-Boot Actions...748machine # [ 11.608975] systemd[1]: Started Reset console on configuration changes.749machine # [ 11.631156] systemd[1]: Starting resolvconf update...750machine # [ 11.638260] systemd[1]: Finished Firewall.751machine # [ 11.692623] systemd[1]: Starting D-Bus System Message Bus...752machine # [ 11.710344] systemd[1]: Finished Post-Boot Actions.753machine # [ 11.731867] nsncd[479]: Sep 03 02:36:31.238 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"754machine # [ 11.744678] systemd[1]: Started Name Service Cache Daemon (nsncd).755machine # [ 11.755481] systemd[1]: Reached target Host and Network Name Lookups.756machine # [ 11.761562] systemd[1]: Reached target User and Group Name Lookups.757machine # [ 11.776312] systemd[1]: Starting User Login Management...758machine # [ 11.804643] systemd[1]: Finished Import lastlog data into lastlog2 database.759machine # [ 11.903963] dbus-broker-launch[488]: Looking up NSS user entry for 'systemd-timesync'...760machine # [ 11.916971] dbus-broker-launch[488]: NSS returned no entry for 'systemd-timesync'761machine # [ 11.919976] dbus-broker-launch[488]: Invalid user-name in /nix/store/7h3c20lswgjcx4dw78jq3y43vk64wi2d-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"762machine # [ 11.955911] systemd-logind[504]: New seat seat0.763machine # [ 11.963942] systemd[1]: Started D-Bus System Message Bus.764machine # [ 11.968830] systemd[1]: Started User Login Management.765machine # [ 11.973021] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.766machine # [ 11.978323] systemd[1]: Starting linger-users.service...767machine # [ 12.013527] dbus-broker-launch[488]: Ready768machine # [ 12.046188] systemd[1]: Stopped target Host and Network Name Lookups.769machine # [ 12.051316] systemd[1]: Stopping Host and Network Name Lookups...770machine # [ 12.055819] systemd[1]: Stopped target User and Group Name Lookups.771machine # [ 12.061821] systemd[1]: Stopping User and Group Name Lookups...772machine # [ 12.067608] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...773machine # [ 12.074889] systemd[1]: nscd.service: Deactivated successfully.774machine # [ 12.078912] systemd[1]: Stopped Name Service Cache Daemon (nsncd).775machine # [ 12.085592] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.776machine # [ 12.100328] systemd[1]: Started backdoor.service.777machine # [ 12.110269] systemd[1]: Starting Name Service Cache Daemon (nsncd)...778machine # [ 12.193331] systemd[1]: Created slice Slice /user/1001.779machine # [ 12.211040] systemd[1]: Starting User Runtime Directory /run/user/1001...780machine # [ 12.246045] systemd[1]: linger-users.service: Deactivated successfully.781machine # [ 12.263165] systemd[1]: Finished linger-users.service.782machine # [ 12.298780] systemd[1]: Finished resolvconf update.783machine # [ 12.309315] systemd[1]: Reached target Preparation for Network.784machine # [ 12.331515] systemd[1]: Starting DHCP Client...785machine # [ 12.344524] systemd[1]: Starting Extra networking commands....786machine # connecting to host...787machine # [ 12.382562] (udev-worker)[372]: Network interface NamePolicy= disabled on kernel command line.788machine # [ 12.408167] (udev-worker)[373]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.789machine # [ 12.410310] (udev-worker)[373]: Network interface NamePolicy= disabled on kernel command line.790machine # [ 12.479181] nsncd[559]: Sep 03 02:36:31.960 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"791machine # [ 12.528591] systemd[1]: Finished User Runtime Directory /run/user/1001.792machine # [ 12.529588] systemd[1]: Starting User Manager for UID 1001...793machine # [ 12.530498] systemd[1]: Started Name Service Cache Daemon (nsncd).794machine # [ 12.531437] systemd[1]: Reached target Host and Network Name Lookups.795machine: Guest shell says: b'Spawning backdoor root shell...\n'796machine: connected to guest root shell797machine # [ 12.593185] systemd[1]: Reached target User and Group Name Lookups.798machine: (connecting took 12.92 seconds)799machine # [ 12.594176] systemd-logind[504]: Watching system buttons on /dev/input/event0 (gpio-keys)800machine: (finished: waiting for the VM to finish booting, in 13.54 seconds)801machine # [ 12.634666] (systemd)[582]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0)802machine # [ 12.669292] systemd[1]: Condition check resulted in Virtio network device being skipped.803machine # [ 12.670452] systemd[1]: Starting Address configuration of eth1...804machine # [ 12.671267] systemd-logind[504]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'.805machine # [ 12.737622] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy806machine # [ 12.827348] mousedev: PS/2 mouse device common for all mice807machine # [ 13.074099] systemd[582]: Queued start job for default target Main User Target.808machine # [ 13.082479] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy809machine # [ 13.105735] systemd[582]: Created slice User Application Slice.810machine # [ 13.106731] systemd[582]: Started Daily Cleanup of User's Temporary Directories.811machine # [ 13.107731] systemd[582]: Reached target Paths.812machine # [ 13.131071] systemd[582]: Reached target Timers.813machine # [ 13.131869] systemd[582]: Starting D-Bus User Message Bus Socket...814machine # [ 13.151852] systemd[582]: Starting Create User Files and Directories...815machine # [ 13.172352] network-addresses-eth1-start[598]: adding address 192.168.1.1/24... done816machine # [ 13.189362] systemd[582]: Finished Create User Files and Directories.817machine # [ 13.199036] network-addresses-eth1-start[598]: adding address 2001:db8:1::1/64... done818machine # [ 13.229712] systemd[582]: Listening on D-Bus User Message Bus Socket.819machine # [ 13.230720] systemd[582]: Reached target Sockets.820machine # [ 13.249271] systemd[582]: Reached target Basic System.821machine # [ 13.253896] systemd[1]: Started User Manager for UID 1001.822machine # [ 13.256904] systemd[582]: Starting Run user-specific NixOS activation...823machine # [ 13.272908] systemd[1]: Finished Address configuration of eth1.824machine # [ 13.308143] systemd[582]: Finished Run user-specific NixOS activation.825machine # [ 13.309240] systemd[582]: Reached target Main User Target.826machine # [ 13.311742] systemd[582]: Startup finished in 595ms.827machine # [ 13.378729] dhcpcd[610]: dhcpcd-10.3.2 starting828machine # [ 13.419434] systemd[1]: Finished Extra networking commands..829machine # [ 13.437243] systemd[1]: Reached target Network.830machine # [ 13.437911] systemd[1]: Starting Permit User Sessions...831machine # [ 13.466584] dhcpcd[690]: dev: loaded udev832machine # [ 13.510607] systemd-logind[504]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)833machine # [ 13.540552] 8021q: 802.1Q VLAN Support v1.8834machine # [ 13.540931] 8021q: adding VLAN 0 to HW filter on device eth1835machine # [ 13.645951] cfg80211: Loading compiled-in X.509 certificates for regulatory database836machine # [ 13.684993] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'837machine # [ 13.685526] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'838machine # [ 13.691137] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2839machine # [ 13.691488] cfg80211: failed to load regulatory.db840machine # [ 13.798230] systemd[1]: Finished Permit User Sessions.841machine # [ 13.815208] systemd[1]: Started Getty on tty1.842machine # [ 13.828798] systemd[1]: Reached target Login Prompts.843machine # [ 14.186916] 8021q: adding VLAN 0 to HW filter on device eth0844machine # [ 14.188716] dhcpcd[690]: eth0: waiting for carrier845machine # [ 14.200564] dhcpcd[690]: libudev: received NULL device846machine # [ 14.213749] dhcpcd[690]: libudev: received NULL device847machine # [ 14.214740] dhcpcd[690]: eth0: carrier acquired848machine # [ 14.353538] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3849machine # [ 14.344462] dhcpcd[690]: DUID 00:01:00:01:32:2b:99:b1:52:54:00:12:34:56850machine # [ 14.345592] dhcpcd[690]: eth0: IAID 00:12:34:56851machine # [ 14.346268] dhcpcd[690]: eth0: adding address fe80::5054:ff:fe12:3456852machine # [ 14.752607] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.853machine # [ 14.772569] systemd[1]: Starting Virtual Console Setup...854machine # [ 14.818720] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.855machine # [ 14.819883] systemd[1]: Stopped Virtual Console Setup.856machine # [ 14.826908] systemd[1]: Starting Virtual Console Setup...857machine # [ 14.830680] systemd-logind[504]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)858machine # [ 15.152692] dhcpcd[690]: eth0: soliciting a DHCP lease859machine # [ 15.160591] dhcpcd[690]: eth0: offered 10.0.2.15 from 10.0.2.2860machine # [ 15.168317] dhcpcd[690]: eth0: probing address 10.0.2.15/24861machine # [ 15.266320] systemd-vconsole-setup[723]: Configuration of first virtual console was skipped, ignoring remaining ones.862machine # [ 15.271167] systemd[1]: Finished Virtual Console Setup.863machine # [ 16.723185] dhcpcd[690]: eth0: soliciting an IPv6 router864machine # [ 16.726855] dhcpcd[690]: eth0: Router Advertisement from fe80::2865machine # [ 16.729855] dhcpcd[690]: eth0: adding address fec0::5054:ff:fe12:3456/64866machine # [ 16.733344] dhcpcd[690]: eth0: adding route to fec0::/64867machine # [ 16.735581] dhcpcd[690]: eth0: adding default route via fe80::2868machine # [ 20.312356] dhcpcd[690]: eth0: leased 10.0.2.15 for 86400 seconds869machine # [ 20.313741] dhcpcd[690]: eth0: adding route to 10.0.2.0/24870machine # [ 20.314898] dhcpcd[690]: eth0: adding default route via 10.0.2.2871machine # [ 20.497521] systemd[1]: Started DHCP Client.872machine # [ 20.499383] systemd[1]: Reached target Multi-User System.873machine # [ 20.500925] systemd[1]: Startup finished in 1.063s (kernel) + 5.450s (initrd) + 13.984s (userspace) = 20.499s.874machine: (finished: waiting for unit multi-user.target, in 22.50 seconds)875machine: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/bin/switch-to-configuration test876machine # Checking switch inhibitors... done877machine # [ 22.183554] nixos[840]: switching to system configuration /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test878machine # [ 22.186627] systemd[1]: Stopped target Local File Systems.879machine # activating the configuration...880machine # [ 22.189772] systemd[1]: Stopped target Remote File Systems.881machine # setting up /etc...882machine # [ 22.678362] systemd[1]: Reload requested from client PID 840 ('.switch-to-conf') (unit backdoor.service)...883machine # [ 22.680564] systemd[1]: Reloading...884machine # [ 23.335962] systemd[1]: Reloading finished in 652 ms.885machine # reloading user units for usertest...886machine # [ 23.391699] systemd[582]: Created slice User Core Session Slice.887machine # [ 23.395652] systemd[582]: Starting D-Bus User Message Bus...888machine # [ 23.466713] dbus-broker-launch[910]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/7h3c20lswgjcx4dw78jq3y43vk64wi2d-system-path/share/dbus-1/services/org.freedesktop.import1.service'889machine # [ 23.470038] dbus-broker-launch[910]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/7h3c20lswgjcx4dw78jq3y43vk64wi2d-system-path/share/dbus-1/services/org.freedesktop.machine1.service'890machine # [ 23.473263] dbus-broker-launch[910]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/7h3c20lswgjcx4dw78jq3y43vk64wi2d-system-path/share/dbus-1/services/org.freedesktop.portable1.service'891machine # [ 23.476786] dbus-broker-launch[910]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/7h3c20lswgjcx4dw78jq3y43vk64wi2d-system-path/share/dbus-1/services/org.freedesktop.systemd1.service'892machine # [ 23.480681] dbus-broker-launch[910]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored893machine # [ 23.483616] dbus-broker-launch[910]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored894machine # [ 23.486084] systemd[582]: Started D-Bus User Message Bus.895machine # [ 23.493008] dbus-broker-launch[910]: Ready896machine # [ 23.623557] systemd[582]: Reexecution requested from client PID 909 ('switch-to-confi')...897machine # [ 23.626390] systemd[582]: Reexecuting.898machine # [ 23.695582] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy899machine # [ 23.902804] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy900machine # [ 23.909945] systemd[582]: Reload requested from client PID 909 ('switch-to-confi')...901machine # [ 23.911784] systemd[582]: Reloading...902machine # [ 24.111278] systemd[582]: Reloading finished in 198 ms.903machine # [ 24.128202] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy904machine # restarting the following user units: nixos-activation.service905machine # [ 24.138993] systemd[582]: Stopped Run user-specific NixOS activation.906machine # [ 24.139984] systemd[582]: Stopping Run user-specific NixOS activation...907machine # [ 24.144094] systemd[582]: Starting Run user-specific NixOS activation...908machine # [ 24.190540] systemd[582]: Finished Run user-specific NixOS activation.909machine # restarting sysinit-reactivation.target910machine # [ 24.207599] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....911machine # [ 24.329476] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..912machine # [ 24.333717] systemd[1]: Reached target Reactivate sysinit units.913machine # [ 24.336719] systemd[1]: Reached target Local File Systems.914machine # [ 24.339565] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore915machine # [ 24.347748] systemd[1]: Starting Create SUID/SGID Wrappers...916machine # [ 24.349464] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.917machine # [ 24.355156] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67918machine # [ 24.359147] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore919machine # [ 24.369089] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os920machine # [ 24.370404] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os921machine # [ 24.371605] systemd[1]: Reached target Remote File Systems.922machine # [ 24.373483] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os923machine # [ 24.374799] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki924machine # [ 24.697808] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.925machine # [ 24.702014] systemd[1]: Finished Create SUID/SGID Wrappers.926machine # [ 24.705002] systemd[1]: Starting linger-users.service...927machine # [ 24.770092] systemd[1]: linger-users.service: Deactivated successfully.928machine # [ 24.773213] systemd[1]: Finished linger-users.service.929machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service930machine # [ 25.037366] nixos[840]: finished switching to system configuration /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test931machine: (finished: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/bin/switch-to-configuration test, in 3.50 seconds)932machine: must succeed: rm /etc/NIXOS933machine: (finished: must succeed: rm /etc/NIXOS, in 0.06 seconds)934machine: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/3a3s3qspl50ndrh8jigrqp7ws8cppdim-nixos-system-other-test/bin/switch-to-configuration test935machine # this should succeed (config: /nix/store/3a3s3qspl50ndrh8jigrqp7ws8cppdim-nixos-system-other-test, action: test)936machine # Checking switch inhibitors... done937machine # [ 25.742037] nixos[988]: switching to system configuration /nix/store/3a3s3qspl50ndrh8jigrqp7ws8cppdim-nixos-system-other-test938machine # [ 25.744843] systemd[1]: Stopped target Remote File Systems.939machine # activating the configuration...940machine # [ 25.747629] systemd[1]: Stopped target Local File Systems.941machine # removing user ‘usertest’942machine # setting up /etc...943machine # [ 26.289304] systemd[1]: Reload requested from client PID 988 ('.switch-to-conf') (unit backdoor.service)...944machine # [ 26.291366] systemd[1]: Reloading...945machine # [ 26.957892] systemd[1]: Reloading finished in 663 ms.946machine # reloading user units for usertest...947machine # [ 27.136570] systemd[582]: Reexecution requested from client PID 1059 ('switch-to-confi')...948machine # [ 27.139168] systemd[582]: Reexecuting.949machine # [ 27.201936] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy950machine # [ 27.401297] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy951machine # [ 27.407912] systemd[582]: Reload requested from client PID 1059 ('switch-to-confi')...952machine # [ 27.410586] systemd[582]: Reloading...953machine # [ 27.612485] systemd[582]: Reloading finished in 201 ms.954machine # [ 27.628247] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy955machine # restarting the following user units: nixos-activation.service956machine # [ 27.640097] systemd[582]: Stopped Run user-specific NixOS activation.957machine # [ 27.641148] systemd[582]: Stopping Run user-specific NixOS activation...958machine # [ 27.645412] systemd[582]: Starting Run user-specific NixOS activation...959machine # [ 27.699055] systemd[582]: Finished Run user-specific NixOS activation.960machine # restarting sysinit-reactivation.target961machine # [ 27.704137] systemd[1]: Stopped target Reactivate sysinit units.962machine # reloading the following units: dbus-broker.service963machine # [ 27.709440] systemd[1]: Stopping Reactivate sysinit units...964machine # [ 27.710373] systemd[1]: Reached target Reactivate sysinit units.965machine # [ 27.711205] systemd[1]: Reloading D-Bus System Message Bus...966machine # [ 27.712729] dbus-broker-launch[488]: Caught SIGHUP, trigger reload.967machine # [ 27.735150] dbus-broker-launch[488]: Looking up NSS user entry for 'systemd-timesync'...968machine # [ 27.737586] dbus-broker-launch[488]: NSS returned no entry for 'systemd-timesync'969machine # [ 27.738899] dbus-broker-launch[488]: Invalid user-name in /nix/store/nkx9p62fj70jkwrb7000n9rch9s80873-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"970machine # [ 27.776821] systemd[1]: Reloaded D-Bus System Message Bus.971machine # restarting the following units: network-addresses-eth1.service972machine # [ 27.785467] systemd[1]: Stopping Address configuration of eth1...973machine # [ 27.843429] network-addresses-eth1-pre-stop[1072]: deleting address 192.168.1.1/24... done974machine # [ 27.857532] network-addresses-eth1-pre-stop[1072]: deleting address 2001:db8:1::1/64... done975machine # [ 27.868575] systemd[1]: network-addresses-eth1.service: Deactivated successfully.976machine # [ 27.872189] systemd[1]: Stopped Address configuration of eth1.977machine # [ 27.876821] systemd[1]: Starting Address configuration of eth1...978machine # [ 27.958628] network-addresses-eth1-start[1077]: adding address 192.168.1.2/24... done979machine # [ 27.978707] network-addresses-eth1-start[1077]: adding address 2001:db8:1::2/64... done980machine # [ 27.999249] systemd[1]: Finished Address configuration of eth1.981machine # [ 28.003741] systemd[1]: Reached target Remote File Systems.982machine # [ 28.010797] systemd[1]: Starting linger-users.service...983machine # [ 28.013626] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os984machine # [ 28.017972] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki985machine # [ 28.024003] systemd[1]: Reached target Local File Systems.986machine # [ 28.029532] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore987machine # [ 28.035029] systemd[1]: Starting Create SUID/SGID Wrappers...988machine # [ 28.042123] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.989machine # [ 28.046937] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67990machine # [ 28.054801] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore991machine # [ 28.056812] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os992machine # [ 28.059376] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os993machine # [ 28.105280] linger-users-start[1092]: id: ‘usertest’: no such user994machine # [ 28.108581] linger-users-start[1088]: Removing linger for missing user usertest995machine # [ 28.118986] systemd[1]: linger-users.service: Deactivated successfully.996machine # [ 28.122696] systemd[1]: Finished linger-users.service.997machine # [ 28.520591] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.998machine # [ 28.523618] systemd[1]: Finished Create SUID/SGID Wrappers.999machine # [ 28.782938] nixos[988]: finished switching to system configuration /nix/store/3a3s3qspl50ndrh8jigrqp7ws8cppdim-nixos-system-other-test1000machine: (finished: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/3a3s3qspl50ndrh8jigrqp7ws8cppdim-nixos-system-other-test/bin/switch-to-configuration test, in 3.69 seconds)1001subtest: services1002machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/bin/switch-to-configuration test 2>&11003machine # [ 29.387696] nixos[1155]: switching to system configuration /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test1004machine # [ 29.390723] systemd[1]: Stopped target Remote File Systems.1005machine # [ 29.393241] systemd[1]: Stopped target Local File Systems.1006machine # [ 29.836186] systemd[1]: Reload requested from client PID 1155 ('.switch-to-conf') (unit backdoor.service)...1007machine # [ 29.838762] systemd[1]: Reloading...1008machine # [ 30.446301] systemd[1]: Reloading finished in 604 ms.1009machine # [ 30.624432] systemd[582]: Reexecution requested from client PID 1224 ('switch-to-confi')...1010machine # [ 30.628603] systemd[582]: Reexecuting.1011machine # [ 30.698220] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1012machine # [ 30.899263] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1013machine # [ 30.906124] systemd[582]: Reload requested from client PID 1224 ('switch-to-confi')...1014machine # [ 30.908849] systemd[582]: Reloading...1015machine # [ 31.105365] systemd[582]: Reloading finished in 195 ms.1016machine # [ 31.120200] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1017machine # [ 31.129738] systemd[582]: Stopped Run user-specific NixOS activation.1018machine # [ 31.132269] systemd[582]: Stopping Run user-specific NixOS activation...1019machine # [ 31.135358] systemd[582]: Starting Run user-specific NixOS activation...1020machine # [ 31.182527] systemd[582]: Finished Run user-specific NixOS activation.1021machine # [ 31.186870] systemd[1]: Stopped target Reactivate sysinit units.1022machine # [ 31.190790] systemd[1]: Stopping Reactivate sysinit units...1023machine # [ 31.191692] systemd[1]: Reached target Reactivate sysinit units.1024machine # [ 31.193570] dbus-broker-launch[488]: Caught SIGHUP, trigger reload.1025machine # [ 31.194599] systemd[1]: Reloading D-Bus System Message Bus...1026machine # [ 31.209086] dbus-broker-launch[488]: Looking up NSS user entry for 'systemd-timesync'...1027machine # [ 31.211378] dbus-broker-launch[488]: NSS returned no entry for 'systemd-timesync'1028machine # [ 31.212710] dbus-broker-launch[488]: Invalid user-name in /nix/store/7h3c20lswgjcx4dw78jq3y43vk64wi2d-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1029machine # [ 31.237157] systemd[1]: Reloaded D-Bus System Message Bus.1030machine # [ 31.244080] systemd[1]: Stopping Address configuration of eth1...1031machine # [ 31.299666] network-addresses-eth1-pre-stop[1237]: deleting address 192.168.1.2/24... done1032machine # [ 31.313921] network-addresses-eth1-pre-stop[1237]: deleting address 2001:db8:1::2/64... done1033machine # [ 31.326487] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1034machine # [ 31.328557] systemd[1]: Stopped Address configuration of eth1.1035machine # [ 31.335070] systemd[1]: Starting Address configuration of eth1...1036machine # [ 31.414324] network-addresses-eth1-start[1242]: adding address 192.168.1.1/24... done1037machine # [ 31.427851] network-addresses-eth1-start[1242]: adding address 2001:db8:1::1/64... done1038machine # [ 31.445679] systemd[1]: Finished Address configuration of eth1.1039machine # [ 31.450377] systemd[1]: Reached target Local File Systems.1040machine # [ 31.454186] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1041machine # [ 31.459617] systemd[1]: Starting Create SUID/SGID Wrappers...1042machine # [ 31.462980] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1043machine # [ 31.466729] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671044machine # [ 31.470405] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1045machine # [ 31.472316] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1046machine # [ 31.479036] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1047machine # [ 31.485659] systemd[1]: Reached target Remote File Systems.1048machine # [ 31.486555] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1049machine # [ 31.487811] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1050machine # [ 31.862487] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1051machine # [ 31.865225] systemd[1]: Finished Create SUID/SGID Wrappers.1052machine # [ 31.870575] systemd[1]: Starting linger-users.service...1053machine # [ 31.927253] systemd[1]: linger-users.service: Deactivated successfully.1054machine # [ 31.930558] systemd[1]: Finished linger-users.service.1055machine # [ 32.188715] nixos[1155]: finished switching to system configuration /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test1056machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.40 seconds)1057machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/bin/switch-to-configuration test 2>&11058machine # [ 32.803363] nixos[1311]: switching to system configuration /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test1059machine # [ 32.806320] systemd[1]: Stopped target Remote File Systems.1060machine # [ 32.808763] systemd[1]: Stopped target Local File Systems.1061machine # [ 33.322638] systemd[1]: Reload requested from client PID 1311 ('.switch-to-conf') (unit backdoor.service)...1062machine # [ 33.325082] systemd[1]: Reloading...1063machine # [ 34.010810] systemd[1]: Reloading finished in 682 ms.1064machine # [ 34.182733] systemd[582]: Reexecution requested from client PID 1380 ('switch-to-confi')...1065machine # [ 34.185065] systemd[582]: Reexecuting.1066machine # [ 34.246739] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1067machine # [ 34.447850] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1068machine # [ 34.455568] systemd[582]: Reload requested from client PID 1380 ('switch-to-confi')...1069machine # [ 34.458413] systemd[582]: Reloading...1070machine # [ 34.655849] systemd[582]: Reloading finished in 196 ms.1071machine # [ 34.669828] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1072machine # [ 34.678411] systemd[582]: Stopped Run user-specific NixOS activation.1073machine # [ 34.681204] systemd[582]: Stopping Run user-specific NixOS activation...1074machine # [ 34.684460] systemd[582]: Starting Run user-specific NixOS activation...1075machine # [ 34.737557] systemd[582]: Finished Run user-specific NixOS activation.1076machine # [ 34.742281] systemd[1]: Stopped target Reactivate sysinit units.1077machine # [ 34.745048] systemd[1]: Stopping Reactivate sysinit units...1078machine # [ 34.746031] systemd[1]: Reached target Reactivate sysinit units.1079machine # [ 34.746890] systemd[1]: Reached target Remote File Systems.1080machine # [ 34.753377] systemd[1]: Reached target Local File Systems.1081machine # [ 34.755550] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1082machine # [ 34.760182] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1083machine # [ 34.767166] systemd[1]: Starting linger-users.service...1084machine # [ 34.773038] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1085machine # [ 34.782078] systemd[1]: Starting Create SUID/SGID Wrappers...1086machine # [ 34.783073] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1087machine # [ 34.791397] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671088machine # [ 34.794024] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1089machine # [ 34.795586] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1090machine # [ 34.798350] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1091machine # [ 34.864000] systemd[1]: linger-users.service: Deactivated successfully.1092machine # [ 34.868528] systemd[1]: Finished linger-users.service.1093machine # [ 35.159297] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1094machine # [ 35.163095] systemd[1]: Finished Create SUID/SGID Wrappers.1095machine # [ 35.420271] nixos[1311]: finished switching to system configuration /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test1096machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.23 seconds)1097machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11098machine # [ 36.061827] nixos[1452]: switching to system configuration /nix/store/w4cqv7fv5yxlf22nh2qgz2pyaw4sq201-nixos-system-machine-test1099machine # [ 36.064537] systemd[1]: Stopped target Remote File Systems.1100machine # [ 36.066599] systemd[1]: Stopped target Local File Systems.1101machine # [ 36.604496] systemd[1]: Reload requested from client PID 1452 ('.switch-to-conf') (unit backdoor.service)...1102machine # [ 36.606453] systemd[1]: Reloading...1103machine # [ 37.305212] systemd[1]: Reloading finished in 695 ms.1104machine # [ 37.471422] systemd[582]: Reexecution requested from client PID 1521 ('switch-to-confi')...1105machine # [ 37.474294] systemd[582]: Reexecuting.1106machine # [ 37.529646] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1107machine # [ 37.727395] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1108machine # [ 37.734573] systemd[582]: Reload requested from client PID 1521 ('switch-to-confi')...1109machine # [ 37.737245] systemd[582]: Reloading...1110machine # [ 37.931047] systemd[582]: Reloading finished in 192 ms.1111machine # [ 37.944189] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1112machine # [ 37.955594] systemd[582]: Stopped Run user-specific NixOS activation.1113machine # [ 37.958068] systemd[582]: Stopping Run user-specific NixOS activation...1114machine # [ 37.961515] systemd[582]: Starting Run user-specific NixOS activation...1115machine # [ 38.014000] systemd[582]: Finished Run user-specific NixOS activation.1116machine # [ 38.019042] systemd[1]: Stopped target Reactivate sysinit units.1117machine # [ 38.021972] systemd[1]: Stopping Reactivate sysinit units...1118machine # [ 38.022950] systemd[1]: Reached target Reactivate sysinit units.1119machine # [ 38.024795] systemd[1]: Reached target Local File Systems.1120machine # [ 38.027742] systemd[1]: Reached target Remote File Systems.1121machine # [ 38.030324] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1122machine # [ 38.038622] systemd[1]: Starting Create SUID/SGID Wrappers...1123machine # [ 38.042113] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1124machine # [ 38.043860] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671125machine # [ 38.053614] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1126machine # [ 38.055279] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1127machine # [ 38.060614] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1128machine # [ 38.061960] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1129machine # [ 38.063215] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1130machine # [ 38.409998] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1131machine # [ 38.414710] systemd[1]: Finished Create SUID/SGID Wrappers.1132machine # [ 38.418729] systemd[1]: Starting linger-users.service...1133machine # [ 38.422102] systemd[1]: Starting test.service...1134machine # [ 38.469081] systemd[1]: Finished test.service.1135machine # [ 38.498467] systemd[1]: linger-users.service: Deactivated successfully.1136machine # [ 38.501813] systemd[1]: Finished linger-users.service.1137machine # [ 38.761070] nixos[1452]: finished switching to system configuration /nix/store/w4cqv7fv5yxlf22nh2qgz2pyaw4sq201-nixos-system-machine-test1138machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 3.34 seconds)1139machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11140machine # [ 39.360361] nixos[1595]: switching to system configuration /nix/store/w4cqv7fv5yxlf22nh2qgz2pyaw4sq201-nixos-system-machine-test1141machine # [ 39.363116] systemd[1]: Stopped target Remote File Systems.1142machine # [ 39.365365] systemd[1]: Stopped target Local File Systems.1143machine # [ 39.886231] systemd[1]: Reload requested from client PID 1595 ('.switch-to-conf') (unit backdoor.service)...1144machine # [ 39.888443] systemd[1]: Reloading...1145machine # [ 40.648480] systemd[1]: Reloading finished in 757 ms.1146machine # [ 40.820612] systemd[582]: Reexecution requested from client PID 1664 ('switch-to-confi')...1147machine # [ 40.825463] systemd[582]: Reexecuting.1148machine # [ 40.878314] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1149machine # [ 41.112935] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1150machine # [ 41.119698] systemd[582]: Reload requested from client PID 1664 ('switch-to-confi')...1151machine # [ 41.122405] systemd[582]: Reloading...1152machine # [ 41.350912] systemd[582]: Reloading finished in 227 ms.1153machine # [ 41.365759] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1154machine # [ 41.374699] systemd[582]: Stopped Run user-specific NixOS activation.1155machine # [ 41.377262] systemd[582]: Stopping Run user-specific NixOS activation...1156machine # [ 41.380523] systemd[582]: Starting Run user-specific NixOS activation...1157machine # [ 41.429488] systemd[582]: Finished Run user-specific NixOS activation.1158machine # [ 41.433835] systemd[1]: Stopped target Reactivate sysinit units.1159machine # [ 41.435985] systemd[1]: Stopping Reactivate sysinit units...1160machine # [ 41.437572] systemd[1]: Reached target Reactivate sysinit units.1161machine # [ 41.439533] systemd[1]: Reached target Local File Systems.1162machine # [ 41.442241] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1163machine # [ 41.445857] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1164machine # [ 41.447747] systemd[1]: Reached target Remote File Systems.1165machine # [ 41.456929] systemd[1]: Starting linger-users.service...1166machine # [ 41.467290] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1167machine # [ 41.474056] systemd[1]: Starting Create SUID/SGID Wrappers...1168machine # [ 41.475010] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1169machine # [ 41.479113] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671170machine # [ 41.482933] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1171machine # [ 41.485641] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1172machine # [ 41.488346] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1173machine # [ 41.553104] systemd[1]: linger-users.service: Deactivated successfully.1174machine # [ 41.556451] systemd[1]: Finished linger-users.service.1175machine # [ 41.886630] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1176machine # [ 41.890029] systemd[1]: Finished Create SUID/SGID Wrappers.1177machine # [ 42.147541] nixos[1595]: finished switching to system configuration /nix/store/w4cqv7fv5yxlf22nh2qgz2pyaw4sq201-nixos-system-machine-test1178machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 3.39 seconds)1179machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&11180machine # [ 42.908594] nixos[1736]: switching to system configuration /nix/store/06kqwcih8kqlgz8nvhly82flr815ggh8-nixos-system-machine-test1181machine # [ 42.912262] systemd[1]: Stopped target Local File Systems.1182machine # [ 42.913779] systemd[1]: Stopped target Remote File Systems.1183machine # [ 43.523214] systemd[1]: Reload requested from client PID 1736 ('.switch-to-conf') (unit backdoor.service)...1184machine # [ 43.526098] systemd[1]: Reloading...1185machine # [ 44.837360] systemd[1]: Reloading finished in 1308 ms.1186machine # [ 45.011893] systemd[582]: Reexecution requested from client PID 1805 ('switch-to-confi')...1187machine # [ 45.017147] systemd[582]: Reexecuting.1188machine # [ 45.093849] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1189machine # [ 45.312547] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1190machine # [ 45.319419] systemd[582]: Reload requested from client PID 1805 ('switch-to-confi')...1191machine # [ 45.322334] systemd[582]: Reloading...1192machine # [ 45.544502] systemd[582]: Reloading finished in 220 ms.1193machine # [ 45.562218] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1194machine # [ 45.572393] systemd[582]: Stopped Run user-specific NixOS activation.1195machine # [ 45.575153] systemd[582]: Stopping Run user-specific NixOS activation...1196machine # [ 45.578613] systemd[582]: Starting Run user-specific NixOS activation...1197machine # [ 45.634367] systemd[582]: Finished Run user-specific NixOS activation.1198machine # [ 45.639242] systemd[1]: Stopped target Reactivate sysinit units.1199machine # [ 45.641849] systemd[1]: Stopping Reactivate sysinit units...1200machine # [ 45.642733] systemd[1]: Reached target Reactivate sysinit units.1201machine # [ 45.646844] systemd[1]: Reached target Local File Systems.1202machine # [ 45.650901] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1203machine # [ 45.655670] systemd[1]: Starting Create SUID/SGID Wrappers...1204machine # [ 45.658579] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1205machine # [ 45.662187] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671206machine # [ 45.672656] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1207machine # [ 45.674411] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1208machine # [ 45.675638] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1209machine # [ 45.684409] systemd[1]: Reached target Remote File Systems.1210machine # [ 45.688683] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1211machine # [ 45.692989] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1212machine # [ 46.098375] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1213machine # [ 46.103731] systemd[1]: Finished Create SUID/SGID Wrappers.1214machine # [ 46.107080] systemd[1]: Starting linger-users.service...1215machine # [ 46.185490] systemd[1]: linger-users.service: Deactivated successfully.1216machine # [ 46.189087] systemd[1]: Finished linger-users.service.1217machine # [ 46.447478] nixos[1736]: finished switching to system configuration /nix/store/06kqwcih8kqlgz8nvhly82flr815ggh8-nixos-system-machine-test1218machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 4.30 seconds)1219machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11220machine # [ 47.278949] nixos[1877]: switching to system configuration /nix/store/lcf7dm3ckw9spkrc3mhap5fm30ib8r0g-nixos-system-machine-test1221machine # [ 47.283349] systemd[1]: Stopped target Local File Systems.1222machine # [ 47.285244] systemd[1]: Stopped target Remote File Systems.1223machine # [ 47.286108] systemd[1]: test.service: Deactivated successfully.1224machine # [ 47.286952] systemd[1]: Stopped Test unit.1225machine # [ 48.008699] systemd[1]: Reload requested from client PID 1877 ('.switch-to-conf') (unit backdoor.service)...1226machine # [ 48.009336] systemd[1]: Reloading...1227machine # [ 49.169560] systemd[1]: Reloading finished in 1154 ms.1228machine # [ 49.339685] systemd[582]: Reexecution requested from client PID 1947 ('switch-to-confi')...1229machine # [ 49.342307] systemd[582]: Reexecuting.1230machine # [ 49.412365] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1231machine # [ 49.656177] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1232machine # [ 49.664249] systemd[582]: Reload requested from client PID 1947 ('switch-to-confi')...1233machine # [ 49.665679] systemd[582]: Reloading...1234machine # [ 49.904069] systemd[582]: Reloading finished in 236 ms.1235machine # [ 49.917879] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1236machine # [ 49.928119] systemd[582]: Stopped Run user-specific NixOS activation.1237machine # [ 49.929257] systemd[582]: Stopping Run user-specific NixOS activation...1238machine # [ 49.934141] systemd[582]: Starting Run user-specific NixOS activation...1239machine # [ 49.997883] systemd[582]: Finished Run user-specific NixOS activation.1240machine # [ 50.003382] systemd[1]: Stopped target Reactivate sysinit units.1241machine # [ 50.006048] systemd[1]: Stopping Reactivate sysinit units...1242machine # [ 50.007383] systemd[1]: Reached target Reactivate sysinit units.1243machine # [ 50.013463] systemd[1]: Reached target Remote File Systems.1244machine # [ 50.016366] systemd[1]: Starting linger-users.service...1245machine # [ 50.022618] systemd[1]: Starting test.service...1246machine # [ 50.043536] systemd[1]: Reached target Local File Systems.1247machine # [ 50.049984] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1248machine # [ 50.055542] systemd[1]: Starting Create SUID/SGID Wrappers...1249machine # [ 50.061959] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1250machine # [ 50.063448] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671251machine # [ 50.080839] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1252machine # [ 50.085012] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1253machine # [ 50.086849] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1254machine # [ 50.090153] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1255machine # [ 50.092553] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1256machine # [ 50.125323] systemd[1]: Finished test.service.1257machine # [ 50.182374] systemd[1]: linger-users.service: Deactivated successfully.1258machine # [ 50.183530] systemd[1]: Finished linger-users.service.1259machine # [ 50.561157] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1260machine # [ 50.565093] systemd[1]: Finished Create SUID/SGID Wrappers.1261machine # [ 50.823104] nixos[1877]: finished switching to system configuration /nix/store/lcf7dm3ckw9spkrc3mhap5fm30ib8r0g-nixos-system-machine-test1262machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 4.38 seconds)1263machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&11264machine # [ 51.635561] nixos[2020]: switching to system configuration /nix/store/0r8x6rl8kii363lk3vnc3cafmvs9r0ya-nixos-system-machine-test1265machine # [ 51.639455] systemd[1]: Stopped target Local File Systems.1266machine # [ 51.640922] systemd[1]: Stopped target Remote File Systems.1267machine # [ 52.277591] systemd[1]: Reload requested from client PID 2020 ('.switch-to-conf') (unit backdoor.service)...1268machine # [ 52.280073] systemd[1]: Reloading...1269machine # [ 53.076888] systemd[1]: Reloading finished in 794 ms.1270machine # [ 53.238464] systemd[582]: Reexecution requested from client PID 2089 ('switch-to-confi')...1271machine # [ 53.241087] systemd[582]: Reexecuting.1272machine # [ 53.311669] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1273machine # [ 53.544629] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1274machine # [ 53.552594] systemd[582]: Reload requested from client PID 2089 ('switch-to-confi')...1275machine # [ 53.554747] systemd[582]: Reloading...1276machine # [ 53.761197] systemd[582]: Reloading finished in 204 ms.1277machine # [ 53.776302] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1278machine # [ 53.786342] systemd[582]: Stopped Run user-specific NixOS activation.1279machine # [ 53.789195] systemd[582]: Stopping Run user-specific NixOS activation...1280machine # [ 53.792647] systemd[582]: Starting Run user-specific NixOS activation...1281machine # [ 53.846985] systemd[582]: Finished Run user-specific NixOS activation.1282machine # [ 53.851865] systemd[1]: Stopped target Reactivate sysinit units.1283machine # [ 53.856683] systemd[1]: Stopping Reactivate sysinit units...1284machine # [ 53.857639] systemd[1]: Reached target Reactivate sysinit units.1285machine # [ 53.858451] systemd[1]: test.service: Deactivated successfully.1286machine # [ 53.859256] systemd[1]: Stopped test.service.1287machine # [ 53.859888] systemd[1]: Stopping test.service...1288machine # [ 53.864479] systemd[1]: Starting test.service...1289machine # [ 53.907891] systemd[1]: Finished test.service.1290machine # [ 53.912292] systemd[1]: Reached target Remote File Systems.1291machine # [ 53.925597] systemd[1]: Starting linger-users.service...1292machine # [ 53.929278] systemd[1]: Reached target Local File Systems.1293machine # [ 53.934727] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1294machine # [ 53.943259] systemd[1]: Starting Create SUID/SGID Wrappers...1295machine # [ 53.947034] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1296machine # [ 53.953848] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671297machine # [ 53.959535] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1298machine # [ 53.961556] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1299machine # [ 53.962803] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1300machine # [ 53.965540] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1301machine # [ 53.967218] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1302machine # [ 54.042992] systemd[1]: linger-users.service: Deactivated successfully.1303machine # [ 54.046670] systemd[1]: Finished linger-users.service.1304machine # [ 54.374779] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1305machine # [ 54.378360] systemd[1]: Finished Create SUID/SGID Wrappers.1306machine # [ 54.635919] nixos[2020]: finished switching to system configuration /nix/store/0r8x6rl8kii363lk3vnc3cafmvs9r0ya-nixos-system-machine-test1307machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.81 seconds)1308machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&11309machine # [ 55.358294] nixos[2162]: switching to system configuration /nix/store/xiz333gmqpmz8ad3ykzbgadall575km0-nixos-system-machine-test1310machine # [ 55.361577] systemd[1]: Stopped target Local File Systems.1311machine # [ 55.363031] systemd[1]: Stopped target Remote File Systems.1312machine # [ 55.904625] systemd[1]: Reload requested from client PID 2162 ('.switch-to-conf') (unit backdoor.service)...1313machine # [ 55.906680] systemd[1]: Reloading...1314machine # [ 56.718691] systemd[1]: Reloading finished in 809 ms.1315machine # [ 56.890709] systemd[582]: Reexecution requested from client PID 2231 ('switch-to-confi')...1316machine # [ 56.893009] systemd[582]: Reexecuting.1317machine # [ 56.967094] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1318machine # [ 57.187768] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1319machine # [ 57.195575] systemd[582]: Reload requested from client PID 2231 ('switch-to-confi')...1320machine # [ 57.198685] systemd[582]: Reloading...1321machine # [ 57.408727] systemd[582]: Reloading finished in 208 ms.1322machine # [ 57.424210] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1323machine # [ 57.435746] systemd[582]: Stopped Run user-specific NixOS activation.1324machine # [ 57.438374] systemd[582]: Stopping Run user-specific NixOS activation...1325machine # [ 57.441724] systemd[582]: Starting Run user-specific NixOS activation...1326machine # [ 57.494691] systemd[582]: Finished Run user-specific NixOS activation.1327machine # [ 57.499623] systemd[1]: Stopped target Reactivate sysinit units.1328machine # [ 57.504893] systemd[1]: Stopping Reactivate sysinit units...1329machine # [ 57.506741] systemd[1]: Reached target Reactivate sysinit units.1330machine # [ 57.509109] systemd[1]: Reloading test.service...1331machine # [ 57.549845] systemd[1]: Reloaded test.service.1332machine # [ 57.557747] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1333machine # [ 57.561216] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1334machine # [ 57.563108] systemd[1]: Reached target Local File Systems.1335machine # [ 57.565721] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1336machine # [ 57.573655] systemd[1]: Starting Create SUID/SGID Wrappers...1337machine # [ 57.574611] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1338machine # [ 57.575820] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671339machine # [ 57.579554] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1340machine # [ 57.591987] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1341machine # [ 57.593496] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1342machine # [ 57.594690] systemd[1]: Reached target Remote File Systems.1343machine # [ 57.971289] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1344machine # [ 57.974291] systemd[1]: Finished Create SUID/SGID Wrappers.1345machine # [ 57.981034] systemd[1]: Starting linger-users.service...1346machine # [ 58.062111] systemd[1]: linger-users.service: Deactivated successfully.1347machine # [ 58.066043] systemd[1]: Finished linger-users.service.1348machine # [ 58.326422] nixos[2162]: finished switching to system configuration /nix/store/xiz333gmqpmz8ad3ykzbgadall575km0-nixos-system-machine-test1349machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 3.69 seconds)1350machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&11351machine # [ 59.108690] nixos[2304]: switching to system configuration /nix/store/5zsm433avd24mawyji6a9wnrcfxd48s5-nixos-system-machine-test1352machine # [ 59.112453] systemd[1]: Stopped target Local File Systems.1353machine # [ 59.114063] systemd[1]: Stopped target Remote File Systems.1354machine # [ 59.786223] systemd[1]: Reload requested from client PID 2304 ('.switch-to-conf') (unit backdoor.service)...1355machine # [ 59.787942] systemd[1]: Reloading...1356machine # [ 60.574961] systemd[1]: Reloading finished in 783 ms.1357machine # [ 60.740002] systemd[582]: Reexecution requested from client PID 2372 ('switch-to-confi')...1358machine # [ 60.741474] systemd[582]: Reexecuting.1359machine # [ 60.806980] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1360machine # [ 61.018926] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1361machine # [ 61.025664] systemd[582]: Reload requested from client PID 2372 ('switch-to-confi')...1362machine # [ 61.028326] systemd[582]: Reloading...1363machine # [ 61.240761] systemd[582]: Reloading finished in 211 ms.1364machine # [ 61.257682] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1365machine # [ 61.266892] systemd[582]: Stopped Run user-specific NixOS activation.1366machine # [ 61.269486] systemd[582]: Stopping Run user-specific NixOS activation...1367machine # [ 61.272963] systemd[582]: Starting Run user-specific NixOS activation...1368machine # [ 61.325273] systemd[582]: Finished Run user-specific NixOS activation.1369machine # [ 61.329598] systemd[1]: Stopped target Reactivate sysinit units.1370machine # [ 61.332830] systemd[1]: Stopping Reactivate sysinit units...1371machine # [ 61.333983] systemd[1]: Reached target Reactivate sysinit units.1372machine # [ 61.338262] systemd[1]: Reached target Remote File Systems.1373machine # [ 61.340760] systemd[1]: Starting linger-users.service...1374machine # [ 61.350497] systemd[1]: Reached target Local File Systems.1375machine # [ 61.352895] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1376machine # [ 61.354208] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1377machine # [ 61.358293] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1378machine # [ 61.365791] systemd[1]: Starting Create SUID/SGID Wrappers...1379machine # [ 61.366787] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1380machine # [ 61.368713] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671381machine # [ 61.374908] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1382machine # [ 61.377171] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1383machine # [ 61.380202] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1384machine # [ 61.444178] systemd[1]: linger-users.service: Deactivated successfully.1385machine # [ 61.446579] systemd[1]: Finished linger-users.service.1386machine # [ 61.762384] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1387machine # [ 61.765925] systemd[1]: Finished Create SUID/SGID Wrappers.1388machine # [ 62.023009] nixos[2304]: finished switching to system configuration /nix/store/5zsm433avd24mawyji6a9wnrcfxd48s5-nixos-system-machine-test1389machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 3.69 seconds)1390machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&11391machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.80 seconds)1392machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/bin/switch-to-configuration test 2>&11393machine # [ 63.454745] nixos[2454]: switching to system configuration /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test1394machine # [ 63.458380] systemd[1]: Stopped target Local File Systems.1395machine # [ 63.461482] systemd[1]: Stopped target Remote File Systems.1396machine # [ 63.462723] systemd[1]: test.service: Deactivated successfully.1397machine # [ 63.463817] systemd[1]: Stopped test.service.1398machine # [ 64.001186] systemd[1]: Reload requested from client PID 2454 ('.switch-to-conf') (unit backdoor.service)...1399machine # [ 64.003240] systemd[1]: Reloading...1400machine # [ 64.653313] systemd[1]: Reloading finished in 647 ms.1401machine # [ 64.808733] systemd[582]: Reexecution requested from client PID 2523 ('switch-to-confi')...1402machine # [ 64.813093] systemd[582]: Reexecuting.1403machine # [ 64.867730] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1404machine # [ 65.074656] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1405machine # [ 65.081828] systemd[582]: Reload requested from client PID 2523 ('switch-to-confi')...1406machine # [ 65.084740] systemd[582]: Reloading...1407machine # [ 65.280522] systemd[582]: Reloading finished in 194 ms.1408machine # [ 65.300184] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1409machine # [ 65.309315] systemd[582]: Stopped Run user-specific NixOS activation.1410machine # [ 65.311665] systemd[582]: Stopping Run user-specific NixOS activation...1411machine # [ 65.314618] systemd[582]: Starting Run user-specific NixOS activation...1412machine # [ 65.363644] systemd[582]: Finished Run user-specific NixOS activation.1413machine # [ 65.368159] systemd[1]: Stopped target Reactivate sysinit units.1414machine # [ 65.370992] systemd[1]: Stopping Reactivate sysinit units...1415machine # [ 65.371874] systemd[1]: Reached target Reactivate sysinit units.1416machine # [ 65.373896] systemd[1]: Reached target Local File Systems.1417machine # [ 65.377401] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1418machine # [ 65.384747] systemd[1]: Starting Create SUID/SGID Wrappers...1419machine # [ 65.388359] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1420machine # [ 65.389662] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671421machine # [ 65.391772] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1422machine # [ 65.400144] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1423machine # [ 65.401454] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1424machine # [ 65.402632] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1425machine # [ 65.403876] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1426machine # [ 65.408906] systemd[1]: Reached target Remote File Systems.1427machine # [ 65.722122] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1428machine # [ 65.726708] systemd[1]: Finished Create SUID/SGID Wrappers.1429machine # [ 65.729843] systemd[1]: Starting linger-users.service...1430machine # [ 65.792615] systemd[1]: linger-users.service: Deactivated successfully.1431machine # [ 65.795233] systemd[1]: Finished linger-users.service.1432machine # [ 66.055712] nixos[2454]: finished switching to system configuration /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test1433machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.23 seconds)1434machine: must succeed: /nix/store/3jd67zljlvfr0iiw04bgs4ff4q04d4dv-separate-activation-script/bin/switch-to-configuration test 2>&11435machine # [ 66.676963] nixos[2594]: switching to system configuration /nix/store/8hl7kz9mgd7akdwijsswdjx7wn5hcf7f-nixos-system-machine-test1436machine # [ 66.680748] systemd[1]: Stopped target Local File Systems.1437machine # [ 66.681885] systemd[1]: Stopped target Remote File Systems.1438machine # [ 67.214224] systemd[1]: Reload requested from client PID 2594 ('.switch-to-conf') (unit backdoor.service)...1439machine # [ 67.216282] systemd[1]: Reloading...1440machine # [ 67.833189] systemd[1]: Reloading finished in 613 ms.1441machine # [ 67.992242] systemd[582]: Stopped Run user-specific NixOS activation.1442machine # [ 67.996318] systemd[582]: Reexecution requested from client PID 2663 ('switch-to-confi')...1443machine # [ 67.997683] systemd[582]: Reexecuting.1444machine # [ 68.045809] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1445machine # [ 68.237296] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1446machine # [ 68.244060] systemd[582]: Reload requested from client PID 2663 ('switch-to-confi')...1447machine # [ 68.246376] systemd[582]: Reloading...1448machine # [ 68.434261] systemd[582]: Reloading finished in 186 ms.1449machine # [ 68.448174] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1450machine # [ 68.459034] systemd[1]: Stopped target Reactivate sysinit units.1451machine # [ 68.461335] systemd[1]: Stopping Reactivate sysinit units...1452machine # [ 68.463529] systemd[1]: Reached target Reactivate sysinit units.1453machine # [ 68.465629] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1454machine # [ 68.466933] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1455machine # [ 68.469754] systemd[1]: Reached target Local File Systems.1456machine # [ 68.472532] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1457machine # [ 68.477291] systemd[1]: Starting Create SUID/SGID Wrappers...1458machine # [ 68.478161] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1459machine # [ 68.479375] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671460machine # [ 68.484173] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1461machine # [ 68.494848] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1462machine # [ 68.497537] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1463machine # [ 68.498733] systemd[1]: Reached target Remote File Systems.1464machine # [ 68.818749] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1465machine # [ 68.823683] systemd[1]: Finished Create SUID/SGID Wrappers.1466machine # [ 68.827530] systemd[1]: Starting linger-users.service...1467machine # [ 68.830923] systemd[1]: Starting test.service...1468machine # [ 68.873328] systemd[1]: Finished test.service.1469machine # [ 68.898644] systemd[1]: linger-users.service: Deactivated successfully.1470machine # [ 68.901653] systemd[1]: Finished linger-users.service.1471machine # [ 69.161019] nixos[2594]: finished switching to system configuration /nix/store/8hl7kz9mgd7akdwijsswdjx7wn5hcf7f-nixos-system-machine-test1472machine: (finished: must succeed: /nix/store/3jd67zljlvfr0iiw04bgs4ff4q04d4dv-separate-activation-script/bin/switch-to-configuration test 2>&1, in 3.10 seconds)1473machine: must succeed: ! test -e /run/current-system/activate1474machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.04 seconds)1475machine: must succeed: ! test -e /run/current-system/dry-activate1476machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.03 seconds)1477machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration1478machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.03 seconds)1479machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&11480machine # [ 69.868392] nixos[2742]: switching to system configuration /nix/store/adjmj1rnhc72wbw8w8n0wfv0r715rp45-nixos-system-machine-test1481machine # [ 69.872629] systemd[1]: Stopped target Local File Systems.1482machine # [ 69.875063] systemd[1]: Stopped target Remote File Systems.1483machine # [ 69.876151] systemd[1]: test.service: Deactivated successfully.1484machine # [ 69.877134] systemd[1]: Stopped test.service.1485machine # [ 70.394956] systemd[1]: Reload requested from client PID 2742 ('.switch-to-conf') (unit backdoor.service)...1486machine # [ 70.397279] systemd[1]: Reloading...1487machine # [ 71.080765] systemd[1]: Reloading finished in 681 ms.1488machine # [ 71.218599] systemd[582]: Reexecution requested from client PID 2811 ('switch-to-confi')...1489machine # [ 71.219984] systemd[582]: Reexecuting.1490machine # [ 71.282660] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1491machine # [ 71.474099] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1492machine # [ 71.481112] systemd[582]: Reload requested from client PID 2811 ('switch-to-confi')...1493machine # [ 71.483978] systemd[582]: Reloading...1494machine # [ 71.681122] systemd[582]: Reloading finished in 195 ms.1495machine # [ 71.696194] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1496machine # [ 71.707310] systemd[582]: Starting Run user-specific NixOS activation...1497machine # [ 71.754693] systemd[582]: Finished Run user-specific NixOS activation.1498machine # [ 71.759947] systemd[582]: Stopped Run user-specific NixOS activation.1499machine # [ 71.761726] systemd[582]: Stopping Run user-specific NixOS activation...1500machine # [ 71.764718] systemd[582]: Starting Run user-specific NixOS activation...1501machine # [ 71.772459] systemd[1]: Stopped target Reactivate sysinit units.1502machine # [ 71.773642] systemd[1]: Stopping Reactivate sysinit units...1503machine # [ 71.774449] systemd[1]: Reached target Reactivate sysinit units.1504machine # [ 71.775288] systemd[1]: Reached target Local File Systems.1505machine # [ 71.786263] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1506machine # [ 71.792353] systemd[1]: Starting Create SUID/SGID Wrappers...1507machine # [ 71.798032] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1508machine # [ 71.800568] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671509machine # [ 71.814013] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1510machine # [ 71.815672] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1511machine # [ 71.823484] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1512machine # [ 71.827855] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1513machine # [ 71.832636] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1514machine # [ 71.836186] systemd[1]: Reached target Remote File Systems.1515machine # [ 71.845409] systemd[582]: Finished Run user-specific NixOS activation.1516machine # [ 72.150177] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1517machine # [ 72.154787] systemd[1]: Finished Create SUID/SGID Wrappers.1518machine # [ 72.159242] systemd[1]: Starting linger-users.service...1519machine # [ 72.162768] systemd[1]: Started test.service.1520machine # [ 72.208824] systemd[1]: test.service: Deactivated successfully.1521machine # [ 72.240962] systemd[1]: linger-users.service: Deactivated successfully.1522machine # [ 72.243517] systemd[1]: Finished linger-users.service.1523machine # [ 72.501420] nixos[2742]: finished switching to system configuration /nix/store/adjmj1rnhc72wbw8w8n0wfv0r715rp45-nixos-system-machine-test1524machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 3.24 seconds)1525machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&11526machine # [ 73.144196] nixos[2887]: switching to system configuration /nix/store/b3z8frai1la3wx1x52y2x0cbb07d23py-nixos-system-machine-test1527machine # [ 73.147311] systemd[1]: Stopped target Local File Systems.1528machine # [ 73.148783] systemd[1]: Stopped target Remote File Systems.1529machine # [ 73.666130] systemd[1]: Reload requested from client PID 2887 ('.switch-to-conf') (unit backdoor.service)...1530machine # [ 73.668191] systemd[1]: Reloading...1531machine # [ 74.349858] systemd[1]: Reloading finished in 679 ms.1532machine # [ 74.501011] systemd[582]: Reexecution requested from client PID 2956 ('switch-to-confi')...1533machine # [ 74.504692] systemd[582]: Reexecuting.1534machine # [ 74.558211] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1535machine # [ 74.753855] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1536machine # [ 74.761406] systemd[582]: Reload requested from client PID 2956 ('switch-to-confi')...1537machine # [ 74.763908] systemd[582]: Reloading...1538machine # [ 74.963136] systemd[582]: Reloading finished in 198 ms.1539machine # [ 74.976173] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1540machine # [ 74.985125] systemd[582]: Stopped Run user-specific NixOS activation.1541machine # [ 74.987526] systemd[582]: Stopping Run user-specific NixOS activation...1542machine # [ 74.990453] systemd[582]: Starting Run user-specific NixOS activation...1543machine # [ 75.038643] systemd[582]: Finished Run user-specific NixOS activation.1544machine # [ 75.043141] systemd[1]: Stopped target Reactivate sysinit units.1545machine # [ 75.045642] systemd[1]: Stopping Reactivate sysinit units...1546machine # [ 75.046511] systemd[1]: Reached target Reactivate sysinit units.1547machine # [ 75.049349] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1548machine # [ 75.050724] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1549machine # [ 75.054464] systemd[1]: Reached target Local File Systems.1550machine # [ 75.056535] systemd[1]: Reached target Remote File Systems.1551machine # [ 75.059668] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1552machine # [ 75.067117] systemd[1]: Starting Create SUID/SGID Wrappers...1553machine # [ 75.068431] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1554machine # [ 75.073319] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671555machine # [ 75.076837] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1556machine # [ 75.078429] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1557machine # [ 75.079637] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1558machine # [ 75.405472] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1559machine # [ 75.410192] systemd[1]: Finished Create SUID/SGID Wrappers.1560machine # [ 75.414111] systemd[1]: Starting escaped\x2ddash.service...1561machine # [ 75.417478] systemd[1]: Starting linger-users.service...1562machine # [ 75.457853] systemd[1]: Finished escaped\x2ddash.service.1563machine # [ 75.487144] systemd[1]: linger-users.service: Deactivated successfully.1564machine # [ 75.490418] systemd[1]: Finished linger-users.service.1565machine # [ 75.748985] nixos[2887]: finished switching to system configuration /nix/store/b3z8frai1la3wx1x52y2x0cbb07d23py-nixos-system-machine-test1566machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 3.25 seconds)1567machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&11568machine # [ 76.413908] nixos[3029]: switching to system configuration /nix/store/rkylxpnbk83bcbzqzvqnv6ln95ryxha8-nixos-system-machine-test1569machine # [ 76.418060] systemd[1]: Stopped target Local File Systems.1570machine # [ 76.420061] systemd[1]: Stopped target Remote File Systems.1571machine # [ 76.420911] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1572machine # [ 76.421823] systemd[1]: Stopped escaped\x2ddash.service.1573machine # [ 76.976114] systemd[1]: Reload requested from client PID 3029 ('.switch-to-conf') (unit backdoor.service)...1574machine # [ 76.978162] systemd[1]: Reloading...1575machine # [ 77.667504] systemd[1]: Reloading finished in 686 ms.1576machine # [ 77.813113] systemd[582]: Reexecution requested from client PID 3098 ('switch-to-confi')...1577machine # [ 77.816884] systemd[582]: Reexecuting.1578machine # [ 77.870008] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1579machine # [ 78.070545] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1580machine # [ 78.077297] systemd[582]: Reload requested from client PID 3098 ('switch-to-confi')...1581machine # [ 78.079760] systemd[582]: Reloading...1582machine # [ 78.286591] systemd[582]: Reloading finished in 205 ms.1583machine # [ 78.304217] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1584machine # [ 78.314912] systemd[582]: Stopped Run user-specific NixOS activation.1585machine # [ 78.316202] systemd[582]: Stopping Run user-specific NixOS activation...1586machine # [ 78.319340] systemd[582]: Starting Run user-specific NixOS activation...1587machine # [ 78.368495] systemd[582]: Finished Run user-specific NixOS activation.1588machine # [ 78.372758] systemd[1]: Stopped target Reactivate sysinit units.1589machine # [ 78.375959] systemd[1]: Stopping Reactivate sysinit units...1590machine # [ 78.377464] systemd[1]: Reached target Reactivate sysinit units.1591machine # [ 78.384088] systemd[1]: Starting escaped\x2ddash.service...1592machine # [ 78.386251] systemd[1]: Reached target Remote File Systems.1593machine # [ 78.389593] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1594machine # [ 78.391794] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1595machine # [ 78.402147] systemd[1]: Starting linger-users.service...1596machine # [ 78.405456] systemd[1]: Reached target Local File Systems.1597machine # [ 78.418905] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1598machine # [ 78.426395] systemd[1]: Starting Create SUID/SGID Wrappers...1599machine # [ 78.427517] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1600machine # [ 78.432563] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671601machine # [ 78.434715] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1602machine # [ 78.440766] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1603machine # [ 78.446528] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1604machine # [ 78.469086] systemd[1]: Finished escaped\x2ddash.service.1605machine # [ 78.515308] systemd[1]: linger-users.service: Deactivated successfully.1606machine # [ 78.518341] systemd[1]: Finished linger-users.service.1607machine # [ 78.842342] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1608machine # [ 78.845977] systemd[1]: Finished Create SUID/SGID Wrappers.1609machine # [ 79.103127] nixos[3029]: finished switching to system configuration /nix/store/rkylxpnbk83bcbzqzvqnv6ln95ryxha8-nixos-system-machine-test1610machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 3.36 seconds)1611machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&11612machine # [ 79.778700] nixos[3171]: switching to system configuration /nix/store/is5s1b9zw6jw64c13nim34nivkmqzdr1-nixos-system-machine-test1613machine # [ 79.782497] systemd[1]: Stopped target Local File Systems.1614machine # [ 79.784386] systemd[1]: Stopped target Remote File Systems.1615machine # [ 79.785201] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1616machine # [ 79.786086] systemd[1]: Stopped escaped\x2ddash.service.1617machine # [ 80.273744] systemd[1]: Reload requested from client PID 3171 ('.switch-to-conf') (unit backdoor.service)...1618machine # [ 80.275728] systemd[1]: Reloading...1619machine # [ 80.960778] systemd[1]: Reloading finished in 682 ms.1620machine # [ 81.103304] systemd[582]: Reexecution requested from client PID 3240 ('switch-to-confi')...1621machine # [ 81.107670] systemd[582]: Reexecuting.1622machine # [ 81.175586] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1623machine # [ 81.376796] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1624machine # [ 81.384602] systemd[582]: Reload requested from client PID 3240 ('switch-to-confi')...1625machine # [ 81.387366] systemd[582]: Reloading...1626machine # [ 81.580828] systemd[582]: Reloading finished in 192 ms.1627machine # [ 81.596198] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1628machine # [ 81.605951] systemd[582]: Stopped Run user-specific NixOS activation.1629machine # [ 81.608580] systemd[582]: Stopping Run user-specific NixOS activation...1630machine # [ 81.611872] systemd[582]: Starting Run user-specific NixOS activation...1631machine # [ 81.662970] systemd[582]: Finished Run user-specific NixOS activation.1632machine # [ 81.667990] systemd[1]: Stopped target Reactivate sysinit units.1633machine # [ 81.670416] systemd[1]: Stopping Reactivate sysinit units...1634machine # [ 81.671235] systemd[1]: Reached target Reactivate sysinit units.1635machine # [ 81.676854] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1636machine # [ 81.682153] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1637machine # [ 81.683990] systemd[1]: Reached target Remote File Systems.1638machine # [ 81.688144] systemd[1]: Starting -.service...1639machine # [ 81.692126] systemd[1]: Starting linger-users.service...1640machine # [ 81.707759] systemd[1]: Reached target Local File Systems.1641machine # [ 81.709390] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1642machine # [ 81.719310] systemd[1]: Starting Create SUID/SGID Wrappers...1643machine # [ 81.723280] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1644machine # [ 81.728449] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671645machine # [ 81.730660] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1646machine # [ 81.737153] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1647machine # [ 81.739229] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1648machine # [ 81.778452] systemd[1]: Finished -.service.1649machine # [ 81.819049] systemd[1]: linger-users.service: Deactivated successfully.1650machine # [ 81.822744] systemd[1]: Finished linger-users.service.1651machine # [ 82.099022] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1652machine # [ 82.101083] systemd[1]: Finished Create SUID/SGID Wrappers.1653machine # [ 82.361822] nixos[3171]: finished switching to system configuration /nix/store/is5s1b9zw6jw64c13nim34nivkmqzdr1-nixos-system-machine-test1654machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 3.26 seconds)1655machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&11656machine # [ 83.031653] nixos[3313]: switching to system configuration /nix/store/2a9myq0cd1pq4n9w9azaaf640x0alazm-nixos-system-machine-test1657machine # [ 83.035407] systemd[1]: Stopped target Local File Systems.1658machine # [ 83.036943] systemd[1]: Stopped target Remote File Systems.1659machine # [ 83.581679] systemd[1]: Reload requested from client PID 3313 ('.switch-to-conf') (unit backdoor.service)...1660machine # [ 83.583634] systemd[1]: Reloading...1661machine # [ 84.247326] systemd[1]: Reloading finished in 661 ms.1662machine # [ 84.395338] systemd[582]: Reexecution requested from client PID 3382 ('switch-to-confi')...1663machine # [ 84.399043] systemd[582]: Reexecuting.1664machine # [ 84.453929] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1665machine # [ 84.650093] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1666machine # [ 84.657080] systemd[582]: Reload requested from client PID 3382 ('switch-to-confi')...1667machine # [ 84.659847] systemd[582]: Reloading...1668machine # [ 84.852697] systemd[582]: Reloading finished in 191 ms.1669machine # [ 84.868178] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1670machine # [ 84.878665] systemd[582]: Stopped Run user-specific NixOS activation.1671machine # [ 84.879727] systemd[582]: Stopping Run user-specific NixOS activation...1672machine # [ 84.882646] systemd[582]: Starting Run user-specific NixOS activation...1673machine # [ 84.931870] systemd[582]: Finished Run user-specific NixOS activation.1674machine # [ 84.936702] systemd[1]: Stopped target Reactivate sysinit units.1675machine # [ 84.937690] systemd[1]: Stopping Reactivate sysinit units...1676machine # [ 84.938458] systemd[1]: Reached target Reactivate sysinit units.1677machine # [ 84.944305] systemd[1]: Reloading -.service...1678machine # [ 84.981340] systemd[1]: Reloaded -.service.1679machine # [ 84.984084] systemd[1]: Reached target Local File Systems.1680machine # [ 84.987688] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1681machine # [ 84.992614] systemd[1]: Starting Create SUID/SGID Wrappers...1682machine # [ 84.993520] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1683machine # [ 84.994741] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671684machine # [ 85.012229] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1685machine # [ 85.013897] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1686machine # [ 85.015128] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1687machine # [ 85.016596] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1688machine # [ 85.017843] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1689machine # [ 85.019106] systemd[1]: Reached target Remote File Systems.1690machine # [ 85.337744] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1691machine # [ 85.342563] systemd[1]: Finished Create SUID/SGID Wrappers.1692machine # [ 85.345213] systemd[1]: Starting linger-users.service...1693machine # [ 85.410051] systemd[1]: linger-users.service: Deactivated successfully.1694machine # [ 85.412961] systemd[1]: Finished linger-users.service.1695machine # [ 85.670724] nixos[3313]: finished switching to system configuration /nix/store/2a9myq0cd1pq4n9w9azaaf640x0alazm-nixos-system-machine-test1696machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 3.31 seconds)1697machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&11698machine # [ 86.290519] nixos[3455]: switching to system configuration /nix/store/3x85aqg6f79rgnlx3vq28vik3v5a10dl-nixos-system-machine-test1699machine # [ 86.293256] systemd[1]: Stopped target Remote File Systems.1700machine # [ 86.295781] systemd[1]: -.service: Deactivated successfully.1701machine # [ 86.297710] systemd[1]: Stopped -.service.1702machine # [ 86.298503] systemd[1]: Stopped target Local File Systems.1703machine # [ 86.826308] systemd[1]: Reload requested from client PID 3455 ('.switch-to-conf') (unit backdoor.service)...1704machine # [ 86.828481] systemd[1]: Reloading...1705machine # [ 87.509681] systemd[1]: Reloading finished in 679 ms.1706machine # [ 87.660507] systemd[582]: Reexecution requested from client PID 3524 ('switch-to-confi')...1707machine # [ 87.664971] systemd[582]: Reexecuting.1708machine # [ 87.706389] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1709machine # [ 87.900450] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1710machine # [ 87.907089] systemd[582]: Reload requested from client PID 3524 ('switch-to-confi')...1711machine # [ 87.909809] systemd[582]: Reloading...1712machine # [ 88.110156] systemd[582]: Reloading finished in 199 ms.1713machine # [ 88.124225] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1714machine # [ 88.135748] systemd[582]: Stopped Run user-specific NixOS activation.1715machine # [ 88.136880] systemd[582]: Stopping Run user-specific NixOS activation...1716machine # [ 88.139871] systemd[582]: Starting Run user-specific NixOS activation...1717machine # [ 88.188896] systemd[582]: Finished Run user-specific NixOS activation.1718machine # [ 88.193538] systemd[1]: Stopped target Reactivate sysinit units.1719machine # [ 88.194452] systemd[1]: Stopping Reactivate sysinit units...1720machine # [ 88.195219] systemd[1]: Reached target Reactivate sysinit units.1721machine # [ 88.199725] systemd[1]: Reached target Remote File Systems.1722machine # [ 88.205997] systemd[1]: Starting linger-users.service...1723machine # [ 88.210091] systemd[1]: Starting required-service.service...1724machine # [ 88.216581] systemd[1]: Starting test-service.service...1725machine # [ 88.224813] systemd[1]: Reached target Local File Systems.1726machine # [ 88.226166] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1727machine # [ 88.235566] systemd[1]: Starting Create SUID/SGID Wrappers...1728machine # [ 88.243709] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1729machine # [ 88.251965] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671730machine # [ 88.260498] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1731machine # [ 88.263621] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1732machine # [ 88.268265] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1733machine # [ 88.270660] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1734machine # [ 88.274236] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1735machine # [ 88.306340] systemd[1]: Finished required-service.service.1736machine # [ 88.314696] systemd[1]: Finished test-service.service.1737machine # [ 88.348157] systemd[1]: linger-users.service: Deactivated successfully.1738machine # [ 88.349800] systemd[1]: Finished linger-users.service.1739machine # [ 88.627531] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1740machine # [ 88.630240] systemd[1]: Finished Create SUID/SGID Wrappers.1741machine # [ 88.890632] nixos[3455]: finished switching to system configuration /nix/store/3x85aqg6f79rgnlx3vq28vik3v5a10dl-nixos-system-machine-test1742machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 3.22 seconds)1743machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&11744machine # [ 89.532607] nixos[3599]: switching to system configuration /nix/store/dyy3v0iyn9hg7j8fy16lfhh0n6mnnwr0-nixos-system-machine-test1745machine # [ 89.536757] systemd[1]: Stopped target Local File Systems.1746machine # [ 89.538809] systemd[1]: Stopped target Remote File Systems.1747machine # [ 89.539651] systemd[1]: required-service.service: Deactivated successfully.1748machine # [ 89.541454] systemd[1]: Stopped required-service.service.1749machine # [ 89.542345] systemd[1]: test-service.service: Deactivated successfully.1750machine # [ 89.543491] systemd[1]: Stopped test-service.service.1751machine # [ 90.062139] systemd[1]: Reload requested from client PID 3599 ('.switch-to-conf') (unit backdoor.service)...1752machine # [ 90.064209] systemd[1]: Reloading...1753machine # [ 90.733010] systemd[1]: Reloading finished in 666 ms.1754machine # [ 90.880429] systemd[582]: Reexecution requested from client PID 3668 ('switch-to-confi')...1755machine # [ 90.883280] systemd[582]: Reexecuting.1756machine # [ 90.945881] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1757machine # [ 91.151173] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1758machine # [ 91.157937] systemd[582]: Reload requested from client PID 3668 ('switch-to-confi')...1759machine # [ 91.160466] systemd[582]: Reloading...1760machine # [ 91.365193] systemd[582]: Reloading finished in 203 ms.1761machine # [ 91.380197] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1762machine # [ 91.390938] systemd[582]: Stopped Run user-specific NixOS activation.1763machine # [ 91.393380] systemd[582]: Stopping Run user-specific NixOS activation...1764machine # [ 91.396472] systemd[582]: Starting Run user-specific NixOS activation...1765machine # [ 91.443025] systemd[582]: Finished Run user-specific NixOS activation.1766machine # [ 91.447166] systemd[1]: Stopped target Reactivate sysinit units.1767machine # [ 91.449310] systemd[1]: Stopping Reactivate sysinit units...1768machine # [ 91.450643] systemd[1]: Reached target Reactivate sysinit units.1769machine # [ 91.457622] systemd[1]: Reached target Local File Systems.1770machine # [ 91.460478] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1771machine # [ 91.465557] systemd[1]: Starting Create SUID/SGID Wrappers...1772machine # [ 91.466478] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1773machine # [ 91.467727] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671774machine # [ 91.471487] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1775machine # [ 91.478800] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1776machine # [ 91.483675] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1777machine # [ 91.489462] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1778machine # [ 91.490741] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1779machine # [ 91.494770] systemd[1]: Reached target Remote File Systems.1780machine # [ 91.852213] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1781machine # [ 91.856729] systemd[1]: Finished Create SUID/SGID Wrappers.1782machine # [ 91.862822] systemd[1]: Starting linger-users.service...1783machine # [ 91.867070] systemd[1]: Starting required-service.service...1784machine # [ 91.872256] systemd[1]: Starting test-service.service...1785machine # [ 91.926750] systemd[1]: Finished required-service.service.1786machine # [ 91.930920] systemd[1]: Finished test-service.service.1787machine # [ 91.959534] systemd[1]: linger-users.service: Deactivated successfully.1788machine # [ 91.962336] systemd[1]: Finished linger-users.service.1789machine # [ 92.219085] nixos[3599]: finished switching to system configuration /nix/store/dyy3v0iyn9hg7j8fy16lfhh0n6mnnwr0-nixos-system-machine-test1790machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 3.33 seconds)1791machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&11792machine # [ 92.909969] nixos[3743]: switching to system configuration /nix/store/yf94nz93l4216y7vmllrwc85p88px1m4-nixos-system-machine-test1793machine # [ 92.914426] systemd[1]: Stopped target Local File Systems.1794machine # [ 92.916712] systemd[1]: Stopped target Remote File Systems.1795machine # [ 92.917590] systemd[1]: required-service.service: Deactivated successfully.1796machine # [ 92.918525] systemd[1]: Stopped required-service.service.1797machine # [ 92.919269] systemd[1]: test-service.service: Deactivated successfully.1798machine # [ 92.921062] systemd[1]: Stopped test-service.service.1799machine # [ 93.432208] systemd[1]: Reload requested from client PID 3743 ('.switch-to-conf') (unit backdoor.service)...1800machine # [ 93.434189] systemd[1]: Reloading...1801machine # [ 94.132461] systemd[1]: Reloading finished in 695 ms.1802machine # [ 94.282623] systemd[582]: Reexecution requested from client PID 3812 ('switch-to-confi')...1803machine # [ 94.286438] systemd[582]: Reexecuting.1804machine # [ 94.341937] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1805machine # [ 94.546159] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1806machine # [ 94.552937] systemd[582]: Reload requested from client PID 3812 ('switch-to-confi')...1807machine # [ 94.555405] systemd[582]: Reloading...1808machine # [ 94.749131] systemd[582]: Reloading finished in 192 ms.1809machine # [ 94.760176] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1810machine # [ 94.770062] systemd[582]: Stopped Run user-specific NixOS activation.1811machine # [ 94.772482] systemd[582]: Stopping Run user-specific NixOS activation...1812machine # [ 94.775438] systemd[582]: Starting Run user-specific NixOS activation...1813machine # [ 94.824100] systemd[582]: Finished Run user-specific NixOS activation.1814machine # [ 94.828423] systemd[1]: Stopped target Reactivate sysinit units.1815machine # [ 94.831492] systemd[1]: Stopping Reactivate sysinit units...1816machine # [ 94.833787] systemd[1]: Reached target Reactivate sysinit units.1817machine # [ 94.834693] systemd[1]: Reached target Remote File Systems.1818machine # [ 94.835447] systemd[1]: Reached target Local File Systems.1819machine # [ 94.841321] systemd[1]: Starting required-service.service...1820machine # [ 94.851387] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1821machine # [ 94.857585] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1822machine # [ 94.858832] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1823machine # [ 94.863780] systemd[1]: Starting Create SUID/SGID Wrappers...1824machine # [ 94.867344] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1825machine # [ 94.870726] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671826machine # [ 94.876358] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1827machine # [ 94.878982] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1828machine # [ 94.883369] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1829machine # [ 94.902078] systemd[1]: Finished required-service.service.1830machine # [ 95.211257] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1831machine # [ 95.215819] systemd[1]: Finished Create SUID/SGID Wrappers.1832machine # [ 95.220363] systemd[1]: Starting linger-users.service...1833machine # [ 95.223057] systemd[1]: Starting test-service.service...1834machine # [ 95.271310] systemd[1]: Finished test-service.service.1835machine # [ 95.298348] systemd[1]: linger-users.service: Deactivated successfully.1836machine # [ 95.301555] systemd[1]: Finished linger-users.service.1837machine # [ 95.558479] nixos[3743]: finished switching to system configuration /nix/store/yf94nz93l4216y7vmllrwc85p88px1m4-nixos-system-machine-test1838machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 3.34 seconds)1839machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&11840machine # [ 96.216558] nixos[3887]: switching to system configuration /nix/store/f0q97bn9laf2gqf1hrig7p5p10kvz7by-nixos-system-machine-test1841machine # [ 96.219267] systemd[1]: test-service.service: Deactivated successfully.1842machine # [ 96.222108] systemd[1]: Stopped test-service.service.1843machine # [ 96.222896] systemd[1]: Stopped target Local File Systems.1844machine # [ 96.224623] systemd[1]: required-service.service: Deactivated successfully.1845machine # [ 96.225614] systemd[1]: Stopped required-service.service.1846machine # [ 96.227520] systemd[1]: Stopped target Remote File Systems.1847machine # [ 96.774667] systemd[1]: Reload requested from client PID 3887 ('.switch-to-conf') (unit backdoor.service)...1848machine # [ 96.776798] systemd[1]: Reloading...1849machine # [ 97.491879] systemd[1]: Reloading finished in 712 ms.1850machine # [ 97.640407] systemd[582]: Reexecution requested from client PID 3956 ('switch-to-confi')...1851machine # [ 97.644208] systemd[582]: Reexecuting.1852machine # [ 97.714522] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1853machine # [ 97.929719] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1854machine # [ 97.936683] systemd[582]: Reload requested from client PID 3956 ('switch-to-confi')...1855machine # [ 97.939300] systemd[582]: Reloading...1856machine # [ 98.148292] systemd[582]: Reloading finished in 207 ms.1857machine # [ 98.164261] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1858machine # [ 98.175147] systemd[582]: Stopped Run user-specific NixOS activation.1859machine # [ 98.177613] systemd[582]: Stopping Run user-specific NixOS activation...1860machine # [ 98.180708] systemd[582]: Starting Run user-specific NixOS activation...1861machine # [ 98.230916] systemd[582]: Finished Run user-specific NixOS activation.1862machine # [ 98.235066] systemd[1]: Stopped target Reactivate sysinit units.1863machine # [ 98.237636] systemd[1]: Stopping Reactivate sysinit units...1864machine # [ 98.240631] systemd[1]: Reached target Reactivate sysinit units.1865machine # [ 98.241847] systemd[1]: Reached target Local File Systems.1866machine # [ 98.245613] systemd[1]: Created slice Slice /system/instantiated.1867machine # [ 98.248344] systemd[1]: Reached target Remote File Systems.1868machine # [ 98.255216] systemd[1]: Starting instantiated@one.service...1869machine # [ 98.260137] systemd[1]: Starting instantiated@two.service...1870machine # [ 98.266281] systemd[1]: Starting linger-users.service...1871machine # [ 98.269286] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1872machine # [ 98.282417] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1873machine # [ 98.289739] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1874machine # [ 98.295166] systemd[1]: Starting Create SUID/SGID Wrappers...1875machine # [ 98.302805] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1876machine # [ 98.308482] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671877machine # [ 98.317408] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1878machine # [ 98.321992] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1879machine # [ 98.324580] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1880machine # [ 98.357405] systemd[1]: Finished instantiated@one.service.1881machine # [ 98.361060] systemd[1]: Finished instantiated@two.service.1882machine # [ 98.405469] systemd[1]: linger-users.service: Deactivated successfully.1883machine # [ 98.409413] systemd[1]: Finished linger-users.service.1884machine # [ 98.713989] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1885machine # [ 98.717621] systemd[1]: Finished Create SUID/SGID Wrappers.1886machine # [ 98.976865] nixos[3887]: finished switching to system configuration /nix/store/f0q97bn9laf2gqf1hrig7p5p10kvz7by-nixos-system-machine-test1887machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 3.42 seconds)1888machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&11889machine # [ 99.664560] nixos[4031]: switching to system configuration /nix/store/fkilk422n94glhjsmxbkskay1y8rm8pv-nixos-system-machine-test1890machine # [ 99.667068] systemd[1]: Stopped target Local File Systems.1891machine # [ 99.669886] systemd[1]: instantiated@two.service: Deactivated successfully.1892machine # [ 99.670927] systemd[1]: Stopped instantiated@two.service.1893machine # [ 99.672802] systemd[1]: instantiated@one.service: Deactivated successfully.1894machine # [ 99.673806] systemd[1]: Stopped instantiated@one.service.1895machine # [ 99.676136] systemd[1]: Stopped target Remote File Systems.1896machine # [ 100.207266] systemd[1]: Reload requested from client PID 4031 ('.switch-to-conf') (unit backdoor.service)...1897machine # [ 100.209517] systemd[1]: Reloading...1898machine # [ 100.875710] systemd[1]: Reloading finished in 664 ms.1899machine # [ 101.020405] systemd[582]: Reexecution requested from client PID 4100 ('switch-to-confi')...1900machine # [ 101.024098] systemd[582]: Reexecuting.1901machine # [ 101.069468] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1902machine # [ 101.260835] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1903machine # [ 101.267432] systemd[582]: Reload requested from client PID 4100 ('switch-to-confi')...1904machine # [ 101.271345] systemd[582]: Reloading...1905machine # [ 101.465115] systemd[582]: Reloading finished in 195 ms.1906machine # [ 101.480190] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1907machine # [ 101.490814] systemd[582]: Stopped Run user-specific NixOS activation.1908machine # [ 101.491842] systemd[582]: Stopping Run user-specific NixOS activation...1909machine # [ 101.494942] systemd[582]: Starting Run user-specific NixOS activation...1910machine # [ 101.542417] systemd[582]: Finished Run user-specific NixOS activation.1911machine # [ 101.546872] systemd[1]: Stopped target Reactivate sysinit units.1912machine # [ 101.549766] systemd[1]: Stopping Reactivate sysinit units...1913machine # [ 101.551116] systemd[1]: Reached target Reactivate sysinit units.1914machine # [ 101.553793] systemd[1]: Reached target Local File Systems.1915machine # [ 101.555399] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1916machine # [ 101.557618] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1917machine # [ 101.561462] systemd[1]: Reached target Remote File Systems.1918machine # [ 101.567855] systemd[1]: Starting instantiated@one.service...1919machine # [ 101.571652] systemd[1]: Starting instantiated@two.service...1920machine # [ 101.576578] systemd[1]: Starting linger-users.service...1921machine # [ 101.594455] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1922machine # [ 101.599685] systemd[1]: Starting Create SUID/SGID Wrappers...1923machine # [ 101.604368] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1924machine # [ 101.605660] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671925machine # [ 101.607759] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1926machine # [ 101.619475] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1927machine # [ 101.623202] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1928machine # [ 101.661709] systemd[1]: Finished instantiated@two.service.1929machine # [ 101.669617] systemd[1]: Finished instantiated@one.service.1930machine # [ 101.706716] systemd[1]: linger-users.service: Deactivated successfully.1931machine # [ 101.709393] systemd[1]: Finished linger-users.service.1932machine # [ 101.999069] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1933machine # [ 102.001781] systemd[1]: Finished Create SUID/SGID Wrappers.1934machine # [ 102.257617] nixos[4031]: finished switching to system configuration /nix/store/fkilk422n94glhjsmxbkskay1y8rm8pv-nixos-system-machine-test1935machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 3.28 seconds)1936(finished: subtest: services, in 73.47 seconds)1937subtest: failing units1938machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11939machine # [ 102.886880] nixos[4175]: switching to system configuration /nix/store/lcf7dm3ckw9spkrc3mhap5fm30ib8r0g-nixos-system-machine-test1940machine # [ 102.891624] systemd[1]: Stopped target Local File Systems.1941machine # [ 102.894659] systemd[1]: Stopped target Remote File Systems.1942machine # [ 102.895808] systemd[1]: instantiated@one.service: Deactivated successfully.1943machine # [ 102.897145] systemd[1]: Stopped instantiated@one.service.1944machine # [ 102.898431] systemd[1]: instantiated@two.service: Deactivated successfully.1945machine # [ 102.899752] systemd[1]: Stopped instantiated@two.service.1946machine # [ 103.362640] systemd[1]: Reload requested from client PID 4175 ('.switch-to-conf') (unit backdoor.service)...1947machine # [ 103.364728] systemd[1]: Reloading...1948machine # [ 104.009932] systemd[1]: Reloading finished in 642 ms.1949machine # [ 104.161357] systemd[582]: Reexecution requested from client PID 4244 ('switch-to-confi')...1950machine # [ 104.165020] systemd[582]: Reexecuting.1951machine # [ 104.222019] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1952machine # [ 104.417614] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1953machine # [ 104.425238] systemd[582]: Reload requested from client PID 4244 ('switch-to-confi')...1954machine # [ 104.427920] systemd[582]: Reloading...1955machine # [ 104.622813] systemd[582]: Reloading finished in 193 ms.1956machine # [ 104.636175] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1957machine # [ 104.645816] systemd[582]: Stopped Run user-specific NixOS activation.1958machine # [ 104.648127] systemd[582]: Stopping Run user-specific NixOS activation...1959machine # [ 104.651230] systemd[582]: Starting Run user-specific NixOS activation...1960machine # [ 104.698262] systemd[582]: Finished Run user-specific NixOS activation.1961machine # [ 104.702421] systemd[1]: Stopped target Reactivate sysinit units.1962machine # [ 104.705739] systemd[1]: Stopping Reactivate sysinit units...1963machine # [ 104.708386] systemd[1]: Reached target Reactivate sysinit units.1964machine # [ 104.709288] systemd[1]: Reached target Remote File Systems.1965machine # [ 104.711445] systemd[1]: Reached target Local File Systems.1966machine # [ 104.714867] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1967machine # [ 104.719246] systemd[1]: Starting Create SUID/SGID Wrappers...1968machine # [ 104.722751] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1969machine # [ 104.728332] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671970machine # [ 104.730563] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1971machine # [ 104.736887] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1972machine # [ 104.741844] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1973machine # [ 104.743066] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1974machine # [ 104.744408] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1975machine # [ 105.061520] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1976machine # [ 105.066228] systemd[1]: Finished Create SUID/SGID Wrappers.1977machine # [ 105.069941] systemd[1]: Starting linger-users.service...1978machine # [ 105.073211] systemd[1]: Starting test.service...1979machine # [ 105.119985] systemd[1]: Finished test.service.1980machine # [ 105.147598] systemd[1]: linger-users.service: Deactivated successfully.1981machine # [ 105.150149] systemd[1]: Finished linger-users.service.1982machine # [ 105.408930] nixos[4175]: finished switching to system configuration /nix/store/lcf7dm3ckw9spkrc3mhap5fm30ib8r0g-nixos-system-machine-test1983machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 3.15 seconds)1984machine: must fail: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&11985machine # [ 106.024255] nixos[4317]: switching to system configuration /nix/store/721zd7376q1f026k0xalpawgbbc2mms1-nixos-system-machine-test1986machine # [ 106.026835] systemd[1]: Stopped target Remote File Systems.1987machine # [ 106.029859] systemd[1]: Stopped target Local File Systems.1988machine # [ 106.030722] systemd[1]: test.service: Deactivated successfully.1989machine # [ 106.031541] systemd[1]: Stopped test.service.1990machine # [ 106.541315] systemd[1]: Reload requested from client PID 4317 ('.switch-to-conf') (unit backdoor.service)...1991machine # [ 106.543325] systemd[1]: Reloading...1992machine # [ 107.229597] systemd[1]: Reloading finished in 681 ms.1993machine # [ 107.387444] systemd[582]: Reexecution requested from client PID 4386 ('switch-to-confi')...1994machine # [ 107.391185] systemd[582]: Reexecuting.1995machine # [ 107.446164] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1996machine # [ 107.643277] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1997machine # [ 107.650975] systemd[582]: Reload requested from client PID 4386 ('switch-to-confi')...1998machine # [ 107.652826] systemd[582]: Reloading...1999machine # [ 107.855010] systemd[582]: Reloading finished in 201 ms.2000machine # [ 107.868190] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2001machine # [ 107.879801] systemd[582]: Stopped Run user-specific NixOS activation.2002machine # [ 107.880991] systemd[582]: Stopping Run user-specific NixOS activation...2003machine # [ 107.884105] systemd[582]: Starting Run user-specific NixOS activation...2004machine # [ 107.931679] systemd[582]: Finished Run user-specific NixOS activation.2005machine # [ 107.936497] systemd[1]: Stopped target Reactivate sysinit units.2006machine # [ 107.937472] systemd[1]: Stopping Reactivate sysinit units...2007machine # [ 107.940001] systemd[1]: Reached target Reactivate sysinit units.2008machine # [ 107.943043] systemd[1]: Reached target Local File Systems.2009machine # [ 107.946624] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2010machine # [ 107.949487] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2011machine # [ 107.950843] systemd[1]: Reached target Remote File Systems.2012machine # [ 107.957342] systemd[1]: Starting test.service...2013machine # [ 107.967925] systemd[1]: Starting linger-users.service...2014machine # [ 107.977857] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2015machine # [ 107.986402] systemd[1]: Starting Create SUID/SGID Wrappers...2016machine # [ 107.987382] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2017machine # [ 107.991957] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672018machine # [ 107.997211] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2019machine # [ 108.003981] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2020machine # [ 108.009086] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2021machine # [ 108.040067] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE2022machine # [ 108.041473] systemd[1]: test.service: Failed with result 'exit-code'.2023machine # [ 108.042645] systemd[1]: Failed to start test.service.2024machine # [ 108.080914] systemd[1]: linger-users.service: Deactivated successfully.2025machine # [ 108.083370] systemd[1]: Finished linger-users.service.2026machine # [ 108.374337] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2027machine # [ 108.377200] systemd[1]: Finished Create SUID/SGID Wrappers.2028machine # [ 108.700520] nixos[4317]: switching to system configuration /nix/store/721zd7376q1f026k0xalpawgbbc2mms1-nixos-system-machine-test failed (status 4)2029machine: (finished: must fail: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 3.29 seconds)2030machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12031machine # [ 109.345873] nixos[4460]: switching to system configuration /nix/store/hl0ph1plwnhmqirm8jyfsbcbxrlsy3fh-nixos-system-machine-test2032machine # [ 109.349586] systemd[1]: Stopped target Local File Systems.2033machine # [ 109.351063] systemd[1]: Stopped target Remote File Systems.2034machine # [ 109.870429] systemd[1]: Reload requested from client PID 4460 ('.switch-to-conf') (unit backdoor.service)...2035machine # [ 109.872522] systemd[1]: Reloading...2036machine # [ 110.522822] systemd[1]: Reloading finished in 647 ms.2037machine # [ 110.674651] systemd[582]: Reexecution requested from client PID 4529 ('switch-to-confi')...2038machine # [ 110.676773] systemd[582]: Reexecuting.2039machine # [ 110.742529] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2040machine # [ 110.936678] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2041machine # [ 110.943656] systemd[582]: Reload requested from client PID 4529 ('switch-to-confi')...2042machine # [ 110.946847] systemd[582]: Reloading...2043machine # [ 111.138972] systemd[582]: Reloading finished in 193 ms.2044machine # [ 111.156176] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2045machine # [ 111.165991] systemd[582]: Stopped Run user-specific NixOS activation.2046machine # [ 111.168370] systemd[582]: Stopping Run user-specific NixOS activation...2047machine # [ 111.171204] systemd[582]: Starting Run user-specific NixOS activation...2048machine # [ 111.218280] systemd[582]: Finished Run user-specific NixOS activation.2049machine # [ 111.222616] systemd[1]: Stopped target Reactivate sysinit units.2050machine # [ 111.225559] systemd[1]: Stopping Reactivate sysinit units...2051machine # [ 111.226418] systemd[1]: Reached target Reactivate sysinit units.2052machine # [ 111.227234] systemd[1]: Reached target Local File Systems.2053machine # [ 111.232533] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2054machine # [ 111.235843] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2055machine # [ 111.240530] systemd[1]: Reached target Remote File Systems.2056machine # [ 111.245929] systemd[1]: Started autorestart.service.2057machine # [ 111.248758] systemd[1]: Starting linger-users.service...2058machine # [ 111.261526] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2059machine # [ 111.266642] systemd[1]: Starting Create SUID/SGID Wrappers...2060machine # [ 111.269600] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2061machine # [ 111.272067] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672062machine # [ 111.274504] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2063machine # [ 111.281170] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2064machine # [ 111.282394] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2065machine # [ 111.316994] systemd[1]: autorestart.service: Deactivated successfully.2066machine # [ 111.353061] systemd[1]: linger-users.service: Deactivated successfully.2067machine # [ 111.356951] systemd[1]: Finished linger-users.service.2068machine # [ 111.636937] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2069machine # [ 111.640489] systemd[1]: Finished Create SUID/SGID Wrappers.2070machine # [ 111.900720] nixos[4460]: finished switching to system configuration /nix/store/hl0ph1plwnhmqirm8jyfsbcbxrlsy3fh-nixos-system-machine-test2071machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 3.20 seconds)2072machine # [ 111.982908] systemd[1]: Stopped autorestart.service.2073machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12074machine # [ 112.563420] nixos[4607]: switching to system configuration /nix/store/hl0ph1plwnhmqirm8jyfsbcbxrlsy3fh-nixos-system-machine-test2075machine # [ 112.566660] systemd[1]: Stopped target Local File Systems.2076machine # [ 112.568612] systemd[1]: Stopped target Remote File Systems.2077machine # [ 113.023278] systemd[1]: Reload requested from client PID 4607 ('.switch-to-conf') (unit backdoor.service)...2078machine # [ 113.025314] systemd[1]: Reloading...2079machine # [ 113.629345] systemd[1]: Reloading finished in 601 ms.2080machine # [ 113.776440] systemd[582]: Reexecution requested from client PID 4676 ('switch-to-confi')...2081machine # [ 113.779689] systemd[582]: Reexecuting.2082machine # [ 113.842161] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2083machine # [ 114.038820] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2084machine # [ 114.045936] systemd[582]: Reload requested from client PID 4676 ('switch-to-confi')...2085machine # [ 114.048205] systemd[582]: Reloading...2086machine # [ 114.238053] systemd[582]: Reloading finished in 187 ms.2087machine # [ 114.252152] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2088machine # [ 114.260827] systemd[582]: Stopped Run user-specific NixOS activation.2089machine # [ 114.263089] systemd[582]: Stopping Run user-specific NixOS activation...2090machine # [ 114.265867] systemd[582]: Starting Run user-specific NixOS activation...2091machine # [ 114.313942] systemd[582]: Finished Run user-specific NixOS activation.2092machine # [ 114.318147] systemd[1]: Stopped target Reactivate sysinit units.2093machine # [ 114.320169] systemd[1]: Stopping Reactivate sysinit units...2094machine # [ 114.321263] systemd[1]: Reached target Reactivate sysinit units.2095machine # [ 114.324441] systemd[1]: Reached target Remote File Systems.2096machine # [ 114.328289] systemd[1]: Started autorestart.service.2097machine # [ 114.332931] systemd[1]: Starting linger-users.service...2098machine # [ 114.337795] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2099machine # [ 114.339120] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2100machine # [ 114.351061] systemd[1]: Reached target Local File Systems.2101machine # [ 114.354147] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2102machine # [ 114.366386] systemd[1]: Starting Create SUID/SGID Wrappers...2103machine # [ 114.367266] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2104machine # [ 114.369438] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672105machine # [ 114.372296] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2106machine # [ 114.376831] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2107machine # [ 114.379960] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2108machine # [ 114.404777] systemd[1]: autorestart.service: Deactivated successfully.2109machine # [ 114.440462] systemd[1]: linger-users.service: Deactivated successfully.2110machine # [ 114.442692] systemd[1]: Finished linger-users.service.2111machine # [ 114.720396] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2112machine # [ 114.724181] systemd[1]: Finished Create SUID/SGID Wrappers.2113machine # [ 114.984692] nixos[4607]: finished switching to system configuration /nix/store/hl0ph1plwnhmqirm8jyfsbcbxrlsy3fh-nixos-system-machine-test2114machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 3.00 seconds)2115machine # [ 115.065347] systemd[1]: Stopped autorestart.service.2116machine: must fail: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&12117machine # [ 115.659093] nixos[4754]: switching to system configuration /nix/store/3qrnmwkxi4hdrmqhjkh7ckp7f9slq53j-nixos-system-machine-test2118machine # [ 115.661894] systemd[1]: Stopped target Local File Systems.2119machine # [ 115.664060] systemd[1]: Stopped target Remote File Systems.2120machine # [ 116.159111] systemd[1]: Reload requested from client PID 4754 ('.switch-to-conf') (unit backdoor.service)...2121machine # [ 116.161280] systemd[1]: Reloading...2122machine # [ 116.782476] systemd[1]: Reloading finished in 618 ms.2123machine # [ 116.921589] systemd[582]: Reexecution requested from client PID 4823 ('switch-to-confi')...2124machine # [ 116.925484] systemd[582]: Reexecuting.2125machine # [ 116.961115] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2126machine # [ 117.145138] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2127machine # [ 117.151982] systemd[582]: Reload requested from client PID 4823 ('switch-to-confi')...2128machine # [ 117.153863] systemd[582]: Reloading...2129machine # [ 117.339661] systemd[582]: Reloading finished in 183 ms.2130machine # [ 117.352145] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2131machine # [ 117.361174] systemd[582]: Stopped Run user-specific NixOS activation.2132machine # [ 117.363449] systemd[582]: Stopping Run user-specific NixOS activation...2133machine # [ 117.366211] systemd[582]: Starting Run user-specific NixOS activation...2134machine # [ 117.412141] systemd[582]: Finished Run user-specific NixOS activation.2135machine # [ 117.416163] systemd[1]: Stopped target Reactivate sysinit units.2136machine # [ 117.417338] systemd[1]: Stopping Reactivate sysinit units...2137machine # [ 117.418140] systemd[1]: Reached target Reactivate sysinit units.2138machine # [ 117.422441] systemd[1]: Reached target Local File Systems.2139machine # [ 117.425964] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2140machine # [ 117.429727] systemd[1]: Starting Create SUID/SGID Wrappers...2141machine # [ 117.430585] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2142machine # [ 117.431809] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672143machine # [ 117.436188] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2144machine # [ 117.446510] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2145machine # [ 117.447849] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2146machine # [ 117.452518] systemd[1]: Reached target Remote File Systems.2147machine # [ 117.453416] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2148machine # [ 117.455606] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2149machine # [ 117.763345] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2150machine # [ 117.765840] systemd[1]: Finished Create SUID/SGID Wrappers.2151machine # [ 117.772549] systemd[1]: Started autorestart.service.2152machine # [ 117.776345] systemd[1]: Starting linger-users.service...2153machine # [ 117.819814] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE2154machine # [ 117.823899] systemd[1]: autorestart.service: Failed with result 'exit-code'.2155machine # [ 117.848840] systemd[1]: linger-users.service: Deactivated successfully.2156machine # [ 117.851541] systemd[1]: Finished linger-users.service.2157machine # [ 118.173013] nixos[4754]: switching to system configuration /nix/store/3qrnmwkxi4hdrmqhjkh7ckp7f9slq53j-nixos-system-machine-test failed (status 4)2158machine: (finished: must fail: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 3.11 seconds)2159(finished: subtest: failing units, in 15.92 seconds)2160subtest: unit file parser2161machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12162machine # [ 118.751976] nixos[4897]: switching to system configuration /nix/store/0r8x6rl8kii363lk3vnc3cafmvs9r0ya-nixos-system-machine-test2163machine # [ 118.755598] systemd[1]: Stopped autorestart.service.2164machine # [ 118.758447] systemd[1]: Stopped target Remote File Systems.2165machine # [ 118.759283] systemd[1]: Stopped target Local File Systems.2166machine # [ 119.201442] systemd[1]: Reload requested from client PID 4897 ('.switch-to-conf') (unit backdoor.service)...2167machine # [ 119.203328] systemd[1]: Reloading...2168machine # [ 119.806868] systemd[1]: Reloading finished in 601 ms.2169machine # [ 119.958393] systemd[582]: Reexecution requested from client PID 4966 ('switch-to-confi')...2170machine # [ 119.959800] systemd[582]: Reexecuting.2171machine # [ 120.022214] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2172machine # [ 120.220540] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2173machine # [ 120.227960] systemd[582]: Reload requested from client PID 4966 ('switch-to-confi')...2174machine # [ 120.230465] systemd[582]: Reloading...2175machine # [ 120.425710] systemd[582]: Reloading finished in 194 ms.2176machine # [ 120.440171] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2177machine # [ 120.449168] systemd[582]: Stopped Run user-specific NixOS activation.2178machine # [ 120.451720] systemd[582]: Stopping Run user-specific NixOS activation...2179machine # [ 120.454789] systemd[582]: Starting Run user-specific NixOS activation...2180machine # [ 120.502441] systemd[582]: Finished Run user-specific NixOS activation.2181machine # [ 120.507112] systemd[1]: Stopped target Reactivate sysinit units.2182machine # [ 120.510463] systemd[1]: Stopping Reactivate sysinit units...2183machine # [ 120.511341] systemd[1]: Reached target Reactivate sysinit units.2184machine # [ 120.518455] systemd[1]: Reached target Local File Systems.2185machine # [ 120.519339] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2186machine # [ 120.523708] systemd[1]: Starting Create SUID/SGID Wrappers...2187machine # [ 120.529362] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2188machine # [ 120.530639] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672189machine # [ 120.540447] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2190machine # [ 120.542045] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2191machine # [ 120.543310] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2192machine # [ 120.546887] systemd[1]: Reached target Remote File Systems.2193machine # [ 120.547877] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2194machine # [ 120.549988] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2195machine # [ 120.859209] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2196machine # [ 120.863417] systemd[1]: Finished Create SUID/SGID Wrappers.2197machine # [ 120.867250] systemd[1]: Starting linger-users.service...2198machine # [ 120.870280] systemd[1]: Starting test.service...2199machine # [ 120.912571] systemd[1]: Finished test.service.2200machine # [ 120.939880] systemd[1]: linger-users.service: Deactivated successfully.2201machine # [ 120.942369] systemd[1]: Finished linger-users.service.2202machine # [ 121.202379] nixos[4897]: finished switching to system configuration /nix/store/0r8x6rl8kii363lk3vnc3cafmvs9r0ya-nixos-system-machine-test2203machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.03 seconds)2204machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&12205machine # [ 121.855957] nixos[5039]: switching to system configuration /nix/store/vplzfgimlcccy7a8xyqwkzcb51czvay6-nixos-system-machine-test2206machine # [ 121.859457] systemd[1]: Stopped target Local File Systems.2207machine # [ 121.860945] systemd[1]: Stopped target Remote File Systems.2208machine # [ 122.369817] systemd[1]: Reload requested from client PID 5039 ('.switch-to-conf') (unit backdoor.service)...2209machine # [ 122.371792] systemd[1]: Reloading...2210machine # [ 123.017563] systemd[1]: Reloading finished in 643 ms.2211machine # [ 123.179894] systemd[582]: Reexecution requested from client PID 5108 ('switch-to-confi')...2212machine # [ 123.182155] systemd[582]: Reexecuting.2213machine # [ 123.246003] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2214machine # [ 123.440181] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2215machine # [ 123.446633] systemd[582]: Reload requested from client PID 5108 ('switch-to-confi')...2216machine # [ 123.449064] systemd[582]: Reloading...2217machine # [ 123.636450] systemd[582]: Reloading finished in 186 ms.2218machine # [ 123.652156] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2219machine # [ 123.662327] systemd[582]: Stopped Run user-specific NixOS activation.2220machine # [ 123.663350] systemd[582]: Stopping Run user-specific NixOS activation...2221machine # [ 123.666322] systemd[582]: Starting Run user-specific NixOS activation...2222machine # [ 123.711994] systemd[582]: Finished Run user-specific NixOS activation.2223machine # [ 123.716444] systemd[1]: Stopped target Reactivate sysinit units.2224machine # [ 123.717694] systemd[1]: Stopping Reactivate sysinit units...2225machine # [ 123.718512] systemd[1]: Reached target Reactivate sysinit units.2226machine # [ 123.721158] systemd[1]: test.service: Deactivated successfully.2227machine # [ 123.724294] systemd[1]: Stopped test.service.2228machine # [ 123.725305] systemd[1]: Stopping test.service...2229machine # [ 123.727235] systemd[1]: Starting test.service...2230machine # [ 123.761937] systemd[1]: Finished test.service.2231machine # [ 123.765202] systemd[1]: Reached target Remote File Systems.2232machine # [ 123.769743] systemd[1]: Starting linger-users.service...2233machine # [ 123.773566] systemd[1]: Reached target Local File Systems.2234machine # [ 123.783202] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2235machine # [ 123.790081] systemd[1]: Starting Create SUID/SGID Wrappers...2236machine # [ 123.793316] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2237machine # [ 123.794616] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672238machine # [ 123.803806] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2239machine # [ 123.806370] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2240machine # [ 123.808176] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2241machine # [ 123.809681] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2242machine # [ 123.811212] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2243machine # [ 123.868345] systemd[1]: linger-users.service: Deactivated successfully.2244machine # [ 123.870954] systemd[1]: Finished linger-users.service.2245machine # [ 124.141488] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2246machine # [ 124.144998] systemd[1]: Finished Create SUID/SGID Wrappers.2247machine # [ 124.403135] nixos[5039]: finished switching to system configuration /nix/store/vplzfgimlcccy7a8xyqwkzcb51czvay6-nixos-system-machine-test2248machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 3.20 seconds)2249machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&12250machine # [ 125.073293] nixos[5181]: switching to system configuration /nix/store/12jr4khrmpw05nzyqvq4mb5l99rlvhrq-nixos-system-machine-test2251machine # [ 125.076373] systemd[1]: Stopped target Local File Systems.2252machine # [ 125.077715] systemd[1]: Stopped target Remote File Systems.2253machine # [ 125.579208] systemd[1]: Reload requested from client PID 5181 ('.switch-to-conf') (unit backdoor.service)...2254machine # [ 125.581466] systemd[1]: Reloading...2255machine # [ 126.246221] systemd[1]: Reloading finished in 662 ms.2256machine # [ 126.408417] systemd[582]: Reexecution requested from client PID 5250 ('switch-to-confi')...2257machine # [ 126.411663] systemd[582]: Reexecuting.2258machine # [ 126.469717] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2259machine # [ 126.665397] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2260machine # [ 126.671517] systemd[582]: Reload requested from client PID 5250 ('switch-to-confi')...2261machine # [ 126.673979] systemd[582]: Reloading...2262machine # [ 126.860605] systemd[582]: Reloading finished in 185 ms.2263machine # [ 126.876167] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2264machine # [ 126.885053] systemd[582]: Stopped Run user-specific NixOS activation.2265machine # [ 126.887334] systemd[582]: Stopping Run user-specific NixOS activation...2266machine # [ 126.890116] systemd[582]: Starting Run user-specific NixOS activation...2267machine # [ 126.937195] systemd[582]: Finished Run user-specific NixOS activation.2268machine # [ 126.941473] systemd[1]: Stopped target Reactivate sysinit units.2269machine # [ 126.943336] systemd[1]: Stopping Reactivate sysinit units...2270machine # [ 126.948599] systemd[1]: Reached target Reactivate sysinit units.2271machine # [ 126.949676] systemd[1]: test.service: Deactivated successfully.2272machine # [ 126.951669] systemd[1]: Stopped test.service.2273machine # [ 126.952833] systemd[1]: Stopping test.service...2274machine # [ 126.953809] systemd[1]: Starting test.service...2275machine # [ 126.987302] systemd[1]: Finished test.service.2276machine # [ 126.994158] systemd[1]: Reached target Remote File Systems.2277machine # [ 127.000810] systemd[1]: Starting linger-users.service...2278machine # [ 127.004980] systemd[1]: Reached target Local File Systems.2279machine # [ 127.007132] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2280machine # [ 127.013959] systemd[1]: Starting Create SUID/SGID Wrappers...2281machine # [ 127.015196] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2282machine # [ 127.020389] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672283machine # [ 127.022545] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2284machine # [ 127.029489] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2285machine # [ 127.030784] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2286machine # [ 127.031949] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2287machine # [ 127.035041] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2288machine # [ 127.092972] systemd[1]: linger-users.service: Deactivated successfully.2289machine # [ 127.095836] systemd[1]: Finished linger-users.service.2290machine # [ 127.355971] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2291machine # [ 127.359174] systemd[1]: Finished Create SUID/SGID Wrappers.2292machine # [ 127.613646] nixos[5181]: finished switching to system configuration /nix/store/12jr4khrmpw05nzyqvq4mb5l99rlvhrq-nixos-system-machine-test2293machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 3.20 seconds)2294machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12295machine # [ 128.166608] nixos[5323]: switching to system configuration /nix/store/0r8x6rl8kii363lk3vnc3cafmvs9r0ya-nixos-system-machine-test2296machine # [ 128.170961] systemd[1]: Stopped target Remote File Systems.2297machine # [ 128.172003] systemd[1]: Stopped target Local File Systems.2298machine # [ 128.621237] systemd[1]: Reload requested from client PID 5323 ('.switch-to-conf') (unit backdoor.service)...2299machine # [ 128.623135] systemd[1]: Reloading...2300machine # [ 129.213737] systemd[1]: Reloading finished in 588 ms.2301machine # [ 129.352239] systemd[582]: Reexecution requested from client PID 5392 ('switch-to-confi')...2302machine # [ 129.353558] systemd[582]: Reexecuting.2303machine # [ 129.417525] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2304machine # [ 129.604154] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2305machine # [ 129.610722] systemd[582]: Reload requested from client PID 5392 ('switch-to-confi')...2306machine # [ 129.612656] systemd[582]: Reloading...2307machine # [ 129.792877] systemd[582]: Reloading finished in 179 ms.2308machine # [ 129.808145] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2309machine # [ 129.816372] systemd[582]: Stopped Run user-specific NixOS activation.2310machine # [ 129.818489] systemd[582]: Stopping Run user-specific NixOS activation...2311machine # [ 129.821181] systemd[582]: Starting Run user-specific NixOS activation...2312machine # [ 129.862228] systemd[582]: Finished Run user-specific NixOS activation.2313machine # [ 129.865931] systemd[1]: Stopped target Reactivate sysinit units.2314machine # [ 129.867864] systemd[1]: Stopping Reactivate sysinit units...2315machine # [ 129.871616] systemd[1]: Reached target Reactivate sysinit units.2316machine # [ 129.872890] systemd[1]: test.service: Deactivated successfully.2317machine # [ 129.874634] systemd[1]: Stopped test.service.2318machine # [ 129.875274] systemd[1]: Stopping test.service...2319machine # [ 129.875930] systemd[1]: Starting test.service...2320machine # [ 129.908732] systemd[1]: Finished test.service.2321machine # [ 129.914274] systemd[1]: Reached target Local File Systems.2322machine # [ 129.917173] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2323machine # [ 129.921425] systemd[1]: Starting Create SUID/SGID Wrappers...2324machine # [ 129.922297] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2325machine # [ 129.923493] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672326machine # [ 129.927039] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2327machine # [ 129.937507] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2328machine # [ 129.941127] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2329machine # [ 129.942320] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2330machine # [ 129.943549] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2331machine # [ 129.944878] systemd[1]: Reached target Remote File Systems.2332machine # [ 130.248844] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2333machine # [ 130.252162] systemd[1]: Finished Create SUID/SGID Wrappers.2334machine # [ 130.255903] systemd[1]: Starting linger-users.service...2335machine # [ 130.315076] systemd[1]: linger-users.service: Deactivated successfully.2336machine # [ 130.317617] systemd[1]: Finished linger-users.service.2337machine # [ 130.575556] nixos[5323]: finished switching to system configuration /nix/store/0r8x6rl8kii363lk3vnc3cafmvs9r0ya-nixos-system-machine-test2338machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.97 seconds)2339machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&12340machine # [ 131.218462] nixos[5465]: switching to system configuration /nix/store/q0j7px22aw2wz30ipqb9ydxpyvwvq407-nixos-system-machine-test2341machine # [ 131.221527] systemd[1]: Stopped target Local File Systems.2342machine # [ 131.222866] systemd[1]: Stopped target Remote File Systems.2343machine # [ 131.737953] systemd[1]: Reload requested from client PID 5465 ('.switch-to-conf') (unit backdoor.service)...2344machine # [ 131.739909] systemd[1]: Reloading...2345machine # [ 132.426752] systemd[1]: Reloading finished in 684 ms.2346machine # [ 132.602869] systemd[582]: Reexecution requested from client PID 5534 ('switch-to-confi')...2347machine # [ 132.606645] systemd[582]: Reexecuting.2348machine # [ 132.674736] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2349machine # [ 132.900265] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2350machine # [ 132.907150] systemd[582]: Reload requested from client PID 5534 ('switch-to-confi')...2351machine # [ 132.909881] systemd[582]: Reloading...2352machine # [ 133.108071] systemd[582]: Reloading finished in 197 ms.2353machine # [ 133.124173] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2354machine # [ 133.134290] systemd[582]: Stopped Run user-specific NixOS activation.2355machine # [ 133.136792] systemd[582]: Stopping Run user-specific NixOS activation...2356machine # [ 133.139885] systemd[582]: Starting Run user-specific NixOS activation...2357machine # [ 133.186771] systemd[582]: Finished Run user-specific NixOS activation.2358machine # [ 133.191571] systemd[1]: Stopped target Reactivate sysinit units.2359machine # [ 133.195525] systemd[1]: Stopping Reactivate sysinit units...2360machine # [ 133.198566] systemd[1]: Reached target Reactivate sysinit units.2361machine # [ 133.199741] systemd[1]: Reached target Remote File Systems.2362machine # [ 133.203698] systemd[1]: Reached target Local File Systems.2363machine # [ 133.206696] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2364machine # [ 133.214469] systemd[1]: Starting Create SUID/SGID Wrappers...2365machine # [ 133.215403] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2366machine # [ 133.218016] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672367machine # [ 133.227984] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2368machine # [ 133.231705] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2369machine # [ 133.234032] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2370machine # [ 133.235249] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2371machine # [ 133.236738] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2372machine # [ 133.578503] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2373machine # [ 133.581145] systemd[1]: Finished Create SUID/SGID Wrappers.2374machine # [ 133.586789] systemd[1]: Starting linger-users.service...2375machine # [ 133.652081] systemd[1]: linger-users.service: Deactivated successfully.2376machine # [ 133.654861] systemd[1]: Finished linger-users.service.2377machine # [ 133.914824] nixos[5465]: finished switching to system configuration /nix/store/q0j7px22aw2wz30ipqb9ydxpyvwvq407-nixos-system-machine-test2378machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 3.34 seconds)2379machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&12380machine # [ 134.599799] nixos[5605]: switching to system configuration /nix/store/i5pymwxzj6p4qpa45rzfdsj2il0vzdg7-nixos-system-machine-test2381machine # [ 134.602570] systemd[1]: Stopped target Local File Systems.2382machine # [ 134.604820] systemd[1]: Stopped target Remote File Systems.2383machine # [ 135.134046] systemd[1]: Reload requested from client PID 5605 ('.switch-to-conf') (unit backdoor.service)...2384machine # [ 135.136111] systemd[1]: Reloading...2385machine # [ 135.793359] systemd[1]: Reloading finished in 654 ms.2386machine # [ 135.937470] systemd[582]: Reexecution requested from client PID 5674 ('switch-to-confi')...2387machine # [ 135.941468] systemd[582]: Reexecuting.2388machine # [ 135.981681] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2389machine # [ 136.169248] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2390machine # [ 136.176761] systemd[582]: Reload requested from client PID 5674 ('switch-to-confi')...2391machine # [ 136.178818] systemd[582]: Reloading...2392machine # [ 136.368840] systemd[582]: Reloading finished in 188 ms.2393machine # [ 136.380149] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2394machine # [ 136.388882] systemd[582]: Stopped Run user-specific NixOS activation.2395machine # [ 136.391068] systemd[582]: Stopping Run user-specific NixOS activation...2396machine # [ 136.393821] systemd[582]: Starting Run user-specific NixOS activation...2397machine # [ 136.436236] systemd[582]: Finished Run user-specific NixOS activation.2398machine # [ 136.440090] systemd[1]: Stopped target Reactivate sysinit units.2399machine # [ 136.442065] systemd[1]: Stopping Reactivate sysinit units...2400machine # [ 136.444516] systemd[1]: Reached target Reactivate sysinit units.2401machine # [ 136.445396] systemd[1]: test.service: Deactivated successfully.2402machine # [ 136.446215] systemd[1]: Stopped test.service.2403machine # [ 136.446844] systemd[1]: Stopping test.service...2404machine # [ 136.450570] systemd[1]: Starting test.service...2405machine # [ 136.485981] systemd[1]: Finished test.service.2406machine # [ 136.490337] systemd[1]: Reached target Remote File Systems.2407machine # [ 136.493816] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2408machine # [ 136.495148] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2409machine # [ 136.497404] systemd[1]: Reached target Local File Systems.2410machine # [ 136.500642] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2411machine # [ 136.507473] systemd[1]: Starting Create SUID/SGID Wrappers...2412machine # [ 136.510320] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2413machine # [ 136.513587] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672414machine # [ 136.515742] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2415machine # [ 136.517509] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2416machine # [ 136.519101] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2417machine # [ 136.840670] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2418machine # [ 136.844092] systemd[1]: Finished Create SUID/SGID Wrappers.2419machine # [ 136.847969] systemd[1]: Starting linger-users.service...2420machine # [ 136.906608] systemd[1]: linger-users.service: Deactivated successfully.2421machine # [ 136.909248] systemd[1]: Finished linger-users.service.2422machine # [ 137.166856] nixos[5605]: finished switching to system configuration /nix/store/i5pymwxzj6p4qpa45rzfdsj2il0vzdg7-nixos-system-machine-test2423machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 3.25 seconds)2424machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&12425machine # [ 137.799107] nixos[5747]: switching to system configuration /nix/store/qy0q9pjjnd4p4mcfy5y1rjpcl9rmp84f-nixos-system-machine-test2426machine # [ 137.801694] systemd[1]: Stopped target Remote File Systems.2427machine # [ 137.803316] systemd[1]: Stopped target Local File Systems.2428machine # [ 138.311443] systemd[1]: Reload requested from client PID 5747 ('.switch-to-conf') (unit backdoor.service)...2429machine # [ 138.313659] systemd[1]: Reloading...2430machine # [ 138.951692] systemd[1]: Reloading finished in 635 ms.2431machine # [ 139.100423] systemd[582]: Reexecution requested from client PID 5816 ('switch-to-confi')...2432machine # [ 139.103612] systemd[582]: Reexecuting.2433machine # [ 139.165823] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2434machine # [ 139.365871] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2435machine # [ 139.372801] systemd[582]: Reload requested from client PID 5816 ('switch-to-confi')...2436machine # [ 139.374833] systemd[582]: Reloading...2437machine # [ 139.572223] systemd[582]: Reloading finished in 195 ms.2438machine # [ 139.588167] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2439machine # [ 139.599071] systemd[582]: Stopped Run user-specific NixOS activation.2440machine # [ 139.601488] systemd[582]: Stopping Run user-specific NixOS activation...2441machine # [ 139.604514] systemd[582]: Starting Run user-specific NixOS activation...2442machine # [ 139.654258] systemd[582]: Finished Run user-specific NixOS activation.2443machine # [ 139.658658] systemd[1]: Stopped target Reactivate sysinit units.2444machine # [ 139.660636] systemd[1]: Stopping Reactivate sysinit units...2445machine # [ 139.665047] systemd[1]: Reached target Reactivate sysinit units.2446machine # [ 139.667053] systemd[1]: test.service: Deactivated successfully.2447machine # [ 139.667971] systemd[1]: Stopped test.service.2448machine # [ 139.668820] systemd[1]: Stopping test.service...2449machine # [ 139.669832] systemd[1]: Starting test.service...2450machine # [ 139.704253] systemd[1]: Finished test.service.2451machine # [ 139.710062] systemd[1]: Reached target Local File Systems.2452machine # [ 139.712433] systemd[1]: Reached target Remote File Systems.2453machine # [ 139.715723] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2454machine # [ 139.719471] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2455machine # [ 139.722736] systemd[1]: Starting linger-users.service...2456machine # [ 139.725070] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2457machine # [ 139.732252] systemd[1]: Starting Create SUID/SGID Wrappers...2458machine # [ 139.733163] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2459machine # [ 139.734425] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672460machine # [ 139.743991] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2461machine # [ 139.745962] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2462machine # [ 139.747378] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2463machine # [ 139.815545] systemd[1]: linger-users.service: Deactivated successfully.2464machine # [ 139.818566] systemd[1]: Finished linger-users.service.2465machine # [ 140.091885] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2466machine # [ 140.095345] systemd[1]: Finished Create SUID/SGID Wrappers.2467machine # [ 140.352000] nixos[5747]: finished switching to system configuration /nix/store/qy0q9pjjnd4p4mcfy5y1rjpcl9rmp84f-nixos-system-machine-test2468machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 3.19 seconds)2469machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&12470machine # [ 141.003720] nixos[5889]: switching to system configuration /nix/store/dc28v3hsxgf73plmf3ayw8h34cbjbp2k-nixos-system-machine-test2471machine # [ 141.007142] systemd[1]: Stopped target Local File Systems.2472machine # [ 141.008415] systemd[1]: Stopped target Remote File Systems.2473machine # [ 141.507680] systemd[1]: Reload requested from client PID 5889 ('.switch-to-conf') (unit backdoor.service)...2474machine # [ 141.509825] systemd[1]: Reloading...2475machine # [ 142.145328] systemd[1]: Reloading finished in 633 ms.2476machine # [ 142.291205] systemd[582]: Reexecution requested from client PID 5958 ('switch-to-confi')...2477machine # [ 142.295059] systemd[582]: Reexecuting.2478machine # [ 142.357893] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2479machine # [ 142.550070] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2480machine # [ 142.556270] systemd[582]: Reload requested from client PID 5958 ('switch-to-confi')...2481machine # [ 142.558408] systemd[582]: Reloading...2482machine # [ 142.747971] systemd[582]: Reloading finished in 188 ms.2483machine # [ 142.764163] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2484machine # [ 142.773010] systemd[582]: Stopped Run user-specific NixOS activation.2485machine # [ 142.775327] systemd[582]: Stopping Run user-specific NixOS activation...2486machine # [ 142.778263] systemd[582]: Starting Run user-specific NixOS activation...2487machine # [ 142.826461] systemd[582]: Finished Run user-specific NixOS activation.2488machine # [ 142.830479] systemd[1]: Stopped target Reactivate sysinit units.2489machine # [ 142.832481] systemd[1]: Stopping Reactivate sysinit units...2490machine # [ 142.836326] systemd[1]: Reached target Reactivate sysinit units.2491machine # [ 142.837532] systemd[1]: test.service: Deactivated successfully.2492machine # [ 142.839525] systemd[1]: Stopped test.service.2493machine # [ 142.840460] systemd[1]: Stopping test.service...2494machine # [ 142.841433] systemd[1]: Starting test.service...2495machine # [ 142.876970] systemd[1]: Finished test.service.2496machine # [ 142.882934] systemd[1]: Reached target Local File Systems.2497machine # [ 142.887603] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2498machine # [ 142.894349] systemd[1]: Starting Create SUID/SGID Wrappers...2499machine # [ 142.895249] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2500machine # [ 142.897994] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672501machine # [ 142.908199] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2502machine # [ 142.909785] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2503machine # [ 142.911038] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2504machine # [ 142.912731] systemd[1]: Reached target Remote File Systems.2505machine # [ 142.913537] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2506machine # [ 142.914776] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2507machine # [ 143.221441] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2508machine # [ 143.223547] systemd[1]: Finished Create SUID/SGID Wrappers.2509machine # [ 143.228664] systemd[1]: Starting linger-users.service...2510machine # [ 143.288766] systemd[1]: linger-users.service: Deactivated successfully.2511machine # [ 143.290795] systemd[1]: Finished linger-users.service.2512machine # [ 143.548882] nixos[5889]: finished switching to system configuration /nix/store/dc28v3hsxgf73plmf3ayw8h34cbjbp2k-nixos-system-machine-test2513machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 3.20 seconds)2514machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12515machine # [ 144.120143] nixos[6031]: switching to system configuration /nix/store/0r8x6rl8kii363lk3vnc3cafmvs9r0ya-nixos-system-machine-test2516machine # [ 144.122569] systemd[1]: Stopped target Local File Systems.2517machine # [ 144.124725] systemd[1]: Stopped target Remote File Systems.2518machine # [ 144.551174] systemd[1]: Reload requested from client PID 6031 ('.switch-to-conf') (unit backdoor.service)...2519machine # [ 144.553247] systemd[1]: Reloading...2520machine # [ 145.114137] systemd[1]: Reloading finished in 559 ms.2521machine # [ 145.253748] systemd[582]: Reexecution requested from client PID 6100 ('switch-to-confi')...2522machine # [ 145.257627] systemd[582]: Reexecuting.2523machine # [ 145.301077] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2524machine # [ 145.481012] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2525machine # [ 145.487666] systemd[582]: Reload requested from client PID 6100 ('switch-to-confi')...2526machine # [ 145.490114] systemd[582]: Reloading...2527machine # [ 145.673740] systemd[582]: Reloading finished in 183 ms.2528machine # [ 145.688140] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2529machine # [ 145.698041] systemd[582]: Stopped Run user-specific NixOS activation.2530machine # [ 145.700099] systemd[582]: Stopping Run user-specific NixOS activation...2531machine # [ 145.702906] systemd[582]: Starting Run user-specific NixOS activation...2532machine # [ 145.747660] systemd[582]: Finished Run user-specific NixOS activation.2533machine # [ 145.752060] systemd[1]: Stopped target Reactivate sysinit units.2534machine # [ 145.753983] systemd[1]: Stopping Reactivate sysinit units...2535machine # [ 145.756616] systemd[1]: Reached target Reactivate sysinit units.2536machine # [ 145.757478] systemd[1]: test.service: Deactivated successfully.2537machine # [ 145.758265] systemd[1]: Stopped test.service.2538machine # [ 145.758870] systemd[1]: Stopping test.service...2539machine # [ 145.762415] systemd[1]: Starting test.service...2540machine # [ 145.797747] systemd[1]: Finished test.service.2541machine # [ 145.803509] systemd[1]: Reached target Local File Systems.2542machine # [ 145.806734] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2543machine # [ 145.811117] systemd[1]: Starting Create SUID/SGID Wrappers...2544machine # [ 145.812000] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2545machine # [ 145.816729] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672546machine # [ 145.818847] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2547machine # [ 145.829679] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2548machine # [ 145.830995] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2549machine # [ 145.832330] systemd[1]: Reached target Remote File Systems.2550machine # [ 145.833099] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2551machine # [ 145.834300] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2552machine # [ 146.143878] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2553machine # [ 146.148507] systemd[1]: Finished Create SUID/SGID Wrappers.2554machine # [ 146.150927] systemd[1]: Starting linger-users.service...2555machine # [ 146.210405] systemd[1]: linger-users.service: Deactivated successfully.2556machine # [ 146.212421] systemd[1]: Finished linger-users.service.2557machine # [ 146.470479] nixos[6031]: finished switching to system configuration /nix/store/0r8x6rl8kii363lk3vnc3cafmvs9r0ya-nixos-system-machine-test2558machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.92 seconds)2559machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&12560machine # [ 147.087432] nixos[6173]: switching to system configuration /nix/store/dbawq4nxyg5j10pi41qqg66772f9bxrd-nixos-system-machine-test2561machine # [ 147.091817] systemd[1]: Stopped target Local File Systems.2562machine # [ 147.092965] systemd[1]: Stopped target Remote File Systems.2563machine # [ 147.582934] systemd[1]: Reload requested from client PID 6173 ('.switch-to-conf') (unit backdoor.service)...2564machine # [ 147.585129] systemd[1]: Reloading...2565machine # [ 148.214888] systemd[1]: Reloading finished in 627 ms.2566machine # [ 148.365411] systemd[582]: Reexecution requested from client PID 6242 ('switch-to-confi')...2567machine # [ 148.369464] systemd[582]: Reexecuting.2568machine # [ 148.434389] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2569machine # [ 148.628799] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2570machine # [ 148.635776] systemd[582]: Reload requested from client PID 6242 ('switch-to-confi')...2571machine # [ 148.639027] systemd[582]: Reloading...2572machine # [ 148.827148] systemd[582]: Reloading finished in 189 ms.2573machine # [ 148.841539] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2574machine # [ 148.848930] systemd[582]: Stopped Run user-specific NixOS activation.2575machine # [ 148.851179] systemd[582]: Stopping Run user-specific NixOS activation...2576machine # [ 148.853840] systemd[582]: Starting Run user-specific NixOS activation...2577machine # [ 148.900408] systemd[582]: Finished Run user-specific NixOS activation.2578machine # [ 148.904283] systemd[1]: Stopped target Reactivate sysinit units.2579machine # [ 148.908298] systemd[1]: Stopping Reactivate sysinit units...2580machine # [ 148.909486] systemd[1]: Reached target Reactivate sysinit units.2581machine # [ 148.911497] systemd[1]: Reloading test.service...2582machine # [ 148.946157] systemd[1]: Reloaded test.service.2583machine # [ 148.948861] systemd[1]: Reached target Local File Systems.2584machine # [ 148.954358] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2585machine # [ 148.961178] systemd[1]: Starting Create SUID/SGID Wrappers...2586machine # [ 148.963769] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2587machine # [ 148.968585] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672588machine # [ 148.970751] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2589machine # [ 148.976875] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2590machine # [ 148.979865] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2591machine # [ 148.982643] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2592machine # [ 148.984718] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2593machine # [ 148.986585] systemd[1]: Reached target Remote File Systems.2594machine # [ 149.295403] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2595machine # [ 149.299946] systemd[1]: Finished Create SUID/SGID Wrappers.2596machine # [ 149.303056] systemd[1]: Starting linger-users.service...2597machine # [ 149.363620] systemd[1]: linger-users.service: Deactivated successfully.2598machine # [ 149.365754] systemd[1]: Finished linger-users.service.2599machine # [ 149.624627] nixos[6173]: finished switching to system configuration /nix/store/dbawq4nxyg5j10pi41qqg66772f9bxrd-nixos-system-machine-test2600machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 3.15 seconds)2601machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&12602machine # [ 150.256186] nixos[6315]: switching to system configuration /nix/store/in5r5qv2q6284id6drg207wsdndmc18g-nixos-system-machine-test2603machine # [ 150.259256] systemd[1]: Stopped target Local File Systems.2604machine # [ 150.260683] systemd[1]: Stopped target Remote File Systems.2605machine # [ 150.759355] systemd[1]: Reload requested from client PID 6315 ('.switch-to-conf') (unit backdoor.service)...2606machine # [ 150.761474] systemd[1]: Reloading...2607machine # [ 151.401579] systemd[1]: Reloading finished in 637 ms.2608machine # [ 151.547329] systemd[582]: Reexecution requested from client PID 6384 ('switch-to-confi')...2609machine # [ 151.549666] systemd[582]: Reexecuting.2610machine # [ 151.601475] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2611machine # [ 151.785188] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2612machine # [ 151.792328] systemd[582]: Reload requested from client PID 6384 ('switch-to-confi')...2613machine # [ 151.794601] systemd[582]: Reloading...2614machine # [ 151.978303] systemd[582]: Reloading finished in 182 ms.2615machine # [ 151.993605] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2616machine # [ 152.003130] systemd[582]: Stopped Run user-specific NixOS activation.2617machine # [ 152.004241] systemd[582]: Stopping Run user-specific NixOS activation...2618machine # [ 152.007272] systemd[582]: Starting Run user-specific NixOS activation...2619machine # [ 152.054823] systemd[582]: Finished Run user-specific NixOS activation.2620machine # [ 152.059506] systemd[1]: Stopped target Reactivate sysinit units.2621machine # [ 152.063832] systemd[1]: Stopping Reactivate sysinit units...2622machine # [ 152.065188] systemd[1]: Reached target Reactivate sysinit units.2623machine # [ 152.067726] systemd[1]: Reloading test.service...2624machine # [ 152.104830] systemd[1]: Reloaded test.service.2625machine # [ 152.110999] systemd[1]: Reached target Remote File Systems.2626machine # [ 152.116393] systemd[1]: Starting linger-users.service...2627machine # [ 152.119618] systemd[1]: Reached target Local File Systems.2628machine # [ 152.127386] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2629machine # [ 152.136849] systemd[1]: Starting Create SUID/SGID Wrappers...2630machine # [ 152.137751] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2631machine # [ 152.138937] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672632machine # [ 152.148907] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2633machine # [ 152.151189] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2634machine # [ 152.153037] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2635machine # [ 152.154916] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2636machine # [ 152.157258] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2637machine # [ 152.209607] systemd[1]: linger-users.service: Deactivated successfully.2638machine # [ 152.212654] systemd[1]: Finished linger-users.service.2639machine # [ 152.483272] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2640machine # [ 152.486050] systemd[1]: Finished Create SUID/SGID Wrappers.2641machine # [ 152.745793] nixos[6315]: finished switching to system configuration /nix/store/in5r5qv2q6284id6drg207wsdndmc18g-nixos-system-machine-test2642machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 3.12 seconds)2643machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&12644machine # [ 153.340460] nixos[6457]: switching to system configuration /nix/store/dwzjwfb5kzi985gak9589kinp9ipsk6j-nixos-system-machine-test2645machine # [ 153.343262] systemd[1]: Stopped target Remote File Systems.2646machine # [ 153.345680] systemd[1]: Stopped target Local File Systems.2647machine # [ 153.864512] systemd[1]: Reload requested from client PID 6457 ('.switch-to-conf') (unit backdoor.service)...2648machine # [ 153.866559] systemd[1]: Reloading...2649machine # [ 154.570382] systemd[1]: Reloading finished in 701 ms.2650machine # [ 154.734898] systemd[582]: Reexecution requested from client PID 6526 ('switch-to-confi')...2651machine # [ 154.739393] systemd[582]: Reexecuting.2652machine # [ 154.786688] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2653machine # [ 155.005913] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2654machine # [ 155.013051] systemd[582]: Reload requested from client PID 6526 ('switch-to-confi')...2655machine # [ 155.016189] systemd[582]: Reloading...2656machine # [ 155.221801] systemd[582]: Reloading finished in 204 ms.2657machine # [ 155.236177] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2658machine # [ 155.245892] systemd[582]: Stopped Run user-specific NixOS activation.2659machine # [ 155.248152] systemd[582]: Stopping Run user-specific NixOS activation...2660machine # [ 155.251593] systemd[582]: Starting Run user-specific NixOS activation...2661machine # [ 155.299293] systemd[582]: Finished Run user-specific NixOS activation.2662machine # [ 155.303912] systemd[1]: Stopped target Reactivate sysinit units.2663machine # [ 155.306425] systemd[1]: Stopping Reactivate sysinit units...2664machine # [ 155.307271] systemd[1]: Reached target Reactivate sysinit units.2665machine # [ 155.310908] systemd[1]: test.service: Deactivated successfully.2666machine # [ 155.311868] systemd[1]: Stopped test.service.2667machine # [ 155.312690] systemd[1]: Stopping test.service...2668machine # [ 155.315141] systemd[1]: Starting test.service...2669machine # [ 155.354895] systemd[1]: Finished test.service.2670machine # [ 155.359531] systemd[1]: Reached target Remote File Systems.2671machine # [ 155.363322] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2672machine # [ 155.366521] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2673machine # [ 155.367937] systemd[1]: Reached target Local File Systems.2674machine # [ 155.374124] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2675machine # [ 155.382016] systemd[1]: Starting Create SUID/SGID Wrappers...2676machine # [ 155.382987] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2677machine # [ 155.387576] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672678machine # [ 155.390661] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2679machine # [ 155.393138] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2680machine # [ 155.396282] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2681machine # [ 155.749345] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2682machine # [ 155.754176] systemd[1]: Finished Create SUID/SGID Wrappers.2683machine # [ 155.757010] systemd[1]: Starting linger-users.service...2684machine # [ 155.826621] systemd[1]: linger-users.service: Deactivated successfully.2685machine # [ 155.829463] systemd[1]: Finished linger-users.service.2686machine # [ 156.090529] nixos[6457]: finished switching to system configuration /nix/store/dwzjwfb5kzi985gak9589kinp9ipsk6j-nixos-system-machine-test2687machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 3.35 seconds)2688machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&12689machine # [ 156.707177] nixos[6599]: switching to system configuration /nix/store/i5pymwxzj6p4qpa45rzfdsj2il0vzdg7-nixos-system-machine-test2690machine # [ 156.709915] systemd[1]: Stopped target Remote File Systems.2691machine # [ 156.712435] systemd[1]: Stopped target Local File Systems.2692machine # [ 157.175701] systemd[1]: Reload requested from client PID 6599 ('.switch-to-conf') (unit backdoor.service)...2693machine # [ 157.177897] systemd[1]: Reloading...2694machine # [ 157.773990] systemd[1]: Reloading finished in 594 ms.2695machine # [ 157.923645] systemd[582]: Reexecution requested from client PID 6668 ('switch-to-confi')...2696machine # [ 157.925795] systemd[582]: Reexecuting.2697machine # [ 157.994088] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2698machine # [ 158.187221] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2699machine # [ 158.193412] systemd[582]: Reload requested from client PID 6668 ('switch-to-confi')...2700machine # [ 158.195502] systemd[582]: Reloading...2701machine # [ 158.382816] systemd[582]: Reloading finished in 186 ms.2702machine # [ 158.400156] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2703machine # [ 158.408824] systemd[582]: Stopped Run user-specific NixOS activation.2704machine # [ 158.411322] systemd[582]: Stopping Run user-specific NixOS activation...2705machine # [ 158.414232] systemd[582]: Starting Run user-specific NixOS activation...2706machine # [ 158.460701] systemd[582]: Finished Run user-specific NixOS activation.2707machine # [ 158.464879] systemd[1]: Stopped target Reactivate sysinit units.2708machine # [ 158.467820] systemd[1]: Stopping Reactivate sysinit units...2709machine # [ 158.469164] systemd[1]: Reached target Reactivate sysinit units.2710machine # [ 158.471978] systemd[1]: Reached target Local File Systems.2711machine # [ 158.475197] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2712machine # [ 158.477600] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2713machine # [ 158.480572] systemd[1]: Reached target Remote File Systems.2714machine # [ 158.484628] systemd[1]: Starting linger-users.service...2715machine # [ 158.494226] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2716machine # [ 158.499109] systemd[1]: Starting Create SUID/SGID Wrappers...2717machine # [ 158.499962] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2718machine # [ 158.503704] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672719machine # [ 158.507050] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2720machine # [ 158.509786] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2721machine # [ 158.514685] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2722machine # [ 158.571509] systemd[1]: linger-users.service: Deactivated successfully.2723machine # [ 158.574172] systemd[1]: Finished linger-users.service.2724machine # [ 158.840562] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2725machine # [ 158.843919] systemd[1]: Finished Create SUID/SGID Wrappers.2726machine # [ 159.100862] nixos[6599]: finished switching to system configuration /nix/store/i5pymwxzj6p4qpa45rzfdsj2il0vzdg7-nixos-system-machine-test2727machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 3.01 seconds)2728(finished: subtest: unit file parser, in 40.93 seconds)2729subtest: restart and reload by activation script2730machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&12731machine # [ 159.671857] nixos[6739]: switching to system configuration /nix/store/5zsm433avd24mawyji6a9wnrcfxd48s5-nixos-system-machine-test2732machine # [ 159.674622] systemd[1]: Stopped target Local File Systems.2733machine # [ 159.677013] systemd[1]: Stopped target Remote File Systems.2734machine # [ 160.107986] systemd[1]: Reload requested from client PID 6739 ('.switch-to-conf') (unit backdoor.service)...2735machine # [ 160.110176] systemd[1]: Reloading...2736machine # [ 160.683555] systemd[1]: Reloading finished in 571 ms.2737machine # [ 160.819478] systemd[582]: Reexecution requested from client PID 6808 ('switch-to-confi')...2738machine # [ 160.822938] systemd[582]: Reexecuting.2739machine # [ 160.885606] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2740machine # [ 161.074075] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2741machine # [ 161.081573] systemd[582]: Reload requested from client PID 6808 ('switch-to-confi')...2742machine # [ 161.084256] systemd[582]: Reloading...2743machine # [ 161.270282] systemd[582]: Reloading finished in 184 ms.2744machine # [ 161.284264] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2745machine # [ 161.293058] systemd[582]: Stopped Run user-specific NixOS activation.2746machine # [ 161.295394] systemd[582]: Stopping Run user-specific NixOS activation...2747machine # [ 161.298244] systemd[582]: Starting Run user-specific NixOS activation...2748machine # [ 161.344571] systemd[582]: Finished Run user-specific NixOS activation.2749machine # [ 161.348920] systemd[1]: Stopped target Reactivate sysinit units.2750machine # [ 161.351334] systemd[1]: Stopping Reactivate sysinit units...2751machine # [ 161.352783] systemd[1]: Reached target Reactivate sysinit units.2752machine # [ 161.355570] systemd[1]: Reached target Local File Systems.2753machine # [ 161.358755] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2754machine # [ 161.362281] systemd[1]: Starting Create SUID/SGID Wrappers...2755machine # [ 161.363072] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2756machine # [ 161.368573] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672757machine # [ 161.370697] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2758machine # [ 161.377013] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2759machine # [ 161.382656] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2760machine # [ 161.384819] systemd[1]: Reached target Remote File Systems.2761machine # [ 161.385731] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2762machine # [ 161.387629] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2763machine # [ 161.687553] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2764machine # [ 161.691936] systemd[1]: Finished Create SUID/SGID Wrappers.2765machine # [ 161.694435] systemd[1]: Starting linger-users.service...2766machine # [ 161.752404] systemd[1]: linger-users.service: Deactivated successfully.2767machine # [ 161.754805] systemd[1]: Finished linger-users.service.2768machine # [ 162.013015] nixos[6739]: finished switching to system configuration /nix/store/5zsm433avd24mawyji6a9wnrcfxd48s5-nixos-system-machine-test2769machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 2.91 seconds)2770machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12771machine # [ 162.617204] nixos[6879]: switching to system configuration /nix/store/8rg62kx7dix08zwxcmljvs23vah9r060-nixos-system-machine-test2772machine # [ 162.619578] systemd[1]: test.service: Deactivated successfully.2773machine # [ 162.622793] systemd[1]: Stopped test.service.2774machine # [ 162.623545] systemd[1]: Stopped target Local File Systems.2775machine # [ 162.624807] systemd[1]: Stopped target Remote File Systems.2776machine # [ 163.120646] systemd[1]: Reload requested from client PID 6879 ('.switch-to-conf') (unit backdoor.service)...2777machine # [ 163.122535] systemd[1]: Reloading...2778machine # [ 163.789817] systemd[1]: Reloading finished in 665 ms.2779machine # [ 163.932406] systemd[582]: Reexecution requested from client PID 6950 ('switch-to-confi')...2780machine # [ 163.935401] systemd[582]: Reexecuting.2781machine # [ 163.997766] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2782machine # [ 164.184277] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2783machine # [ 164.190438] systemd[582]: Reload requested from client PID 6950 ('switch-to-confi')...2784machine # [ 164.192616] systemd[582]: Reloading...2785machine # [ 164.376623] systemd[582]: Reloading finished in 182 ms.2786machine # [ 164.392134] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2787machine # [ 164.400592] systemd[582]: Stopped Run user-specific NixOS activation.2788machine # [ 164.402632] systemd[582]: Stopping Run user-specific NixOS activation...2789machine # [ 164.405260] systemd[582]: Starting Run user-specific NixOS activation...2790machine # [ 164.446834] systemd[582]: Finished Run user-specific NixOS activation.2791machine # [ 164.451533] systemd[1]: Stopped target Reactivate sysinit units.2792machine # [ 164.453436] systemd[1]: Stopping Reactivate sysinit units...2793machine # [ 164.454451] systemd[1]: Reached target Reactivate sysinit units.2794machine # [ 164.464138] systemd[1]: Starting no-restart-service.service...2795machine # [ 164.466785] systemd[1]: Starting simple-reload-service.service...2796machine # [ 164.480191] systemd[1]: Created slice Slice /system/templated-reload-triggers.2797machine # [ 164.484246] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart.2798machine # [ 164.485769] systemd[1]: Reached target Remote File Systems.2799machine # [ 164.487464] systemd[1]: Starting linger-users.service...2800machine # [ 164.497843] systemd[1]: Starting reload-triggers-and-restart.service...2801machine # [ 164.508252] systemd[1]: Starting reload-triggers.service...2802machine # [ 164.509080] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2803machine # [ 164.513500] systemd[1]: Starting templated-reload-triggers@instance.service...2804machine # [ 164.530533] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2805machine # [ 164.533644] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2806machine # [ 164.549383] systemd[1]: Created slice Slice /system/templated-simple-restart-service.2807machine # [ 164.555646] systemd[1]: Starting templated-simple-restart-service@instance.service...2808machine # [ 164.584158] systemd[1]: Created slice Slice /system/templated-simple-reload-service.2809machine # [ 164.601576] systemd[1]: Starting templated-simple-reload-service@instance.service...2810machine # [ 164.602789] systemd[1]: Created slice Slice /system/templated-no-restart-service.2811machine # [ 164.603931] systemd[1]: Starting templated-no-restart-service@instance.service...2812machine # [ 164.654613] systemd[1]: Starting simple-service.service...2813machine # [ 164.670944] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as.2814machine # [ 164.693048] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2815machine # [ 164.720652] systemd[1]: Reached target Local File Systems.2816machine # [ 164.730528] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2817machine # [ 164.747278] systemd[1]: Starting Create SUID/SGID Wrappers...2818machine # [ 164.758644] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2819machine # [ 164.764839] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672820machine # [ 164.775568] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2821machine # [ 164.781716] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2822machine # [ 164.783303] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2823machine # [ 164.785310] systemd[1]: Finished no-restart-service.service.2824machine # [ 164.786409] systemd[1]: Finished simple-reload-service.service.2825machine # [ 164.787309] systemd[1]: Finished reload-triggers-and-restart.service.2826machine # [ 164.789153] systemd[1]: Finished templated-reload-triggers@instance.service.2827machine # [ 164.790217] systemd[1]: Created slice Slice /system/templated-simple-service.2828machine # [ 164.791521] systemd[1]: Finished reload-triggers.service.2829machine # [ 164.793056] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2830machine # [ 164.794124] systemd[1]: Finished templated-simple-restart-service@instance.service.2831machine # [ 164.795131] systemd[1]: Finished templated-simple-reload-service@instance.service.2832machine # [ 164.796234] systemd[1]: Finished templated-no-restart-service@instance.service.2833machine # [ 164.797275] systemd[1]: Finished simple-service.service.2834machine # [ 164.798275] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2835machine # [ 164.799580] systemd[1]: linger-users.service: Deactivated successfully.2836machine # [ 164.801007] systemd[1]: Finished linger-users.service.2837machine # [ 165.068068] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2838machine # [ 165.072558] systemd[1]: Finished Create SUID/SGID Wrappers.2839machine # [ 165.075893] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2840machine # [ 165.079623] systemd[1]: Starting simple-restart-service.service...2841machine # [ 165.084219] systemd[1]: Starting templated-simple-service@instance.service...2842machine # [ 165.131909] systemd[1]: Finished simple-restart-service.service.2843machine # [ 165.136256] systemd[1]: Finished templated-simple-service@instance.service.2844machine # [ 165.138278] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2845machine # [ 165.398718] nixos[6879]: finished switching to system configuration /nix/store/8rg62kx7dix08zwxcmljvs23vah9r060-nixos-system-machine-test2846machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.39 seconds)2847machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12848machine # [ 166.092760] nixos[7049]: switching to system configuration /nix/store/8rg62kx7dix08zwxcmljvs23vah9r060-nixos-system-machine-test2849machine # [ 166.095978] systemd[1]: Stopped target Local File Systems.2850machine # [ 166.097367] systemd[1]: Stopped target Remote File Systems.2851machine # [ 166.574057] systemd[1]: Reload requested from client PID 7049 ('.switch-to-conf') (unit backdoor.service)...2852machine # [ 166.575949] systemd[1]: Reloading...2853machine # [ 167.202606] systemd[1]: Reloading finished in 624 ms.2854machine # [ 167.356342] systemd[582]: Reexecution requested from client PID 7120 ('switch-to-confi')...2855machine # [ 167.357675] systemd[582]: Reexecuting.2856machine # [ 167.417929] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2857machine # [ 167.607669] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2858machine # [ 167.615523] systemd[582]: Reload requested from client PID 7120 ('switch-to-confi')...2859machine # [ 167.618539] systemd[582]: Reloading...2860machine # [ 167.800558] systemd[582]: Reloading finished in 182 ms.2861machine # [ 167.816140] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2862machine # [ 167.824510] systemd[582]: Stopped Run user-specific NixOS activation.2863machine # [ 167.826636] systemd[582]: Stopping Run user-specific NixOS activation...2864machine # [ 167.829306] systemd[582]: Starting Run user-specific NixOS activation...2865machine # [ 167.874982] systemd[582]: Finished Run user-specific NixOS activation.2866machine # [ 167.878853] systemd[1]: Stopped target Reactivate sysinit units.2867machine # [ 167.883700] systemd[1]: Stopping Reactivate sysinit units...2868machine # [ 167.885045] systemd[1]: Reached target Reactivate sysinit units.2869machine # [ 167.887546] systemd[1]: Reloading reload-triggers-and-restart.service...2870machine # [ 167.893929] systemd[1]: Reloading reload-triggers.service...2871machine # [ 167.896921] systemd[1]: Reloading simple-reload-service.service...2872machine # [ 167.912969] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service...2873machine # [ 167.917659] systemd[1]: Reloading templated-reload-triggers@instance.service...2874machine # [ 167.925313] systemd[1]: Reloading templated-simple-reload-service@instance.service...2875machine # [ 167.984839] systemd[1]: Reloaded simple-reload-service.service.2876machine # [ 167.990306] systemd[1]: Reloaded reload-triggers-and-restart.service.2877machine # [ 167.996455] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service.2878machine # [ 167.999566] systemd[1]: Reloaded reload-triggers.service.2879machine # [ 168.001810] systemd[1]: Reloaded templated-reload-triggers@instance.service.2880machine # [ 168.007763] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2881machine # [ 168.012453] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2882machine # [ 168.013571] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2883machine # [ 168.014459] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2884machine # [ 168.017542] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2885machine # [ 168.020580] systemd[1]: simple-restart-service.service: Deactivated successfully.2886machine # [ 168.023004] systemd[1]: Stopped simple-restart-service.service.2887machine # [ 168.024313] systemd[1]: Stopping simple-restart-service.service...2888machine # [ 168.026437] systemd[1]: Starting simple-restart-service.service...2889machine # [ 168.033478] systemd[1]: simple-service.service: Deactivated successfully.2890machine # [ 168.034427] systemd[1]: Stopped simple-service.service.2891machine # [ 168.035176] systemd[1]: Stopping simple-service.service...2892machine # [ 168.038292] systemd[1]: Starting simple-service.service...2893machine # [ 168.040302] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2894machine # [ 168.041900] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2895machine # [ 168.045311] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2896machine # [ 168.060583] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2897machine # [ 168.062974] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2898machine # [ 168.074674] systemd[1]: Stopped templated-simple-restart-service@instance.service.2899machine # [ 168.078801] systemd[1]: Stopping templated-simple-restart-service@instance.service...2900machine # [ 168.088427] systemd[1]: Starting templated-simple-restart-service@instance.service...2901machine # [ 168.089576] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2902machine # [ 168.090810] systemd[1]: Stopped templated-simple-service@instance.service.2903machine # [ 168.091829] systemd[1]: Stopping templated-simple-service@instance.service...2904machine # [ 168.100698] systemd[1]: Starting templated-simple-service@instance.service...2905machine # [ 168.123970] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2906machine # [ 168.134036] systemd[1]: Finished simple-restart-service.service.2907machine # [ 168.138048] systemd[1]: Finished simple-service.service.2908machine # [ 168.144425] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2909machine # [ 168.156789] systemd[1]: Finished templated-simple-restart-service@instance.service.2910machine # [ 168.165066] systemd[1]: Finished templated-simple-service@instance.service.2911machine # [ 168.176547] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2912machine # [ 168.180258] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2913machine # [ 168.182041] systemd[1]: Reached target Local File Systems.2914machine # [ 168.184286] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2915machine # [ 168.191350] systemd[1]: Starting Create SUID/SGID Wrappers...2916machine # [ 168.192621] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2917machine # [ 168.195936] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672918machine # [ 168.198993] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2919machine # [ 168.201382] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2920machine # [ 168.207310] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2921machine # [ 168.208646] systemd[1]: Reached target Remote File Systems.2922machine # [ 168.547549] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2923machine # [ 168.552888] systemd[1]: Finished Create SUID/SGID Wrappers.2924machine # [ 168.555814] systemd[1]: Starting linger-users.service...2925machine # [ 168.619570] systemd[1]: linger-users.service: Deactivated successfully.2926machine # [ 168.622231] systemd[1]: Finished linger-users.service.2927machine # [ 168.885301] nixos[7049]: finished switching to system configuration /nix/store/8rg62kx7dix08zwxcmljvs23vah9r060-nixos-system-machine-test2928machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.50 seconds)2929machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&12930machine # [ 169.923156] nixos[7215]: switching to system configuration /nix/store/6jcddik99fcm883bqz9cfm0wkv2zm2si-nixos-system-machine-test2931machine # [ 169.926854] systemd[1]: Stopped target Local File Systems.2932machine # [ 169.928333] systemd[1]: Stopped target Remote File Systems.2933machine # [ 170.482533] systemd[1]: Reload requested from client PID 7215 ('.switch-to-conf') (unit backdoor.service)...2934machine # [ 170.484509] systemd[1]: Reloading...2935machine # [ 171.170748] systemd[1]: Reloading finished in 683 ms.2936machine # [ 171.313647] systemd[582]: Reexecution requested from client PID 7286 ('switch-to-confi')...2937machine # [ 171.317498] systemd[582]: Reexecuting.2938machine # [ 171.369487] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2939machine # [ 171.554272] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2940machine # [ 171.560745] systemd[582]: Reload requested from client PID 7286 ('switch-to-confi')...2941machine # [ 171.562996] systemd[582]: Reloading...2942machine # [ 171.747110] systemd[582]: Reloading finished in 183 ms.2943machine # [ 171.760160] systemd[582]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2944machine # [ 171.770154] systemd[582]: Stopped Run user-specific NixOS activation.2945machine # [ 171.772526] systemd[582]: Stopping Run user-specific NixOS activation...2946machine # [ 171.775436] systemd[582]: Starting Run user-specific NixOS activation...2947machine # [ 171.821103] systemd[582]: Finished Run user-specific NixOS activation.2948machine # [ 171.824967] systemd[1]: Stopped target Reactivate sysinit units.2949machine # [ 171.827821] systemd[1]: Stopping Reactivate sysinit units...2950machine # [ 171.830625] systemd[1]: Reached target Reactivate sysinit units.2951machine # [ 171.833674] systemd[1]: Reloading reload-triggers.service...2952machine # [ 171.839562] systemd[1]: Reloading simple-reload-service.service...2953machine # [ 171.845740] systemd[1]: Reloading templated-reload-triggers@instance.service...2954machine # [ 171.849939] systemd[1]: Reloading templated-simple-reload-service@instance.service...2955machine # [ 171.908073] systemd[1]: Reloaded reload-triggers.service.2956machine # [ 171.911466] systemd[1]: Reloaded simple-reload-service.service.2957machine # [ 171.912887] systemd[1]: Reloaded templated-reload-triggers@instance.service.2958machine # [ 171.913845] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2959machine # [ 171.917391] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2960machine # [ 171.918545] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2961machine # [ 171.919473] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2962machine # [ 171.922672] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2963machine # [ 171.925841] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully.2964machine # [ 171.927278] systemd[1]: Stopped reload-triggers-and-restart.service.2965machine # [ 171.928669] systemd[1]: Stopping reload-triggers-and-restart.service...2966machine # [ 171.933774] systemd[1]: Starting reload-triggers-and-restart.service...2967machine # [ 171.936524] systemd[1]: simple-restart-service.service: Deactivated successfully.2968machine # [ 171.945045] systemd[1]: Stopped simple-restart-service.service.2969machine # [ 171.945872] systemd[1]: Stopping simple-restart-service.service...2970machine # [ 171.946671] systemd[1]: Starting simple-restart-service.service...2971machine # [ 171.947509] systemd[1]: simple-service.service: Deactivated successfully.2972machine # [ 171.961831] systemd[1]: Stopped simple-service.service.2973machine # [ 171.971705] systemd[1]: Stopping simple-service.service...2974machine # [ 171.980668] systemd[1]: Starting simple-service.service...2975machine # [ 171.990834] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2976machine # [ 172.005047] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2977machine # [ 172.019000] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2978machine # [ 172.029559] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2979machine # [ 172.042622] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully.2980machine # [ 172.051310] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service.2981machine # [ 172.067413] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service...2982machine # [ 172.076629] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2983machine # [ 172.078307] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2984machine # [ 172.082490] systemd[1]: Stopped templated-simple-restart-service@instance.service.2985machine # [ 172.084977] systemd[1]: Stopping templated-simple-restart-service@instance.service...2986machine # [ 172.087939] systemd[1]: Starting templated-simple-restart-service@instance.service...2987machine # [ 172.089477] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2988machine # [ 172.092520] systemd[1]: Stopped templated-simple-service@instance.service.2989machine # [ 172.097322] systemd[1]: Stopping templated-simple-service@instance.service...2990machine # [ 172.098635] systemd[1]: Starting templated-simple-service@instance.service...2991machine # [ 172.099832] systemd[1]: Finished reload-triggers-and-restart.service.2992machine # [ 172.102543] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2993machine # [ 172.103734] systemd[1]: Finished simple-restart-service.service.2994machine # [ 172.105100] systemd[1]: Finished simple-service.service.2995machine # [ 172.106093] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2996machine # [ 172.107314] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2997machine # [ 172.108990] systemd[1]: Finished templated-simple-restart-service@instance.service.2998machine # [ 172.112665] systemd[1]: Finished templated-simple-service@instance.service.2999machine # [ 172.118989] systemd[1]: Reached target Remote File Systems.3000machine # [ 172.123789] systemd[1]: Starting linger-users.service...3001machine # [ 172.128507] systemd[1]: Reached target Local File Systems.3002machine # [ 172.129595] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore3003machine # [ 172.137470] systemd[1]: Starting Create SUID/SGID Wrappers...3004machine # [ 172.144455] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.3005machine # [ 172.145678] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc673006machine # [ 172.147772] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore3007machine # [ 172.152969] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3008machine # [ 172.154229] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3009machine # [ 172.155388] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os3010machine # [ 172.156681] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki3011machine # [ 172.217452] systemd[1]: linger-users.service: Deactivated successfully.3012machine # [ 172.220318] systemd[1]: Finished linger-users.service.3013machine # [ 172.483637] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.3014machine # [ 172.486705] systemd[1]: Finished Create SUID/SGID Wrappers.3015machine # [ 172.743828] nixos[7215]: finished switching to system configuration /nix/store/6jcddik99fcm883bqz9cfm0wkv2zm2si-nixos-system-machine-test3016machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 3.85 seconds)3017machine: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&13018machine: (finished: must succeed: /nix/store/65xkbn7l9vzf6fzgddn253mz30z36rf1-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.88 seconds)3019(finished: subtest: restart and reload by activation script, in 14.52 seconds)3020(finished: run the VM test script, in 174.59 seconds)3021test script finished in 174.64s3022cleanup3023kill QemuMachine (pid 45)3024machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)3025(finished: cleanup, in 0.20 seconds)3026additionally exposed symbols:3027 machine, other,3028 vlan1,3029 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