vm-test-run-switch-test-services
checks.aarch64-linux.switchTest
· build #25
· 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.ZhosWQQfDc', 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: 58ac4414-71be-4040-9cb2-b9964d9c515b17machine # Superblock backups stored on blocks:18machine # 32768, 98304, 163840, 22937619machine # 20machine # Allocating group tables: 0/8 done21machine # Writing inode tables: 0/8 done22machine # Creating journal (8192 blocks): done23machine # Writing superblocks and filesystem accounting information: 0/8 done24machine # 25machine # Virtualisation disk image created.26machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]27machine # [ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Sep 2 12:31:51 UTC 202628machine # [ 0.000000] KASLR enabled29machine # [ 0.000000] random: crng init done30machine # [ 0.000000] Machine model: linux,dummy-virt31machine # [ 0.000000] efi: UEFI not found.32machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT33machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]34machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f]35machine # [ 0.000000] Zone ranges:36machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]37machine # [ 0.000000] DMA32 empty38machine # [ 0.000000] Normal empty39machine # [ 0.000000] Device empty40machine # [ 0.000000] Movable zone start for each node41machine # [ 0.000000] Early memory node ranges42machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]43machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]44machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc0000045machine # [ 0.000000] psci: probing for conduit method from DT.46machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.47machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs48machine # [ 0.000000] psci: Trusted OS migration not required49machine # [ 0.000000] psci: SMC Calling Convention v1.150machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)51machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u31129652machine # [ 0.000000] Detected PIPT I-cache on CPU053machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)54machine # [ 0.000000] CPU features: detected: GICv3 CPU interface55machine # [ 0.000000] CPU features: detected: Spectre-v456machine # [ 0.000000] CPU features: detected: Spectre-BHB57machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_3858machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_2359machine # [ 0.000000] alternatives: applying boot alternatives60machine # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/init regInfo=/nix/store/lqyfi30mf6p09gy4am7iays5w7i8yk71-closure-info/registration console=ttyAMA0,115200n8 console=tty061machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/lqyfi30mf6p09gy4am7iays5w7i8yk71-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 @44ce0000 (indirect, esz 8, psz 64K, shr 1)96machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)97machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d0000098machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d1000099machine # [ 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.000028] arm-pv: using stolen time PV105machine # [ 0.000400] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)106machine # [ 0.000579] Console: colour dummy device 80x25107machine # [ 0.000587] printk: legacy console [tty0] enabled108machine # [ 0.000777] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)109machine # [ 0.000784] pid_max: default: 32768 minimum: 301110machine # [ 0.000854] LSM: initializing lsm=capability,landlock,yama,bpf,ima111machine # [ 0.000992] landlock: Up and running.112machine # [ 0.000995] Yama: becoming mindful.113machine # [ 0.001440] LSM support for eBPF active114machine # [ 0.001560] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)115machine # [ 0.001579] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)116machine # [ 0.002668] cacheinfo: Unable to detect cache hierarchy for CPU 0117machine # [ 0.003414] rcu: Hierarchical SRCU implementation.118machine # [ 0.003418] rcu: Max phase no-delay instances is 1000.119machine # [ 0.004607] fsl-mc MSI: its@8080000 domain created120machine # [ 0.004697] EFI services will not be available.121machine # [ 0.004768] smp: Bringing up secondary CPUs ...122machine # [ 0.004776] smp: Brought up 1 node, 1 CPU123machine # [ 0.004779] SMP: Total of 1 processors activated.124machine # [ 0.004782] CPU: All CPU(s) started at EL1125machine # [ 0.004794] CPU features: detected: Branch Target Identification126machine # [ 0.004799] CPU features: detected: ARMv8.4 Translation Table Level127machine # [ 0.004802] CPU features: detected: Instruction cache invalidation not required for I/D coherence128machine # [ 0.004806] CPU features: detected: Data cache clean to the PoU not required for I/D coherence129machine # [ 0.004809] CPU features: detected: Common not Private translations130machine # [ 0.004813] CPU features: detected: CRC32 instructions131machine # [ 0.004815] CPU features: detected: Data cache clean to Point of Deep Persistence132machine # [ 0.004819] CPU features: detected: Data cache clean to Point of Persistence133machine # [ 0.004822] CPU features: detected: Data independent timing control (DIT)134machine # [ 0.004825] CPU features: detected: E0PD135machine # [ 0.004828] CPU features: detected: Enhanced Counter Virtualization136machine # [ 0.004831] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)137machine # [ 0.004834] CPU features: detected: Enhanced Virtualization Traps138machine # [ 0.004837] CPU features: detected: Fine Grained Traps139machine # [ 0.004840] CPU features: detected: Generic authentication (architected QARMA5 algorithm)140machine # [ 0.004845] CPU features: detected: RCpc load-acquire (LDAPR)141machine # [ 0.004849] CPU features: detected: LSE atomic instructions142machine # [ 0.004852] CPU features: detected: Privileged Access Never143machine # [ 0.004854] CPU features: detected: PMUv3144machine # [ 0.004856] CPU features: detected: RAS Extension Support145machine # [ 0.004859] CPU features: detected: RASv1p1 Extension Support146machine # [ 0.004862] CPU features: detected: Random Number Generator147machine # [ 0.004864] CPU features: detected: Speculation barrier (SB)148machine # [ 0.004867] CPU features: detected: Stage-2 Force Write-Back149machine # [ 0.004870] CPU features: detected: TLB range maintenance instructions150machine # [ 0.004875] CPU features: detected: Speculative Store Bypassing Safe (SSBS)151machine # [ 0.004912] alternatives: applying system-wide alternatives152machine # [ 0.007794] CPU features: detected: BBM Level 2 without TLB conflict abort153machine # [ 0.008049] Memory: 894312K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 112964K reserved, 32768K cma-reserved)154machine # [ 0.008362] devtmpfs: initialized155machine # [ 0.010041] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)156machine # [ 0.010063] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).157machine # [ 0.010251] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL158machine # [ 0.010255] 0 pages in range for non-PLT usage159machine # [ 0.010255] 508288 pages in range for PLT usage160machine # [ 0.010370] pinctrl core: initialized pinctrl subsystem161machine # [ 0.011085] DMI not present or invalid.162machine # [ 0.014175] NET: Registered PF_NETLINK/PF_ROUTE protocol family163machine # [ 0.016739] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations164machine # [ 0.016878] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations165machine # [ 0.017034] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations166machine # [ 0.017057] audit: initializing netlink subsys (disabled)167machine # [ 0.017605] thermal_sys: Registered thermal governor 'fair_share'168machine # [ 0.017607] thermal_sys: Registered thermal governor 'bang_bang'169machine # [ 0.017610] thermal_sys: Registered thermal governor 'step_wise'170machine # [ 0.017613] thermal_sys: Registered thermal governor 'user_space'171machine # [ 0.017618] thermal_sys: Registered thermal governor 'power_allocator'172machine # [ 0.017641] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1173machine # [ 0.017651] cpuidle: using governor ladder174machine # [ 0.017656] cpuidle: using governor menu175machine # [ 0.017840] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.176machine # [ 0.017855] ASID allocator initialised with 65536 entries177machine # [ 0.019015] Serial: AMBA PL011 UART driver178machine # [ 0.024062] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1179machine # [ 0.024228] printk: console [ttyAMA0] enabled180machine # [ 0.145492] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages181machine # [ 0.145510] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page182machine # [ 0.145515] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages183machine # [ 0.145520] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page184machine # [ 0.145524] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages185machine # [ 0.145528] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page186machine # [ 0.145533] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages187machine # [ 0.145537] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page188machine # [ 0.152959] fbcon: Taking over console189machine # [ 0.152973] ACPI: Interpreter disabled.190machine # [ 0.154811] iommu: Default domain type: Translated191machine # [ 0.154821] iommu: DMA domain TLB invalidation policy: strict mode192machine # [ 0.156443] SCSI subsystem initialized193machine # [ 0.161840] usbcore: registered new interface driver usbfs194machine # [ 0.161872] usbcore: registered new interface driver hub195machine # [ 0.161893] usbcore: registered new device driver usb196machine # [ 0.162161] pps_core: LinuxPPS API ver. 1 registered197machine # [ 0.162167] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>198machine # [ 0.162177] PTP clock support registered199machine # [ 0.162222] EDAC MC: Ver: 3.0.0200machine # [ 0.166746] scmi_core: SCMI protocol bus registered201machine # [ 0.167680] FPGA manager framework202machine # [ 0.168621] vgaarb: loaded203machine # [ 0.169216] clocksource: Switched to clocksource arch_sys_counter204machine # [ 0.172927] VFS: Disk quotas dquot_6.6.0205machine # [ 0.172956] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)206machine # [ 0.176519] netfs: FS-Cache loaded207machine # [ 0.176638] pnp: PnP ACPI: disabled208machine # [ 0.180488] NET: Registered PF_INET protocol family209machine # [ 0.180647] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)210machine # [ 0.208476] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)211machine # [ 0.208515] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)212machine # [ 0.208537] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)213machine # [ 0.208578] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)214machine # [ 0.208653] TCP: Hash tables configured (established 8192 bind 8192)215machine # [ 0.208727] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)216machine # [ 0.208757] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)217machine # [ 0.208781] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)218machine # [ 0.208860] NET: Registered PF_UNIX/PF_LOCAL protocol family219machine # [ 0.208885] NET: Registered PF_XDP protocol family220machine # [ 0.208904] PCI: CLS 0 bytes, default 64221machine # [ 0.209118] Trying to unpack rootfs image as initramfs...222machine # [ 0.226683] kvm [1]: HYP mode not available223machine # [ 0.310786] Initialise system trusted keyrings224machine # [ 0.311521] workingset: timestamp_bits=42 max_order=18 bucket_order=0225machine # [ 0.317635] squashfs: version 4.0 (2009/01/31) Phillip Lougher226machine # [ 0.318429] 9p: Installing v9fs 9p2000 file system support227machine # [ 0.339001] Key type asymmetric registered228machine # [ 0.339016] Asymmetric key parser 'x509' registered229machine # [ 0.339080] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)230machine # [ 0.341163] io scheduler mq-deadline registered231machine # [ 0.341174] io scheduler kyber registered232machine # [ 0.354079] pl061_gpio 9030000.pl061: PL061 GPIO chip registered233machine # [ 0.355325] ledtrig-cpu: registered to indicate activity on CPUs234machine # [ 0.355723] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:235machine # [ 0.355739] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000236machine # [ 0.355754] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000237machine # [ 0.355763] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000238machine # [ 0.355788] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits239machine # [ 0.355815] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]240machine # [ 0.355908] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00241machine # [ 0.355918] pci_bus 0000:00: root bus resource [bus 00-ff]242machine # [ 0.355924] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]243machine # [ 0.355929] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]244machine # [ 0.355934] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]245machine # [ 0.355996] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint246machine # [ 0.356423] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint247machine # [ 0.356606] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]248machine # [ 0.356624] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]249machine # [ 0.356654] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]250machine # [ 0.356670] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]251machine # [ 0.357117] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint252machine # [ 0.373940] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]253machine # [ 0.373960] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]254machine # [ 0.373991] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]255machine # [ 0.374441] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint256machine # [ 0.374620] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]257machine # [ 0.374636] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]258machine # [ 0.374666] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]259machine # [ 0.375127] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint260machine # [ 0.375305] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]261machine # [ 0.375322] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]262machine # [ 0.375351] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]263machine # [ 0.375806] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint264machine # [ 0.375989] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]265machine # [ 0.376005] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]266machine # [ 0.376036] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]267machine # [ 0.376477] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint268machine # [ 0.376656] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]269machine # [ 0.376673] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]270machine # [ 0.376703] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]271machine # [ 0.377145] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint272machine # [ 0.401369] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]273machine # [ 0.401398] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]274machine # [ 0.401428] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]275machine # [ 0.401445] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]276machine # [ 0.401936] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint277machine # [ 0.402124] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]278machine # [ 0.402154] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]279machine # [ 0.402604] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint280machine # [ 0.402788] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]281machine # [ 0.402819] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]282machine # [ 0.403200] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint283machine # [ 0.403378] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]284machine # [ 0.403626] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint285machine # [ 0.403870] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]286machine # [ 0.403899] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]287machine # [ 0.403929] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]288machine # [ 0.404379] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint289machine # [ 0.404559] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]290machine # [ 0.404576] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]291machine # [ 0.404606] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]292machine # [ 0.405176] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned293machine # [ 0.405188] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned294machine # [ 0.405194] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned295machine # [ 0.405260] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned296machine # [ 0.405307] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned297machine # [ 0.405353] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned298machine # [ 0.405399] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned299machine # [ 0.405445] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned300machine # [ 0.405492] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned301machine # [ 0.405539] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned302machine # [ 0.405585] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned303machine # [ 0.405631] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned304machine # [ 0.405703] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned305machine # [ 0.405749] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned306machine # [ 0.405771] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned307machine # [ 0.405792] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned308machine # [ 0.405814] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned309machine # [ 0.405836] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned310machine # [ 0.405861] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned311machine # [ 0.405883] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned312machine # [ 0.405905] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned313machine # [ 0.405927] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned314machine # [ 0.405950] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned315machine # [ 0.405972] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned316machine # [ 0.405995] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned317machine # [ 0.406017] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned318machine # [ 0.406039] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned319machine # [ 0.406060] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned320machine # [ 0.406082] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned321machine # [ 0.406104] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned322machine # [ 0.406126] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned323machine # [ 0.406148] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned324machine # [ 0.406170] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned325machine # [ 0.406192] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned326machine # [ 0.406219] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]327machine # [ 0.406229] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]328machine # [ 0.406233] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]329machine # [ 0.407383] pci 0000:00:0a.0: enabling device (0000 -> 0002)330machine # [ 0.479137] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)331machine # [ 0.485310] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)332machine # [ 0.487527] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)333machine # [ 0.497403] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)334machine # [ 0.499291] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)335machine # [ 0.501157] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)336machine # [ 0.511251] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)337machine # [ 0.521396] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)338machine # [ 0.525077] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)339machine # [ 0.526810] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)340machine # [ 0.528911] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)341machine # [ 0.546479] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled342machine # [ 0.548838] msm_serial: driver initialized343machine # [ 0.548977] SuperH (H)SCI(F) driver initialized344machine # [ 0.549030] STM32 USART driver initialized345machine # [ 0.582355] loop: module loaded346machine # [ 0.582517] virtio_blk virtio5: 1/0/0 default/read/poll queues347machine # [ 0.583241] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)348machine # [ 0.589763] megasas: 07.734.00.00-rc1349machine # [ 0.590441] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]350machine # [ 0.592485] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000351machine # [ 0.592509] Intel/Sharp Extended Query Table at 0x0031352machine # [ 0.601759] Using buffer write method353machine # [ 0.601818] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]354machine # [ 0.604647] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000355machine # [ 0.604671] Intel/Sharp Extended Query Table at 0x0031356machine # [ 0.609194] Using buffer write method357machine # [ 0.617277] Concatenating MTD devices:358machine # [ 0.617284] (0): "0.flash"359machine # [ 0.617288] (1): "0.flash"360machine # [ 0.617291] into device "0.flash"361machine # [ 0.835026] Freeing initrd memory: 26104K362machine # [ 0.840931] tun: Universal TUN/TAP device driver, 1.6363machine # [ 0.844481] thunder_xcv, ver 1.0364machine # [ 0.844520] thunder_bgx, ver 1.0365machine # [ 0.844544] nicpf, ver 1.0366machine # [ 0.845070] e1000: Intel(R) PRO/1000 Network Driver367machine # [ 0.845077] e1000: Copyright (c) 1999-2006 Intel Corporation.368machine # [ 0.845103] e1000e: Intel(R) PRO/1000 Network Driver369machine # [ 0.845111] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.370machine # [ 0.845139] igb: Intel(R) Gigabit Ethernet Network Driver371machine # [ 0.845144] igb: Copyright (c) 2007-2014 Intel Corporation.372machine # [ 0.845165] igbvf: Intel(R) Gigabit Virtual Function Network Driver373machine # [ 0.845171] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.374machine # [ 0.851966] sky2: driver version 1.30375machine # [ 0.853865] ehci-pci 0000:00:0a.0: EHCI Host Controller376machine # [ 0.853891] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1377machine # [ 0.854120] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000378machine # [ 0.857145] usbcore: registered new interface driver usb-storage379machine # [ 0.857198] usbcore: registered new interface driver usbserial_generic380machine # [ 0.857211] usbserial: USB Serial support registered for generic381machine # [ 0.860057] hv_vmbus: registering driver hyperv_keyboard382machine # [ 0.861481] rtc-pl031 9010000.pl031: registered as rtc0383machine # [ 0.861504] rtc-pl031 9010000.pl031: setting system clock to 2026-09-06T22:46:54 UTC (1788734814)384machine # [ 0.861796] i2c_dev: i2c /dev entries driver385machine # [ 0.866543] sdhci: Secure Digital Host Controller Interface driver386machine # [ 0.866552] sdhci: Copyright(c) Pierre Ossman387machine # [ 0.866811] Synopsys Designware Multimedia Card Interface Driver388machine # [ 0.867173] sdhci-pltfm: SDHCI platform and OF driver helper389machine # [ 0.868791] hid: raw HID events driver (C) Jiri Kosina390machine # [ 0.869013] usbcore: registered new interface driver usbhid391machine # [ 0.869019] usbhid: USB HID core driver392machine # [ 0.873679] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00393machine # [ 0.874008] hub 1-0:1.0: USB hub found394machine # [ 0.874039] hub 1-0:1.0: 6 ports detected395machine # [ 0.876858] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available396machine # [ 0.879398] drop_monitor: Initializing network drop monitor service397machine # [ 0.879555] NET: Registered PF_INET6 protocol family398machine # [ 0.881396] Segment Routing with IPv6399machine # [ 0.881413] In-situ OAM (IOAM) with IPv6400machine # [ 0.881460] NET: Registered PF_PACKET protocol family401machine # [ 0.883065] 9pnet: Installing 9P2000 support402machine # [ 0.885096] Key type dns_resolver registered403machine # [ 0.891683] registered taskstats version 1404machine # [ 0.891822] Loading compiled-in X.509 certificates405machine # [ 0.900232] Demotion targets for Node 0: null406machine # [ 0.900330] Key type .fscrypt registered407machine # [ 0.900336] Key type fscrypt-provisioning registered408machine # [ 0.900421] ima: No TPM chip found, activating TPM-bypass!409machine # [ 0.900440] ima: Allocated hash algorithm: sha1410machine # [ 0.900459] ima: No architecture policies found411machine # [ 0.904466] input: gpio-keys as /devices/platform/gpio-keys/input/input0412machine # [ 0.921850] clk: Disabling unused clocks413machine # [ 0.921869] PM: genpd: Disabling unused power domains414machine # [ 0.925995] Freeing unused kernel memory: 4736K415machine # [ 0.926191] Run /init as init process416machine # [ 0.943288] systemd[1]: Successfully made /usr/ read-only.417machine # [ 1.121290] usb 1-1: new high-speed USB device number 2 using ehci-pci418machine # [ 1.273567] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1419machine # [ 1.279434] systemd[1]: systemd 262-9457f81 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)420machine # [ 1.279492] systemd[1]: Detected virtualization qemu.421machine # [ 1.279562] systemd[1]: Detected architecture arm64.422machine # [ 1.279585] systemd[1]: Running in initrd.423machine # [ 1.280475] systemd[1]: Initializing machine ID from random generator.424machine # [ 1.280740] systemd[1]: Hostname set to <machine>.425machine # [ 1.353480] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0426machine # [ 1.441482] systemd[1]: bpf-restrict-fs: LSM BPF program attached427machine # [ 1.473274] usb 1-2: new high-speed USB device number 3 using ehci-pci428machine # [ 1.492875] systemd[1]: Queued start job for default target Initrd Default Target.429machine # [ 1.499354] systemd[1]: Created slice Slice /system/modprobe.430machine # [ 1.500423] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.431machine # [ 1.501674] systemd[1]: Expecting device /dev/disk/by-label/nixos...432machine # [ 1.502687] systemd[1]: Reached target Path Units.433machine # [ 1.503424] systemd[1]: Reached target Slice Units.434machine # [ 1.504180] systemd[1]: Reached target Swaps.435machine # [ 1.504861] systemd[1]: Reached target Timer Units.436machine # [ 1.505824] systemd[1]: Listening on D-Bus System Message Bus Socket.437machine # [ 1.507009] systemd[1]: Listening on Journal Socket (/dev/log).438machine # [ 1.508077] systemd[1]: Listening on Journal Sockets.439machine # [ 1.508926] systemd[1]: Listening on udev Kernel Socket.440machine # [ 1.509807] systemd[1]: Reached target Socket Units.441machine # [ 1.511998] systemd[1]: Starting Create List of Static Device Nodes...442machine # [ 1.522148] systemd[1]: Starting Load Kernel Module 9pnet_virtio...443machine # [ 1.522268] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs444machine # [ 1.541338] systemd[1]: Mounting Kernel Configuration File System...445machine # [ 1.544318] systemd[1]: Starting Journal Service...446machine # [ 1.557210] systemd[1]: Starting Load Kernel Modules...447machine # [ 1.557354] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os448machine # [ 1.562360] systemd[1]: Starting Coldplug All udev Devices...449machine # [ 1.581481] systemd[1]: Finished Create List of Static Device Nodes.450machine # [ 1.582591] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.451machine # [ 1.582874] systemd[1]: Finished Load Kernel Module 9pnet_virtio.452machine # [ 1.583088] systemd[1]: Mounted Kernel Configuration File System.453machine # [ 1.597697] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...454machine # [ 1.609869] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.455machine # [ 1.623669] systemd-journald[73]: Collecting audit messages is disabled.456machine # [ 1.628893] 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/input2457machine # [ 1.629054] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0458machine # [ 1.638132] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev459machine # [ 1.642530] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0460machine # [ 1.642749] [drm] features: -virgl +edid -resource_blob -host_visible461machine # [ 1.642759] [drm] features: -context_init462machine # [ 1.643444] [drm] number of scanouts: 1463machine # [ 1.643461] [drm] number of cap sets: 0464machine # [ 1.653348] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.465machine # [ 1.657541] systemd[1]: Starting Create Static Device Nodes in /dev...466machine # [ 1.665511] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic467machine # [ 1.665528] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0468machine # [ 1.685535] Console: switching to colour frame buffer device 160x50469machine # [ 1.717789] systemd[1]: Finished Create Static Device Nodes in /dev.470machine # [ 1.717945] systemd[1]: Reached target Preparation for Local File Systems.471machine # [ 1.717967] systemd[1]: Reached target Local File Systems.472machine # [ 1.721710] systemd[1]: Starting Rule-based Manager for Device Events and Files...473machine # [ 1.725824] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device474machine # [ 1.737767] systemd[1]: Finished Load Kernel Modules.475machine # [ 1.745720] systemd[1]: Starting Apply Kernel Variables...476machine # [ 1.769818] systemd[1]: Finished Apply Kernel Variables.477machine # [ 1.801503] systemd[1]: Started Journal Service.478machine # [ 1.792331] systemd-modules-load[74]: Inserted module 'dm_mod'479machine # [ 1.793540] systemd-modules-load[74]: Module 'virtio_balloon' is built in480machine # [ 1.799136] systemd-modules-load[74]: Module 'virtio_console' is built in481machine # [ 1.804362] systemd-modules-load[74]: Inserted module 'virtio_gpu'482machine # [ 1.813860] systemd-modules-load[74]: Module 'virtio_rng' is built in483machine # [ 1.817394] systemd[1]: Starting Create System Files and Directories...484machine # [ 1.823325] systemd-udevd[80]: Using default interface naming scheme 'v261'.485machine # [ 1.836106] systemd[1]: Finished Create System Files and Directories.486machine # [ 1.852115] systemd[1]: Started Rule-based Manager for Device Events and Files.487machine # [ 1.937613] systemd[1]: Starting Virtual Console Setup...488machine # [ 2.000433] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.489machine # [ 2.003659] systemd[1]: Finished Virtual Console Setup.490machine # [ 2.597871] systemd[1]: Finished Coldplug All udev Devices.491machine # [ 2.599030] systemd[1]: Reached target System Initialization.492machine # [ 2.599840] systemd[1]: Reached target Basic System.493machine # [ 2.743316] (udev-worker)[92]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.494machine # [ 2.757267] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.495machine # [ 2.768798] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.496machine # [ 2.815623] systemd[1]: Found device /dev/disk/by-label/nixos.497machine # [ 2.818727] systemd[1]: Reached target Initrd Root Device.498machine # [ 2.822330] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...499machine # [ 2.870517] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks500machine # [ 2.875697] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.501machine # [ 2.887030] systemd[1]: Mounting /sysroot...502machine # [ 2.926902] EXT4-fs (vda): mounted filesystem 58ac4414-71be-4040-9cb2-b9964d9c515b r/w with ordered data mode. Quota mode: none.503machine # [ 2.918888] systemd[1]: Mounted /sysroot.504machine # [ 2.924098] systemd[1]: Reached target Initrd Root File System.505machine # [ 2.925821] systemd[1]: Starting Mountpoints Configured in the Real Root...506machine # [ 2.947771] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload.507machine # [ 2.954463] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)...508machine # [ 2.959532] systemd[1]: Reloading...509machine # [ 3.140972] systemd[1]: Reloading finished in 183 ms.510machine # [ 3.171013] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace...511machine # [ 3.176166] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace...512machine # [ 3.180160] systemd[1]: Starting Load Kernel Module 9pnet_virtio...513machine # [ 3.183749] systemd[1]: initrd-parse-etc.service: Deactivated successfully.514machine # [ 3.186458] systemd[1]: Finished Mountpoints Configured in the Real Root.515machine # [ 3.188302] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.516machine # [ 3.208085] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.517machine # [ 3.209802] systemd[1]: Finished Load Kernel Module 9pnet_virtio.518machine # [ 3.556194] systemd[1]: Mounting /sysroot/nix/.ro-store...519machine # [ 3.567241] systemd[1]: Mounting /sysroot/nix/.rw-store...520machine # [ 3.578260] systemd[1]: Mounting /sysroot/run...521machine # [ 3.600198] systemd[1]: Mounting /sysroot/tmp/shared...522machine # [ 3.618618] systemd[1]: Mounting /sysroot/tmp/xchg...523machine # [ 3.639972] systemd[1]: Mounted /sysroot/nix/.rw-store.524machine # [ 3.661650] systemd[1]: Starting rw-sysroot-nix-store.service...525machine # [ 3.673262] systemd[1]: Mounted /sysroot/nix/.ro-store.526machine # [ 3.674765] systemd[1]: Mounted /sysroot/run.527machine # [ 3.681329] systemd[1]: Mounted /sysroot/tmp/shared.528machine # [ 3.695298] systemd[1]: Mounted /sysroot/tmp/xchg.529machine # [ 3.702212] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.530machine # [ 3.704335] systemd[1]: Finished rw-sysroot-nix-store.service.531machine # [ 3.708989] systemd[1]: Mounting /sysroot/nix/store...532machine # [ 3.741093] systemd[1]: Mounted /sysroot/nix/store.533machine # [ 3.742212] systemd[1]: Reached target Initrd File Systems.534machine # [ 3.744227] systemd[1]: Starting Find NixOS closure...535machine # [ 3.753700] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...536machine # [ 3.782084] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.537machine # [ 3.803334] systemd[1]: Finished Find NixOS closure.538machine # [ 3.804232] systemd[1]: Reached target Initrd Default Target.539machine # [ 3.806076] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...540machine # [ 3.834978] systemd[1]: Stopped target Initrd Default Target.541machine # [ 3.840327] systemd[1]: Stopped target Basic System.542machine # [ 3.842263] systemd[1]: Stopped target Initrd Root Device.543machine # [ 3.843097] systemd[1]: Stopped target Path Units.544machine # [ 3.846069] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.545machine # [ 3.850464] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.546machine # [ 3.852638] systemd[1]: Stopped target Slice Units.547machine # [ 3.856698] systemd[1]: Stopped target Socket Units.548machine # [ 3.858569] systemd[1]: Stopped target System Initialization.549machine # [ 3.860383] systemd[1]: Stopped target Swaps.550machine # [ 3.861601] systemd[1]: Stopped target Timer Units.551machine # [ 3.864723] systemd[1]: dbus.socket: Deactivated successfully.552machine # [ 3.867100] systemd[1]: Closed D-Bus System Message Bus Socket.553machine # [ 3.871989] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.554machine # [ 3.874697] systemd[1]: Stopped Find NixOS closure.555machine # [ 3.877907] systemd[1]: Starting Load Kernel Module 9pnet_virtio...556machine # [ 3.879417] systemd[1]: Starting rw-sysroot-nix-store.service...557machine # [ 3.883679] systemd[1]: systemd-sysctl.service: Deactivated successfully.558machine # [ 3.893870] systemd[1]: Stopped Apply Kernel Variables.559machine # [ 3.894782] systemd[1]: systemd-modules-load.service: Deactivated successfully.560machine # [ 3.895827] systemd[1]: Stopped Load Kernel Modules.561machine # [ 3.908341] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.562machine # [ 3.909480] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.563machine # [ 3.910510] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.564machine # [ 3.911507] systemd[1]: Stopped Create System Files and Directories.565machine # [ 3.917952] systemd[1]: Stopped target Local File Systems.566machine # [ 3.920247] systemd[1]: Stopped target Preparation for Local File Systems.567machine # [ 3.921389] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.568machine # [ 3.922391] systemd[1]: Stopped Coldplug All udev Devices.569machine # [ 3.923177] systemd[1]: Stopping Rule-based Manager for Device Events and Files...570machine # [ 3.924434] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.571machine # [ 3.925449] systemd[1]: Stopped Virtual Console Setup.572machine # [ 3.926176] systemd[1]: initrd-cleanup.service: Deactivated successfully.573machine # [ 3.927111] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.574machine # [ 3.927993] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.575machine # [ 3.936414] systemd[1]: Finished Load Kernel Module 9pnet_virtio.576machine # [ 3.937298] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.577machine # [ 3.938263] systemd[1]: Finished rw-sysroot-nix-store.service.578machine # [ 3.939067] systemd[1]: systemd-udevd.service: Deactivated successfully.579machine # [ 3.939966] systemd[1]: Stopped Rule-based Manager for Device Events and Files.580machine # [ 3.941916] systemd[1]: systemd-udevd.service: Consumed 1.111s CPU time over 2.222s wall clock time, 17.8M memory peak.581machine # [ 3.943333] systemd[1]: Starting Cleanup udev Database...582machine # [ 3.944181] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.583machine # [ 3.945218] systemd[1]: Stopped Create Static Device Nodes in /dev.584machine # [ 3.946072] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.585machine # [ 3.947216] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.586machine # [ 3.956179] systemd[1]: kmod-static-nodes.service: Deactivated successfully.587machine # [ 3.957182] systemd[1]: Stopped Create List of Static Device Nodes.588machine # [ 3.981245] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.589machine # [ 3.984485] systemd[1]: Finished Cleanup udev Database.590machine # [ 3.985288] systemd[1]: Reached target Switch Root.591machine # [ 3.987761] systemd[1]: Starting NixOS Activation...592machine # [ 4.143324] initrd-nixos-activation-start[173]: booting system configuration /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test593machine # [ 4.204859] initrd-nixos-activation-start[173]: running activation script...594machine # [ 4.611667] initrd-nixos-activation-start[196]: setting up /etc...595machine # [ 4.863735] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.596machine # [ 4.866498] systemd[1]: Finished NixOS Activation.597machine # [ 4.868082] systemd[1]: Starting Switch Root...598machine # [ 4.891045] systemd[1]: Switching root.599machine # [ 5.076346] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).600machine # [ 5.664393] systemd[1]: systemd 262-9457f81 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)601machine # [ 5.676527] systemd[1]: Detected virtualization qemu.602machine # [ 5.679483] systemd[1]: Detected architecture arm64.603machine # [ 5.682967] systemd[1]: Detected first boot.604machine # [ 5.688863] systemd[1]: Initializing machine ID from random generator.605machine # [ 5.846911] systemd[1]: bpf-restrict-fs: LSM BPF program attached606machine # [ 5.991696] systemd[1]: Applying preset policy.607machine # [ 6.467764] systemd[1]: Populated /etc with preset unit settings.608machine # [ 6.951861] systemd[1]: initrd-switch-root.service: Deactivated successfully.609machine # [ 6.953136] systemd[1]: Stopped initrd-switch-root.service.610machine # [ 6.956392] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.611machine # [ 6.959893] systemd[1]: Created slice Slice /system/getty.612machine # [ 6.961850] systemd[1]: Created slice User and Session Slice.613machine # [ 6.963084] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.614machine # [ 6.965851] systemd[1]: Started Forward Password Requests to Wall Directory Watch.615machine # [ 6.967178] systemd[1]: Expecting device /dev/hvc0...616machine # [ 6.968656] systemd[1]: Expecting device /dev/ttyAMA0...617machine # [ 6.970272] systemd[1]: Reached target Local Encrypted Volumes.618machine # [ 6.971923] systemd[1]: Stopped target initrd-fs.target.619machine # [ 6.974216] systemd[1]: Stopped target initrd-root-fs.target.620machine # [ 6.975285] systemd[1]: Stopped target initrd-switch-root.target.621machine # [ 6.977533] systemd[1]: Reached target Virtual Machines and Containers.622machine # [ 6.978715] systemd[1]: Reached target Path Units.623machine # [ 6.980041] systemd[1]: Reached target Remote File Systems.624machine # [ 6.981553] systemd[1]: Reached target Slice Units.625machine # [ 6.983659] systemd[1]: Reached target Swaps.626machine # [ 6.987143] systemd[1]: Listening on Query the User Interactively for a Password.627machine # [ 6.991665] systemd[1]: Listening on Process Core Dump Socket.628machine # [ 6.995988] systemd[1]: Listening on Credential Encryption/Decryption.629machine # [ 6.999325] systemd[1]: Listening on Factory Reset Management.630machine # [ 7.000542] systemd[1]: Listening on Hostname Service Socket.631machine # [ 7.005873] systemd[1]: Starting Journal Log Access Socket...632machine # [ 7.007903] systemd[1]: Listening on Journal Audit Socket.633machine # [ 7.011787] systemd[1]: Listening on Console Output Muting Service Socket.634machine # [ 7.014053] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.635machine # [ 7.016313] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os636machine # [ 7.018756] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki637machine # [ 7.029341] systemd[1]: Listening on Disk Repartitioning Service Socket.638machine # [ 7.031421] systemd[1]: Listening on udev Varlink Socket.639machine # [ 7.035883] systemd[1]: Mounting Huge Pages File System...640machine # [ 7.040928] systemd[1]: Mounting POSIX Message Queue File System...641machine # [ 7.048329] systemd[1]: Mounting Kernel Debug File System...642machine # [ 7.061400] systemd[1]: Mounting Kernel Trace File System...643machine # [ 7.069728] systemd[1]: Starting Create List of Static Device Nodes...644machine # [ 7.091141] systemd[1]: Starting Load Kernel Module 9pnet_virtio...645machine # [ 7.093647] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs646machine # [ 7.104281] systemd[1]: Mounting Kernel Configuration File System...647machine # [ 7.106407] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm648machine # [ 7.108983] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore649machine # [ 7.168246] systemd[1]: Starting Load Kernel Module fuse...650machine # [ 7.172074] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67651machine # [ 7.201660] systemd[1]: Starting Journal Service...652machine # [ 7.214667] systemd[1]: Starting Load Kernel Modules...653machine # [ 7.240574] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...654machine # [ 7.262338] fuse: init (API version 7.45)655machine # [ 7.265178] systemd[1]: Starting Remount Root and Kernel File Systems...656machine # [ 7.265616] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os657machine # [ 7.281683] systemd[1]: Starting Coldplug All udev Devices...658machine # [ 7.312580] systemd[1]: Listening on Journal Log Access Socket.659machine # [ 7.317816] systemd[1]: Mounted Huge Pages File System.660machine # [ 7.321487] systemd[1]: Mounted POSIX Message Queue File System.661machine # [ 7.326102] systemd[1]: Mounted Kernel Debug File System.662machine # [ 7.334103] systemd[1]: Mounted Kernel Trace File System.663machine # [ 7.339867] systemd[1]: Finished Create List of Static Device Nodes.664machine # [ 7.340746] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.665machine # [ 7.347948] systemd[1]: Finished Load Kernel Module 9pnet_virtio.666machine # [ 7.352935] systemd[1]: Mounted Kernel Configuration File System.667machine # [ 7.354765] systemd[1]: modprobe@fuse.service: Deactivated successfully.668machine # [ 7.358902] systemd-journald[269]: Collecting audit messages is enabled.669machine # [ 7.362040] systemd[1]: Finished Load Kernel Module fuse.670machine # [ 7.362882] systemd[1]: Finished Load Kernel Modules.671machine # [ 7.362953] systemd[1]: Queued start job for default target Multi-User System.672machine # [ 7.378913] systemd[1]: Mounting FUSE Control File System...673machine # [ 7.369004] systemd[1]: systemd-journald.service: Deactivated successfully.674machine # [ 7.389413] systemd[1]: Starting Firewall...675machine # [ 7.378029] systemd-modules-load[270]: Module 'atkbd' is built in676machine # [ 7.383734] systemd-modules-load[270]: Module 'loop' is built in677machine # [ 7.412038] EXT4-fs (vda): re-mounted 58ac4414-71be-4040-9cb2-b9964d9c515b.678machine # [ 7.426390] systemd[1]: Starting Apply Kernel Variables...679machine # [ 7.442406] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...680machine # [ 7.454560] systemd[1]: Started Journal Service.681machine # [ 7.452130] systemd-oomd[271]: No swap; memory pressure usage will be degraded682machine # [ 7.480708] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.683machine # [ 7.497785] systemd[1]: Finished Remount Root and Kernel File Systems.684machine # [ 7.553611] systemd[1]: Finished Apply Kernel Variables.685machine # [ 7.554618] systemd[1]: Mounted FUSE Control File System.686machine # [ 7.561492] systemd[1]: Listening on Disk Image Download Service Socket.687machine # [ 7.569073] systemd[1]: Starting Flush Journal to Persistent Storage...688machine # [ 7.576282] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore689machine # [ 7.579854] systemd[1]: Starting Load/Save OS Random Seed...690machine # [ 7.581557] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os691machine # [ 7.606167] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.692machine # [ 7.614698] systemd[1]: Starting Create Static Device Nodes in /dev...693machine # [ 7.685416] systemd-journald[269]: Received client request to flush runtime journal.694machine # [ 7.733395] systemd[1]: Finished Load/Save OS Random Seed.695machine # [ 7.735075] systemd[1]: Reached target First Boot Complete.696machine # [ 7.741405] systemd[1]: Finished Flush Journal to Persistent Storage.697machine # [ 7.758754] systemd[1]: Finished Create Static Device Nodes in /dev.698machine # [ 7.762413] systemd[1]: Reached target Preparation for Local File Systems.699machine # [ 7.766324] systemd[1]: Starting Rule-based Manager for Device Events and Files...700machine # [ 7.949721] systemd[1]: Mounting /run/wrappers...701machine # [ 8.009952] systemd-udevd[310]: Using default interface naming scheme 'v261'.702machine # [ 8.026089] systemd[1]: Mounted /run/wrappers.703machine # [ 8.029228] systemd[1]: Reached target Local File Systems.704machine # [ 8.035815] systemd[1]: Listening on Boot Loader Control Service Socket.705machine # [ 8.048301] systemd[1]: Starting register-nix-paths.service...706machine # [ 8.052687] systemd[1]: Starting Create SUID/SGID Wrappers...707machine # [ 8.055300] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.708machine # [ 8.080570] systemd[1]: Starting Save Transient machine-id to Disk...709machine # [ 8.103965] systemd[1]: Starting Create System Files and Directories...710machine # [ 8.184408] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.711machine # [ 8.204416] systemd[1]: Finished Save Transient machine-id to Disk.712machine # [ 8.339480] systemd[1]: Started Rule-based Manager for Device Events and Files.713machine # [ 8.376677] systemd[1]: Finished Create System Files and Directories.714machine # [ 8.393978] systemd[1]: Starting Rebuild Journal Catalog...715machine # [ 8.399935] systemd[1]: Starting Record System Boot/Shutdown in UTMP...716machine # [ 8.589614] systemd[1]: Finished Record System Boot/Shutdown in UTMP.717machine # [ 8.639794] systemd[1]: Finished Rebuild Journal Catalog.718machine # [ 8.657341] systemd[1]: Starting Update is Completed...719machine # [ 8.782345] systemd[1]: Finished Update is Completed.720machine # [ 9.231839] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.721machine # [ 9.236995] systemd[1]: Finished Create SUID/SGID Wrappers.722machine # [ 9.763983] systemd[1]: Finished Coldplug All udev Devices.723machine # [ 9.937825] systemd[1]: Finished Firewall.724machine # [ 9.993354] systemd[1]: Finished register-nix-paths.service.725machine # [ 9.995397] systemd[1]: Reached target System Initialization.726machine # [ 9.998944] systemd[1]: Started Discard unused filesystem blocks once a week.727machine # [ 10.002696] systemd[1]: Started Daily Cleanup of Temporary Directories.728machine # [ 10.003754] systemd[1]: Reached target Timer Units.729machine # [ 10.008371] systemd[1]: Listening on D-Bus System Message Bus Socket.730machine # [ 10.010259] systemd[1]: Listening on Nix Daemon Socket.731machine # [ 10.014668] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.732machine # [ 10.031501] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3733machine # [ 10.021846] systemd[1]: Reached target Socket Units.734machine # [ 10.024285] systemd[1]: Reached target Basic System.735machine # [ 10.026726] systemd[1]: Starting Import lastlog data into lastlog2 database...736machine # [ 10.032204] systemd[1]: Starting Name Service Cache Daemon (nsncd)...737machine # [ 10.034356] systemd[1]: Starting Post-Boot Actions...738machine # [ 10.064119] systemd[1]: Started Reset console on configuration changes.739machine # [ 10.070414] systemd[1]: Starting resolvconf update...740machine # [ 10.125735] systemd[1]: Starting D-Bus System Message Bus...741machine # [ 10.149543] systemd[1]: Finished Post-Boot Actions.742machine # [ 10.187131] nsncd[480]: Sep 06 22:47:03.832 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"743machine # [ 10.201702] systemd[1]: Started Name Service Cache Daemon (nsncd).744machine # [ 10.216300] systemd[1]: Reached target Host and Network Name Lookups.745machine # [ 10.217533] systemd[1]: Reached target User and Group Name Lookups.746machine # [ 10.224888] systemd[1]: Starting User Login Management...747machine # [ 10.257491] systemd[1]: Finished Import lastlog data into lastlog2 database.748machine # [ 10.357630] dbus-broker-launch[486]: Looking up NSS user entry for 'systemd-timesync'...749machine # [ 10.364194] dbus-broker-launch[486]: NSS returned no entry for 'systemd-timesync'750machine # [ 10.366083] dbus-broker-launch[486]: Invalid user-name in /nix/store/q9kni4k6lchfc3fafb6a1yk6yvf86s3s-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"751machine # [ 10.389735] systemd-logind[502]: New seat seat0.752machine # [ 10.397776] systemd[1]: Started User Login Management.753machine # [ 10.408583] systemd[1]: Starting linger-users.service...754machine # [ 10.413403] systemd[1]: Started D-Bus System Message Bus.755machine # [ 10.444904] systemd[1]: Stopped target Host and Network Name Lookups.756machine # [ 10.448720] systemd[1]: Stopping Host and Network Name Lookups...757machine # [ 10.457783] systemd[1]: Stopped target User and Group Name Lookups.758machine # [ 10.461399] systemd[1]: Stopping User and Group Name Lookups...759machine # [ 10.467419] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...760machine # [ 10.475095] systemd[1]: nscd.service: Deactivated successfully.761machine # [ 10.475973] systemd[1]: Stopped Name Service Cache Daemon (nsncd).762machine # [ 10.480756] dbus-broker-launch[486]: Ready763machine # [ 10.492150] systemd[1]: Starting Name Service Cache Daemon (nsncd)...764machine # [ 10.555435] systemd[1]: Created slice Slice /user/1001.765machine # [ 10.572101] systemd[1]: Starting User Runtime Directory /run/user/1001...766machine # [ 10.584412] nsncd[549]: Sep 06 22:47:04.227 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"767machine # [ 10.597806] systemd[1]: Started Name Service Cache Daemon (nsncd).768machine # [ 10.606267] systemd[1]: linger-users.service: Deactivated successfully.769machine # [ 10.611540] systemd[1]: Finished linger-users.service.770machine # [ 10.617947] systemd[1]: Reached target Host and Network Name Lookups.771machine # [ 10.623579] systemd[1]: Reached target User and Group Name Lookups.772machine # [ 10.657739] systemd[1]: Finished resolvconf update.773machine # [ 10.661428] systemd[1]: Reached target Preparation for Network.774machine # [ 10.671266] systemd[1]: Starting DHCP Client...775machine # [ 10.677568] systemd[1]: Starting Extra networking commands....776machine # [ 10.693801] systemd[1]: Finished User Runtime Directory /run/user/1001.777machine # [ 10.733681] systemd[1]: Starting User Manager for UID 1001...778machine # [ 10.869897] (systemd)[581]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0)779machine # [ 10.902881] systemd-logind[502]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'.780machine # [ 10.940524] systemd[1]: Starting Virtual Console Setup...781machine # [ 10.974422] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy782machine # [ 11.064156] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs783machine # [ 11.075729] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.784machine # [ 11.085639] systemd[1]: Stopped Virtual Console Setup.785machine # [ 11.093923] systemd[1]: Starting Virtual Console Setup...786machine # [ 11.197471] systemd[581]: Queued start job for default target Main User Target.787machine # [ 11.205871] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy788machine # [ 11.219962] systemd[581]: Created slice User Application Slice.789machine # [ 11.228607] systemd[581]: Started Daily Cleanup of User's Temporary Directories.790machine # [ 11.237849] systemd[581]: Reached target Paths.791machine # [ 11.246521] systemd[581]: Reached target Timers.792machine # [ 11.259819] systemd[581]: Starting D-Bus User Message Bus Socket...793machine # [ 11.266440] systemd[581]: Starting Create User Files and Directories...794machine # [ 11.303622] systemd[581]: Finished Create User Files and Directories.795machine # [ 11.369476] systemd[581]: Listening on D-Bus User Message Bus Socket.796machine # [ 11.399154] systemd[581]: Reached target Sockets.797machine # [ 11.421016] systemd[581]: Reached target Basic System.798machine # [ 11.441178] systemd[1]: Started User Manager for UID 1001.799machine # [ 11.452285] systemd[581]: Starting Run user-specific NixOS activation...800machine # [ 11.453327] systemd[581]: Finished Run user-specific NixOS activation.801machine # [ 11.454290] systemd[581]: Reached target Main User Target.802machine # [ 11.455100] systemd[581]: Startup finished in 494ms.803machine # [ 11.550831] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.804machine # [ 11.578923] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.805machine # [ 11.601732] dhcpcd[598]: dhcpcd-10.3.2 starting806machine # [ 11.618603] systemd[1]: Started backdoor.service.807machine # [ 11.629424] dhcpcd[662]: dev: loaded udev808machine # [ 11.690957] 8021q: 802.1Q VLAN Support v1.8809machine # [ 11.697435] (udev-worker)[640]: Network interface NamePolicy= disabled on kernel command line.810machine # [ 11.732323] (udev-worker)[627]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.811machine # [ 11.796047] cfg80211: Loading compiled-in X.509 certificates for regulatory database812machine # [ 11.798447] (udev-worker)[627]: Network interface NamePolicy= disabled on kernel command line.813machine # [ 11.831338] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'814machine # [ 11.831867] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'815machine # [ 11.837336] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2816machine # [ 11.837683] cfg80211: failed to load regulatory.db817machine # [ 11.835011] systemd[1]: Finished Extra networking commands..818machine # [ 11.856628] systemd[1]: Reached target Network.819machine # [ 11.886113] systemd[1]: Starting Permit User Sessions...820machine # [ 11.955617] systemd[1]: Condition check resulted in Virtio network device being skipped.821machine # [ 11.981587] systemd[1]: Starting Address configuration of eth1...822machine # [ 12.059351] systemd-logind[502]: Watching system buttons on /dev/input/event0 (gpio-keys)823machine # connecting to host...824machine # [ 12.103639] systemd[1]: Finished Permit User Sessions.825machine # [ 12.118066] systemd[1]: Started Getty on tty1.826machine # [ 12.118754] systemd[1]: Reached target Login Prompts.827machine # [ 12.230974] mousedev: PS/2 mouse device common for all mice828machine: Guest shell says: b'Spawning backdoor root shell...\n'829machine: connected to guest root shell830machine: (connecting took 12.54 seconds)831machine: (finished: waiting for the VM to finish booting, in 12.97 seconds)832machine # [ 12.257434] 8021q: adding VLAN 0 to HW filter on device eth0833machine # [ 12.249740] dhcpcd[662]: eth0: waiting for carrier834machine # [ 12.269003] dhcpcd[662]: eth0: waiting for carrier835machine # [ 12.270410] dhcpcd[662]: eth0: carrier acquired836machine # [ 12.310664] 8021q: adding VLAN 0 to HW filter on device eth1837machine # [ 12.302864] dhcpcd[662]: DUID 00:01:00:01:32:30:a9:e9:52:54:00:12:34:56838machine # [ 12.305534] dhcpcd[662]: eth0: IAID 00:12:34:56839machine # [ 12.309645] dhcpcd[662]: eth0: adding address fe80::5054:ff:fe12:3456840machine # [ 12.381117] network-addresses-eth1-start[682]: adding address 192.168.1.1/24... done841machine # [ 12.475339] systemd-logind[502]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)842machine # [ 12.494413] network-addresses-eth1-start[682]: adding address 2001:db8:1::1/64... done843machine # [ 12.579452] systemd[1]: Finished Address configuration of eth1.844machine # [ 12.808484] systemd-vconsole-setup[596]: Configuration of first virtual console was skipped, ignoring remaining ones.845machine # [ 12.833141] systemd[1]: Finished Virtual Console Setup.846machine # [ 13.280782] dhcpcd[662]: eth0: soliciting a DHCP lease847machine # [ 13.296087] dhcpcd[662]: eth0: offered 10.0.2.15 from 10.0.2.2848machine # [ 13.296996] dhcpcd[662]: eth0: probing address 10.0.2.15/24849machine # [ 13.529263] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.850machine # [ 13.560272] systemd[1]: Stopped Virtual Console Setup.851machine # [ 13.561091] systemd[1]: Stopping Virtual Console Setup...852machine # [ 13.561847] systemd[1]: Starting Virtual Console Setup...853machine # [ 13.562639] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.854machine # [ 13.588313] systemd-logind[502]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)855machine # [ 13.597193] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.856machine # [ 13.598421] systemd[1]: Stopped Virtual Console Setup.857machine # [ 13.600959] systemd[1]: Starting Virtual Console Setup...858machine # [ 13.628676] dhcpcd[662]: eth0: soliciting an IPv6 router859machine # [ 13.630152] dhcpcd[662]: eth0: Router Advertisement from fe80::2860machine # [ 13.631035] dhcpcd[662]: eth0: adding address fec0::5054:ff:fe12:3456/64861machine # [ 13.631945] dhcpcd[662]: eth0: adding route to fec0::/64862machine # [ 13.634071] dhcpcd[662]: eth0: adding default route via fe80::2863machine # [ 13.989067] systemd-vconsole-setup[719]: Configuration of first virtual console was skipped, ignoring remaining ones.864machine # [ 13.994631] systemd[1]: Finished Virtual Console Setup.865machine # [ 18.624555] dhcpcd[662]: eth0: leased 10.0.2.15 for 86400 seconds866machine # [ 18.628123] dhcpcd[662]: eth0: adding route to 10.0.2.0/24867machine # [ 18.630827] dhcpcd[662]: eth0: adding default route via 10.0.2.2868machine # [ 18.783410] systemd[1]: Started DHCP Client.869machine # [ 18.785705] systemd[1]: Reached target Multi-User System.870machine # [ 18.786586] systemd[1]: Startup finished in 917ms (kernel) + 4.263s (initrd) + 13.604s (userspace) = 18.785s.871machine: (finished: waiting for unit multi-user.target, in 20.19 seconds)872machine: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/bin/switch-to-configuration test873machine # Checking switch inhibitors... done874machine # [ 20.022408] nixos[836]: switching to system configuration /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test875machine # activating the configuration...876machine # [ 20.026558] systemd[1]: Stopped target Remote File Systems.877machine # [ 20.027623] systemd[1]: Stopped target Local File Systems.878machine # setting up /etc...879machine # [ 20.459623] systemd[1]: Reload requested from client PID 836 ('.switch-to-conf') (unit backdoor.service)...880machine # [ 20.461785] systemd[1]: Reloading...881machine # [ 21.018984] systemd[1]: Reloading finished in 555 ms.882machine # reloading user units for usertest...883machine # [ 21.065422] systemd[581]: Created slice User Core Session Slice.884machine # [ 21.068650] systemd[581]: Starting D-Bus User Message Bus...885machine # [ 21.127835] dbus-broker-launch[906]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/q9kni4k6lchfc3fafb6a1yk6yvf86s3s-system-path/share/dbus-1/services/org.freedesktop.import1.service'886machine # [ 21.131018] dbus-broker-launch[906]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/q9kni4k6lchfc3fafb6a1yk6yvf86s3s-system-path/share/dbus-1/services/org.freedesktop.machine1.service'887machine # [ 21.134145] dbus-broker-launch[906]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/q9kni4k6lchfc3fafb6a1yk6yvf86s3s-system-path/share/dbus-1/services/org.freedesktop.portable1.service'888machine # [ 21.137507] dbus-broker-launch[906]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/q9kni4k6lchfc3fafb6a1yk6yvf86s3s-system-path/share/dbus-1/services/org.freedesktop.systemd1.service'889machine # [ 21.141177] dbus-broker-launch[906]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored890machine # [ 21.143644] dbus-broker-launch[906]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored891machine # [ 21.146027] systemd[581]: Started D-Bus User Message Bus.892machine # [ 21.152595] dbus-broker-launch[906]: Ready893machine # [ 21.252075] systemd[581]: Reexecution requested from client PID 904 ('switch-to-confi')...894machine # [ 21.254680] systemd[581]: Reexecuting.895machine # [ 21.313661] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy896machine # [ 21.493889] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy897machine # [ 21.499846] systemd[581]: Reload requested from client PID 904 ('switch-to-confi')...898machine # [ 21.502241] systemd[581]: Reloading...899machine # [ 21.680115] systemd[581]: Reloading finished in 177 ms.900machine # [ 21.696130] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy901machine # restarting the following user units: nixos-activation.service902machine # [ 21.705304] systemd[581]: Stopped Run user-specific NixOS activation.903machine # [ 21.707415] systemd[581]: Stopping Run user-specific NixOS activation...904machine # [ 21.709977] systemd[581]: Starting Run user-specific NixOS activation...905machine # [ 21.762288] systemd[581]: Finished Run user-specific NixOS activation.906machine # restarting sysinit-reactivation.target907machine # [ 21.781855] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....908machine # [ 21.900166] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..909machine # [ 21.901306] systemd[1]: Reached target Reactivate sysinit units.910machine # [ 21.905126] systemd[1]: Reached target Remote File Systems.911machine # [ 21.910172] systemd[1]: Reached target Local File Systems.912machine # [ 21.913146] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore913machine # [ 21.917476] systemd[1]: Starting Create SUID/SGID Wrappers...914machine # [ 21.918333] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.915machine # [ 21.919523] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67916machine # [ 21.922955] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore917machine # [ 21.932157] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os918machine # [ 21.933449] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os919machine # [ 21.934605] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os920machine # [ 21.935833] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki921machine # [ 22.235691] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.922machine # [ 22.237638] systemd[1]: Finished Create SUID/SGID Wrappers.923machine # [ 22.243631] systemd[1]: Starting linger-users.service...924machine # [ 22.302181] systemd[1]: linger-users.service: Deactivated successfully.925machine # [ 22.304591] systemd[1]: Finished linger-users.service.926machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service927machine # [ 22.567781] nixos[836]: finished switching to system configuration /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test928machine: (finished: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/bin/switch-to-configuration test, in 3.13 seconds)929machine: must succeed: rm /etc/NIXOS930machine: (finished: must succeed: rm /etc/NIXOS, in 0.05 seconds)931machine: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/h7cjjcq34gik896rnm34qkpr3psnxwz8-nixos-system-other-test/bin/switch-to-configuration test932machine # this should succeed (config: /nix/store/h7cjjcq34gik896rnm34qkpr3psnxwz8-nixos-system-other-test, action: test)933machine # Checking switch inhibitors... done934machine # [ 23.220960] nixos[984]: switching to system configuration /nix/store/h7cjjcq34gik896rnm34qkpr3psnxwz8-nixos-system-other-test935machine # [ 23.223637] systemd[1]: Stopped target Local File Systems.936machine # activating the configuration...937machine # [ 23.226319] systemd[1]: Stopped target Remote File Systems.938machine # removing user ‘usertest’939machine # setting up /etc...940machine # [ 23.693262] systemd[1]: Reload requested from client PID 984 ('.switch-to-conf') (unit backdoor.service)...941machine # [ 23.695028] systemd[1]: Reloading...942machine # [ 24.299871] systemd[1]: Reloading finished in 602 ms.943machine # reloading user units for usertest...944machine # [ 24.451840] systemd[581]: Reexecution requested from client PID 1055 ('switch-to-confi')...945machine # [ 24.454088] systemd[581]: Reexecuting.946machine # [ 24.518188] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy947machine # [ 24.713398] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy948machine # [ 24.719860] systemd[581]: Reload requested from client PID 1055 ('switch-to-confi')...949machine # [ 24.722407] systemd[581]: Reloading...950machine # [ 24.903686] systemd[581]: Reloading finished in 180 ms.951machine # [ 24.916156] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy952machine # restarting the following user units: nixos-activation.service953machine # [ 24.926328] systemd[581]: Stopped Run user-specific NixOS activation.954machine # [ 24.928681] systemd[581]: Stopping Run user-specific NixOS activation...955machine # [ 24.931586] systemd[581]: Starting Run user-specific NixOS activation...956machine # [ 24.975651] systemd[581]: Finished Run user-specific NixOS activation.957machine # restarting sysinit-reactivation.target958machine # [ 24.980127] systemd[1]: Stopped target Reactivate sysinit units.959machine # reloading the following units: dbus-broker.service960machine # [ 24.982950] systemd[1]: Stopping Reactivate sysinit units...961machine # [ 24.983816] systemd[1]: Reached target Reactivate sysinit units.962machine # [ 24.986683] systemd[1]: Reloading D-Bus System Message Bus...963machine # [ 24.988573] dbus-broker-launch[486]: Caught SIGHUP, trigger reload.964machine # [ 25.007108] dbus-broker-launch[486]: Looking up NSS user entry for 'systemd-timesync'...965machine # [ 25.009192] dbus-broker-launch[486]: NSS returned no entry for 'systemd-timesync'966machine # [ 25.010373] dbus-broker-launch[486]: Invalid user-name in /nix/store/2d37a0ag8593x6bsc14irprkj2vpg80c-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"967machine # [ 25.045749] systemd[1]: Reloaded D-Bus System Message Bus.968machine # restarting the following units: network-addresses-eth1.service969machine # [ 25.052121] systemd[1]: Stopping Address configuration of eth1...970machine # [ 25.115114] network-addresses-eth1-pre-stop[1067]: deleting address 192.168.1.1/24... done971machine # [ 25.127236] network-addresses-eth1-pre-stop[1067]: deleting address 2001:db8:1::1/64... done972machine # [ 25.138491] systemd[1]: network-addresses-eth1.service: Deactivated successfully.973machine # [ 25.142607] systemd[1]: Stopped Address configuration of eth1.974machine # [ 25.144828] systemd[1]: Starting Address configuration of eth1...975machine # [ 25.217428] network-addresses-eth1-start[1072]: adding address 192.168.1.2/24... done976machine # [ 25.228823] network-addresses-eth1-start[1072]: adding address 2001:db8:1::2/64... done977machine # [ 25.243302] systemd[1]: Finished Address configuration of eth1.978machine # [ 25.247929] systemd[1]: Reached target Local File Systems.979machine # [ 25.251477] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore980machine # [ 25.255560] systemd[1]: Starting Create SUID/SGID Wrappers...981machine # [ 25.258168] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.982machine # [ 25.265006] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67983machine # [ 25.267654] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore984machine # [ 25.273386] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os985machine # [ 25.274790] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os986machine # [ 25.276401] systemd[1]: Reached target Remote File Systems.987machine # [ 25.277618] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os988machine # [ 25.282892] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki989machine # [ 25.631589] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.990machine # [ 25.634173] systemd[1]: Finished Create SUID/SGID Wrappers.991machine # [ 25.638870] systemd[1]: Starting linger-users.service...992machine # [ 25.684217] linger-users-start[1145]: id: ‘usertest’: no such user993machine # [ 25.686582] linger-users-start[1143]: Removing linger for missing user usertest994machine # [ 25.695152] systemd[1]: linger-users.service: Deactivated successfully.995machine # [ 25.697115] systemd[1]: Finished linger-users.service.996machine # [ 25.956557] nixos[984]: finished switching to system configuration /nix/store/h7cjjcq34gik896rnm34qkpr3psnxwz8-nixos-system-other-test997machine: (finished: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/h7cjjcq34gik896rnm34qkpr3psnxwz8-nixos-system-other-test/bin/switch-to-configuration test, in 3.34 seconds)998subtest: services999machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/bin/switch-to-configuration test 2>&11000machine # [ 26.512257] nixos[1151]: switching to system configuration /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test1001machine # [ 26.514602] systemd[1]: Stopped target Remote File Systems.1002machine # [ 26.516743] systemd[1]: Stopped target Local File Systems.1003machine # [ 26.930009] systemd[1]: Reload requested from client PID 1151 ('.switch-to-conf') (unit backdoor.service)...1004machine # [ 26.931895] systemd[1]: Reloading...1005machine # [ 27.474596] systemd[1]: Reloading finished in 540 ms.1006machine # [ 27.609237] systemd[581]: Reexecution requested from client PID 1220 ('switch-to-confi')...1007machine # [ 27.612539] systemd[581]: Reexecuting.1008machine # [ 27.673906] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1009machine # [ 27.858152] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1010machine # [ 27.863949] systemd[581]: Reload requested from client PID 1220 ('switch-to-confi')...1011machine # [ 27.866331] systemd[581]: Reloading...1012machine # [ 28.043267] systemd[581]: Reloading finished in 175 ms.1013machine # [ 28.056130] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1014machine # [ 28.064071] systemd[581]: Stopped Run user-specific NixOS activation.1015machine # [ 28.065030] systemd[581]: Stopping Run user-specific NixOS activation...1016machine # [ 28.068399] systemd[581]: Starting Run user-specific NixOS activation...1017machine # [ 28.109417] systemd[581]: Finished Run user-specific NixOS activation.1018machine # [ 28.113413] systemd[1]: Stopped target Reactivate sysinit units.1019machine # [ 28.114706] systemd[1]: Stopping Reactivate sysinit units...1020machine # [ 28.115532] systemd[1]: Reached target Reactivate sysinit units.1021machine # [ 28.118621] systemd[1]: Reloading D-Bus System Message Bus...1022machine # [ 28.120348] dbus-broker-launch[486]: Caught SIGHUP, trigger reload.1023machine # [ 28.133092] dbus-broker-launch[486]: Looking up NSS user entry for 'systemd-timesync'...1024machine # [ 28.135064] dbus-broker-launch[486]: NSS returned no entry for 'systemd-timesync'1025machine # [ 28.136274] dbus-broker-launch[486]: Invalid user-name in /nix/store/q9kni4k6lchfc3fafb6a1yk6yvf86s3s-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1026machine # [ 28.160206] systemd[1]: Reloaded D-Bus System Message Bus.1027machine # [ 28.165601] systemd[1]: Stopping Address configuration of eth1...1028machine # [ 28.208655] network-addresses-eth1-pre-stop[1232]: deleting address 192.168.1.2/24... done1029machine # [ 28.218834] network-addresses-eth1-pre-stop[1232]: deleting address 2001:db8:1::2/64... done1030machine # [ 28.227572] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1031machine # [ 28.231181] systemd[1]: Stopped Address configuration of eth1.1032machine # [ 28.233433] systemd[1]: Starting Address configuration of eth1...1033machine # [ 28.296465] network-addresses-eth1-start[1237]: adding address 192.168.1.1/24... done1034machine # [ 28.306946] network-addresses-eth1-start[1237]: adding address 2001:db8:1::1/64... done1035machine # [ 28.320804] systemd[1]: Finished Address configuration of eth1.1036machine # [ 28.323535] systemd[1]: Reached target Local File Systems.1037machine # [ 28.325742] systemd[1]: Reached target Remote File Systems.1038machine # [ 28.327519] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1039machine # [ 28.330185] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1040machine # [ 28.334984] systemd[1]: Starting linger-users.service...1041machine # [ 28.346775] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1042machine # [ 28.350734] systemd[1]: Starting Create SUID/SGID Wrappers...1043machine # [ 28.351574] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1044machine # [ 28.355500] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671045machine # [ 28.360328] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1046machine # [ 28.361870] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1047machine # [ 28.365678] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1048machine # [ 28.415624] systemd[1]: linger-users.service: Deactivated successfully.1049machine # [ 28.418388] systemd[1]: Finished linger-users.service.1050machine # [ 28.695823] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1051machine # [ 28.698484] systemd[1]: Finished Create SUID/SGID Wrappers.1052machine # [ 28.957814] nixos[1151]: finished switching to system configuration /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test1053machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.00 seconds)1054machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/bin/switch-to-configuration test 2>&11055machine # [ 29.544640] nixos[1307]: switching to system configuration /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test1056machine # [ 29.548788] systemd[1]: Stopped target Local File Systems.1057machine # [ 29.549936] systemd[1]: Stopped target Remote File Systems.1058machine # [ 29.997770] systemd[1]: Reload requested from client PID 1307 ('.switch-to-conf') (unit backdoor.service)...1059machine # [ 29.999992] systemd[1]: Reloading...1060machine # [ 30.609016] systemd[1]: Reloading finished in 606 ms.1061machine # [ 30.753622] systemd[581]: Reexecution requested from client PID 1376 ('switch-to-confi')...1062machine # [ 30.758108] systemd[581]: Reexecuting.1063machine # [ 30.821954] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1064machine # [ 31.022702] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1065machine # [ 31.031674] systemd[581]: Reload requested from client PID 1376 ('switch-to-confi')...1066machine # [ 31.034547] systemd[581]: Reloading...1067machine # [ 31.267322] systemd[581]: Reloading finished in 231 ms.1068machine # [ 31.280254] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1069machine # [ 31.293826] systemd[581]: Stopped Run user-specific NixOS activation.1070machine # [ 31.294861] systemd[581]: Stopping Run user-specific NixOS activation...1071machine # [ 31.298149] systemd[581]: Starting Run user-specific NixOS activation...1072machine # [ 31.353234] systemd[581]: Finished Run user-specific NixOS activation.1073machine # [ 31.358995] systemd[1]: Stopped target Reactivate sysinit units.1074machine # [ 31.361528] systemd[1]: Stopping Reactivate sysinit units...1075machine # [ 31.362377] systemd[1]: Reached target Reactivate sysinit units.1076machine # [ 31.369954] systemd[1]: Reached target Local File Systems.1077machine # [ 31.372622] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1078machine # [ 31.379517] systemd[1]: Starting Create SUID/SGID Wrappers...1079machine # [ 31.382841] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1080machine # [ 31.388579] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671081machine # [ 31.390772] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1082machine # [ 31.402027] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1083machine # [ 31.403467] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1084machine # [ 31.407853] systemd[1]: Reached target Remote File Systems.1085machine # [ 31.408790] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1086machine # [ 31.410065] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1087machine # [ 31.855716] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1088machine # [ 31.863867] systemd[1]: Finished Create SUID/SGID Wrappers.1089machine # [ 31.867583] systemd[1]: Starting linger-users.service...1090machine # [ 31.954918] systemd[1]: linger-users.service: Deactivated successfully.1091machine # [ 31.957738] systemd[1]: Finished linger-users.service.1092machine # [ 32.223767] nixos[1307]: finished switching to system configuration /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test1093machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.27 seconds)1094machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11095machine # [ 33.023766] nixos[1448]: switching to system configuration /nix/store/lxdwfgd5c934743c3whv68kagkbv8rj8-nixos-system-machine-test1096machine # [ 33.027483] systemd[1]: Stopped target Local File Systems.1097machine # [ 33.028914] systemd[1]: Stopped target Remote File Systems.1098machine # [ 33.528245] systemd[1]: Reload requested from client PID 1448 ('.switch-to-conf') (unit backdoor.service)...1099machine # [ 33.530179] systemd[1]: Reloading...1100machine # [ 34.151436] systemd[1]: Reloading finished in 618 ms.1101machine # [ 34.290802] systemd[581]: Reexecution requested from client PID 1517 ('switch-to-confi')...1102machine # [ 34.292837] systemd[581]: Reexecuting.1103machine # [ 34.362014] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1104machine # [ 34.549636] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1105machine # [ 34.555715] systemd[581]: Reload requested from client PID 1517 ('switch-to-confi')...1106machine # [ 34.558162] systemd[581]: Reloading...1107machine # [ 34.735922] systemd[581]: Reloading finished in 177 ms.1108machine # [ 34.748135] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1109machine # [ 34.757988] systemd[581]: Stopped Run user-specific NixOS activation.1110machine # [ 34.760154] systemd[581]: Stopping Run user-specific NixOS activation...1111machine # [ 34.762806] systemd[581]: Starting Run user-specific NixOS activation...1112machine # [ 34.807138] systemd[581]: Finished Run user-specific NixOS activation.1113machine # [ 34.810815] systemd[1]: Stopped target Reactivate sysinit units.1114machine # [ 34.812712] systemd[1]: Stopping Reactivate sysinit units...1115machine # [ 34.813949] systemd[1]: Reached target Reactivate sysinit units.1116machine # [ 34.818007] systemd[1]: Reached target Remote File Systems.1117machine # [ 34.820338] systemd[1]: Starting linger-users.service...1118machine # [ 34.823971] systemd[1]: Starting test.service...1119machine # [ 34.840586] systemd[1]: Reached target Local File Systems.1120machine # [ 34.841575] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1121machine # [ 34.846025] systemd[1]: Starting Create SUID/SGID Wrappers...1122machine # [ 34.846889] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1123machine # [ 34.853107] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671124machine # [ 34.859165] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1125machine # [ 34.862704] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1126machine # [ 34.865411] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1127machine # [ 34.867779] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1128machine # [ 34.870298] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1129machine # [ 34.896073] systemd[1]: Finished test.service.1130machine # [ 34.930381] systemd[1]: linger-users.service: Deactivated successfully.1131machine # [ 34.933323] systemd[1]: Finished linger-users.service.1132machine # [ 35.213171] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1133machine # [ 35.215842] systemd[1]: Finished Create SUID/SGID Wrappers.1134machine # [ 35.473919] nixos[1448]: finished switching to system configuration /nix/store/lxdwfgd5c934743c3whv68kagkbv8rj8-nixos-system-machine-test1135machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 3.24 seconds)1136machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11137machine # [ 36.032109] nixos[1591]: switching to system configuration /nix/store/lxdwfgd5c934743c3whv68kagkbv8rj8-nixos-system-machine-test1138machine # [ 36.035381] systemd[1]: Stopped target Local File Systems.1139machine # [ 36.036634] systemd[1]: Stopped target Remote File Systems.1140machine # [ 36.449167] systemd[1]: Reload requested from client PID 1591 ('.switch-to-conf') (unit backdoor.service)...1141machine # [ 36.451020] systemd[1]: Reloading...1142machine # [ 37.013847] systemd[1]: Reloading finished in 560 ms.1143machine # [ 37.151267] systemd[581]: Reexecution requested from client PID 1659 ('switch-to-confi')...1144machine # [ 37.153374] systemd[581]: Reexecuting.1145machine # [ 37.218615] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1146machine # [ 37.404192] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1147machine # [ 37.411162] systemd[581]: Reload requested from client PID 1659 ('switch-to-confi')...1148machine # [ 37.413258] systemd[581]: Reloading...1149machine # [ 37.594247] systemd[581]: Reloading finished in 179 ms.1150machine # [ 37.608129] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1151machine # [ 37.617900] systemd[581]: Stopped Run user-specific NixOS activation.1152machine # [ 37.618831] systemd[581]: Stopping Run user-specific NixOS activation...1153machine # [ 37.621496] systemd[581]: Starting Run user-specific NixOS activation...1154machine # [ 37.661835] systemd[581]: Finished Run user-specific NixOS activation.1155machine # [ 37.665686] systemd[1]: Stopped target Reactivate sysinit units.1156machine # [ 37.667453] systemd[1]: Stopping Reactivate sysinit units...1157machine # [ 37.669271] systemd[1]: Reached target Reactivate sysinit units.1158machine # [ 37.672351] systemd[1]: Reached target Local File Systems.1159machine # [ 37.674428] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1160machine # [ 37.677689] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1161machine # [ 37.682142] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1162machine # [ 37.685926] systemd[1]: Starting Create SUID/SGID Wrappers...1163machine # [ 37.686755] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1164machine # [ 37.687951] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671165machine # [ 37.691726] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1166machine # [ 37.697001] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1167machine # [ 37.699317] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1168machine # [ 37.703985] systemd[1]: Reached target Remote File Systems.1169machine # [ 38.000702] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1170machine # [ 38.004420] systemd[1]: Finished Create SUID/SGID Wrappers.1171machine # [ 38.007636] systemd[1]: Starting linger-users.service...1172machine # [ 38.063116] systemd[1]: linger-users.service: Deactivated successfully.1173machine # [ 38.065208] systemd[1]: Finished linger-users.service.1174machine # [ 38.323034] nixos[1591]: finished switching to system configuration /nix/store/lxdwfgd5c934743c3whv68kagkbv8rj8-nixos-system-machine-test1175machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 2.85 seconds)1176machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&11177machine # [ 38.951937] nixos[1731]: switching to system configuration /nix/store/57cymh966qv38v1hbfbxxw2iyvk92vn8-nixos-system-machine-test1178machine # [ 38.954626] systemd[1]: Stopped target Local File Systems.1179machine # [ 38.956891] systemd[1]: Stopped target Remote File Systems.1180machine # [ 39.436710] systemd[1]: Reload requested from client PID 1731 ('.switch-to-conf') (unit backdoor.service)...1181machine # [ 39.438602] systemd[1]: Reloading...1182machine # [ 40.054943] systemd[1]: Reloading finished in 614 ms.1183machine # [ 40.190257] systemd[581]: Reexecution requested from client PID 1801 ('switch-to-confi')...1184machine # [ 40.193476] systemd[581]: Reexecuting.1185machine # [ 40.241293] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1186machine # [ 40.418508] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1187machine # [ 40.424620] systemd[581]: Reload requested from client PID 1801 ('switch-to-confi')...1188machine # [ 40.426697] systemd[581]: Reloading...1189machine # [ 40.609236] systemd[581]: Reloading finished in 181 ms.1190machine # [ 40.624143] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1191machine # [ 40.632534] systemd[581]: Stopped Run user-specific NixOS activation.1192machine # [ 40.634680] systemd[581]: Stopping Run user-specific NixOS activation...1193machine # [ 40.637353] systemd[581]: Starting Run user-specific NixOS activation...1194machine # [ 40.682537] systemd[581]: Finished Run user-specific NixOS activation.1195machine # [ 40.686261] systemd[1]: Stopped target Reactivate sysinit units.1196machine # [ 40.688290] systemd[1]: Stopping Reactivate sysinit units...1197machine # [ 40.689847] systemd[1]: Reached target Reactivate sysinit units.1198machine # [ 40.692540] systemd[1]: Reached target Remote File Systems.1199machine # [ 40.696383] systemd[1]: Starting linger-users.service...1200machine # [ 40.699400] systemd[1]: Reached target Local File Systems.1201machine # [ 40.705390] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1202machine # [ 40.706753] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1203machine # [ 40.713406] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1204machine # [ 40.717965] systemd[1]: Starting Create SUID/SGID Wrappers...1205machine # [ 40.718885] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1206machine # [ 40.728430] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671207machine # [ 40.730591] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1208machine # [ 40.733287] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1209machine # [ 40.734936] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1210machine # [ 40.791276] systemd[1]: linger-users.service: Deactivated successfully.1211machine # [ 40.792774] systemd[1]: Finished linger-users.service.1212machine # [ 41.055086] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1213machine # [ 41.058564] systemd[1]: Finished Create SUID/SGID Wrappers.1214machine # [ 41.314993] nixos[1731]: finished switching to system configuration /nix/store/57cymh966qv38v1hbfbxxw2iyvk92vn8-nixos-system-machine-test1215machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 2.99 seconds)1216machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11217machine # [ 41.964486] nixos[1872]: switching to system configuration /nix/store/r7ly5vgiiy16h1wf0db10pqxzlzffnss-nixos-system-machine-test1218machine # [ 41.966805] systemd[1]: Stopped target Local File Systems.1219machine # [ 41.969978] systemd[1]: Stopped target Remote File Systems.1220machine # [ 41.970938] systemd[1]: test.service: Deactivated successfully.1221machine # [ 41.971938] systemd[1]: Stopped Test unit.1222machine # [ 42.452703] systemd[1]: Reload requested from client PID 1872 ('.switch-to-conf') (unit backdoor.service)...1223machine # [ 42.454574] systemd[1]: Reloading...1224machine # [ 43.065637] systemd[1]: Reloading finished in 608 ms.1225machine # [ 43.200685] systemd[581]: Reexecution requested from client PID 1942 ('switch-to-confi')...1226machine # [ 43.204273] systemd[581]: Reexecuting.1227machine # [ 43.253945] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1228machine # [ 43.438235] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1229machine # [ 43.444502] systemd[581]: Reload requested from client PID 1942 ('switch-to-confi')...1230machine # [ 43.446857] systemd[581]: Reloading...1231machine # [ 43.628950] systemd[581]: Reloading finished in 180 ms.1232machine # [ 43.644143] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1233machine # [ 43.652968] systemd[581]: Stopped Run user-specific NixOS activation.1234machine # [ 43.655188] systemd[581]: Stopping Run user-specific NixOS activation...1235machine # [ 43.657836] systemd[581]: Starting Run user-specific NixOS activation...1236machine # [ 43.703951] systemd[581]: Finished Run user-specific NixOS activation.1237machine # [ 43.708718] systemd[1]: Stopped target Reactivate sysinit units.1238machine # [ 43.709669] systemd[1]: Stopping Reactivate sysinit units...1239machine # [ 43.710462] systemd[1]: Reached target Reactivate sysinit units.1240machine # [ 43.715614] systemd[1]: Reached target Local File Systems.1241machine # [ 43.718887] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1242machine # [ 43.722845] systemd[1]: Starting Create SUID/SGID Wrappers...1243machine # [ 43.723722] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1244machine # [ 43.729481] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671245machine # [ 43.736680] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1246machine # [ 43.738243] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1247machine # [ 43.739486] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1248machine # [ 43.743594] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1249machine # [ 43.747109] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1250machine # [ 43.748995] systemd[1]: Reached target Remote File Systems.1251machine # [ 44.045355] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1252machine # [ 44.049525] systemd[1]: Finished Create SUID/SGID Wrappers.1253machine # [ 44.052374] systemd[1]: Starting linger-users.service...1254machine # [ 44.056819] systemd[1]: Starting test.service...1255machine # [ 44.099241] systemd[1]: Finished test.service.1256machine # [ 44.127392] systemd[1]: linger-users.service: Deactivated successfully.1257machine # [ 44.129875] systemd[1]: Finished linger-users.service.1258machine # [ 44.388763] nixos[1872]: finished switching to system configuration /nix/store/r7ly5vgiiy16h1wf0db10pqxzlzffnss-nixos-system-machine-test1259machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 3.07 seconds)1260machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&11261machine # [ 44.996516] nixos[2015]: switching to system configuration /nix/store/8w1qkrbnln7x21ymczhvirs6win356ij-nixos-system-machine-test1262machine # [ 44.999121] systemd[1]: Stopped target Local File Systems.1263machine # [ 45.001221] systemd[1]: Stopped target Remote File Systems.1264machine # [ 45.516758] systemd[1]: Reload requested from client PID 2015 ('.switch-to-conf') (unit backdoor.service)...1265machine # [ 45.518625] systemd[1]: Reloading...1266machine # [ 46.125677] systemd[1]: Reloading finished in 604 ms.1267machine # [ 46.261968] systemd[581]: Reexecution requested from client PID 2084 ('switch-to-confi')...1268machine # [ 46.265393] systemd[581]: Reexecuting.1269machine # [ 46.325506] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1270machine # [ 46.505825] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1271machine # [ 46.511922] systemd[581]: Reload requested from client PID 2084 ('switch-to-confi')...1272machine # [ 46.514331] systemd[581]: Reloading...1273machine # [ 46.691763] systemd[581]: Reloading finished in 176 ms.1274machine # [ 46.708131] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1275machine # [ 46.717122] systemd[581]: Stopped Run user-specific NixOS activation.1276machine # [ 46.718076] systemd[581]: Stopping Run user-specific NixOS activation...1277machine # [ 46.720623] systemd[581]: Starting Run user-specific NixOS activation...1278machine # [ 46.757767] systemd[581]: Finished Run user-specific NixOS activation.1279machine # [ 46.762262] systemd[1]: Stopped target Reactivate sysinit units.1280machine # [ 46.763936] systemd[1]: Stopping Reactivate sysinit units...1281machine # [ 46.765449] systemd[1]: Reached target Reactivate sysinit units.1282machine # [ 46.768291] systemd[1]: test.service: Deactivated successfully.1283machine # [ 46.769130] systemd[1]: Stopped test.service.1284machine # [ 46.769756] systemd[1]: Stopping test.service...1285machine # [ 46.772002] systemd[1]: Starting test.service...1286machine # [ 46.804638] systemd[1]: Finished test.service.1287machine # [ 46.808336] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1288machine # [ 46.810614] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1289machine # [ 46.815467] systemd[1]: Reached target Remote File Systems.1290machine # [ 46.820179] systemd[1]: Starting linger-users.service...1291machine # [ 46.829274] systemd[1]: Reached target Local File Systems.1292machine # [ 46.830796] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1293machine # [ 46.837140] systemd[1]: Starting Create SUID/SGID Wrappers...1294machine # [ 46.837984] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1295machine # [ 46.839184] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671296machine # [ 46.842814] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1297machine # [ 46.845173] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1298machine # [ 46.849974] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1299machine # [ 46.899643] systemd[1]: linger-users.service: Deactivated successfully.1300machine # [ 46.901326] systemd[1]: Finished linger-users.service.1301machine # [ 47.162803] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1302machine # [ 47.165420] systemd[1]: Finished Create SUID/SGID Wrappers.1303machine # [ 47.421783] nixos[2015]: finished switching to system configuration /nix/store/8w1qkrbnln7x21ymczhvirs6win356ij-nixos-system-machine-test1304machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.03 seconds)1305machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&11306machine # [ 48.016553] nixos[2158]: switching to system configuration /nix/store/pna5fpaf2z3xilzibhcrvrc3gjq9zq12-nixos-system-machine-test1307machine # [ 48.018816] systemd[1]: Stopped target Local File Systems.1308machine # [ 48.020876] systemd[1]: Stopped target Remote File Systems.1309machine # [ 48.494295] systemd[1]: Reload requested from client PID 2158 ('.switch-to-conf') (unit backdoor.service)...1310machine # [ 48.496165] systemd[1]: Reloading...1311machine # [ 49.117338] systemd[1]: Reloading finished in 619 ms.1312machine # [ 49.252374] systemd[581]: Reexecution requested from client PID 2226 ('switch-to-confi')...1313machine # [ 49.253671] systemd[581]: Reexecuting.1314machine # [ 49.313408] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1315machine # [ 49.495482] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1316machine # [ 49.501557] systemd[581]: Reload requested from client PID 2226 ('switch-to-confi')...1317machine # [ 49.503824] systemd[581]: Reloading...1318machine # [ 49.680889] systemd[581]: Reloading finished in 175 ms.1319machine # [ 49.697489] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1320machine # [ 49.706537] systemd[581]: Stopped Run user-specific NixOS activation.1321machine # [ 49.708742] systemd[581]: Stopping Run user-specific NixOS activation...1322machine # [ 49.711450] systemd[581]: Starting Run user-specific NixOS activation...1323machine # [ 49.754210] systemd[581]: Finished Run user-specific NixOS activation.1324machine # [ 49.758236] systemd[1]: Stopped target Reactivate sysinit units.1325machine # [ 49.762072] systemd[1]: Stopping Reactivate sysinit units...1326machine # [ 49.763244] systemd[1]: Reached target Reactivate sysinit units.1327machine # [ 49.765519] systemd[1]: Reloading test.service...1328machine # [ 49.796235] systemd[1]: Reloaded test.service.1329machine # [ 49.801932] systemd[1]: Reached target Local File Systems.1330machine # [ 49.804824] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1331machine # [ 49.809729] systemd[1]: Starting Create SUID/SGID Wrappers...1332machine # [ 49.810601] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1333machine # [ 49.811769] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671334machine # [ 49.816854] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1335machine # [ 49.820417] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1336machine # [ 49.829479] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1337machine # [ 49.830670] systemd[1]: Reached target Remote File Systems.1338machine # [ 49.831411] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1339machine # [ 49.832795] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1340machine # [ 50.130578] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1341machine # [ 50.134535] systemd[1]: Finished Create SUID/SGID Wrappers.1342machine # [ 50.136758] systemd[1]: Starting linger-users.service...1343machine # [ 50.191087] systemd[1]: linger-users.service: Deactivated successfully.1344machine # [ 50.193180] systemd[1]: Finished linger-users.service.1345machine # [ 50.450669] nixos[2158]: finished switching to system configuration /nix/store/pna5fpaf2z3xilzibhcrvrc3gjq9zq12-nixos-system-machine-test1346machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 3.03 seconds)1347machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&11348machine # [ 51.046321] nixos[2300]: switching to system configuration /nix/store/12zh8y7plvai6dd6gnzisvgwx1593956-nixos-system-machine-test1349machine # [ 51.048956] systemd[1]: Stopped target Local File Systems.1350machine # [ 51.051320] systemd[1]: Stopped target Remote File Systems.1351machine # [ 51.540759] systemd[1]: Reload requested from client PID 2300 ('.switch-to-conf') (unit backdoor.service)...1352machine # [ 51.542712] systemd[1]: Reloading...1353machine # [ 52.190356] systemd[1]: Reloading finished in 645 ms.1354machine # [ 52.338109] systemd[581]: Reexecution requested from client PID 2369 ('switch-to-confi')...1355machine # [ 52.342434] systemd[581]: Reexecuting.1356machine # [ 52.410020] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1357machine # [ 52.605861] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1358machine # [ 52.613294] systemd[581]: Reload requested from client PID 2369 ('switch-to-confi')...1359machine # [ 52.614661] systemd[581]: Reloading...1360machine # [ 52.803378] systemd[581]: Reloading finished in 187 ms.1361machine # [ 52.816157] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1362machine # [ 52.825122] systemd[581]: Stopped Run user-specific NixOS activation.1363machine # [ 52.827474] systemd[581]: Stopping Run user-specific NixOS activation...1364machine # [ 52.830241] systemd[581]: Starting Run user-specific NixOS activation...1365machine # [ 52.876075] systemd[581]: Finished Run user-specific NixOS activation.1366machine # [ 52.880190] systemd[1]: Stopped target Reactivate sysinit units.1367machine # [ 52.882365] systemd[1]: Stopping Reactivate sysinit units...1368machine # [ 52.884326] systemd[1]: Reached target Reactivate sysinit units.1369machine # [ 52.889134] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1370machine # [ 52.891542] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1371machine # [ 52.896529] systemd[1]: Reached target Remote File Systems.1372machine # [ 52.898920] systemd[1]: Starting linger-users.service...1373machine # [ 52.903197] systemd[1]: Reached target Local File Systems.1374machine # [ 52.908328] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1375machine # [ 52.914012] systemd[1]: Starting Create SUID/SGID Wrappers...1376machine # [ 52.914976] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1377machine # [ 52.922347] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671378machine # [ 52.926770] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1379machine # [ 52.929529] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1380machine # [ 52.930845] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1381machine # [ 52.988530] systemd[1]: linger-users.service: Deactivated successfully.1382machine # [ 52.991562] systemd[1]: Finished linger-users.service.1383machine # [ 53.248188] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1384machine # [ 53.251241] systemd[1]: Finished Create SUID/SGID Wrappers.1385machine # [ 53.511053] nixos[2300]: finished switching to system configuration /nix/store/12zh8y7plvai6dd6gnzisvgwx1593956-nixos-system-machine-test1386machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 3.06 seconds)1387machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&11388machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.69 seconds)1389machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/bin/switch-to-configuration test 2>&11390machine # [ 54.737801] nixos[2450]: switching to system configuration /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test1391machine # [ 54.741647] systemd[1]: Stopped target Local File Systems.1392machine # [ 54.743348] systemd[1]: Stopped target Remote File Systems.1393machine # [ 54.744792] systemd[1]: test.service: Deactivated successfully.1394machine # [ 54.745617] systemd[1]: Stopped test.service.1395machine # [ 55.181181] systemd[1]: Reload requested from client PID 2450 ('.switch-to-conf') (unit backdoor.service)...1396machine # [ 55.183082] systemd[1]: Reloading...1397machine # [ 55.757801] systemd[1]: Reloading finished in 572 ms.1398machine # [ 55.892804] systemd[581]: Reexecution requested from client PID 2518 ('switch-to-confi')...1399machine # [ 55.896947] systemd[581]: Reexecuting.1400machine # [ 55.942519] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1401machine # [ 56.122528] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1402machine # [ 56.128716] systemd[581]: Reload requested from client PID 2518 ('switch-to-confi')...1403machine # [ 56.130975] systemd[581]: Reloading...1404machine # [ 56.310682] systemd[581]: Reloading finished in 178 ms.1405machine # [ 56.324141] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1406machine # [ 56.332644] systemd[581]: Stopped Run user-specific NixOS activation.1407machine # [ 56.334795] systemd[581]: Stopping Run user-specific NixOS activation...1408machine # [ 56.337462] systemd[581]: Starting Run user-specific NixOS activation...1409machine # [ 56.379774] systemd[581]: Finished Run user-specific NixOS activation.1410machine # [ 56.383658] systemd[1]: Stopped target Reactivate sysinit units.1411machine # [ 56.385304] systemd[1]: Stopping Reactivate sysinit units...1412machine # [ 56.386133] systemd[1]: Reached target Reactivate sysinit units.1413machine # [ 56.387635] systemd[1]: Reached target Remote File Systems.1414machine # [ 56.393549] systemd[1]: Starting linger-users.service...1415machine # [ 56.402865] systemd[1]: Reached target Local File Systems.1416machine # [ 56.403965] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1417machine # [ 56.412386] systemd[1]: Starting Create SUID/SGID Wrappers...1418machine # [ 56.413248] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1419machine # [ 56.414437] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671420machine # [ 56.424874] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1421machine # [ 56.426651] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1422machine # [ 56.428546] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1423machine # [ 56.430630] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1424machine # [ 56.432243] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1425machine # [ 56.485065] systemd[1]: linger-users.service: Deactivated successfully.1426machine # [ 56.487456] systemd[1]: Finished linger-users.service.1427machine # [ 56.737644] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1428machine # [ 56.741006] systemd[1]: Finished Create SUID/SGID Wrappers.1429machine # [ 56.999194] nixos[2450]: finished switching to system configuration /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test1430machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.80 seconds)1431machine: must succeed: /nix/store/d6ryfp12kfvzvs5yhn3y5nagh1ilpa08-separate-activation-script/bin/switch-to-configuration test 2>&11432machine # [ 57.582820] nixos[2590]: switching to system configuration /nix/store/9jjx92m9ym6whrg55xyvnjf1krr5frad-nixos-system-machine-test1433machine # [ 57.585507] systemd[1]: Stopped target Local File Systems.1434machine # [ 57.587644] systemd[1]: Stopped target Remote File Systems.1435machine # [ 58.070962] systemd[1]: Reload requested from client PID 2590 ('.switch-to-conf') (unit backdoor.service)...1436machine # [ 58.073026] systemd[1]: Reloading...1437machine # [ 58.644675] systemd[1]: Reloading finished in 569 ms.1438machine # [ 58.794446] systemd[581]: Stopped Run user-specific NixOS activation.1439machine # [ 58.798781] systemd[581]: Reexecution requested from client PID 2658 ('switch-to-confi')...1440machine # [ 58.800516] systemd[581]: Reexecuting.1441machine # [ 58.853483] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1442machine # [ 59.041596] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1443machine # [ 59.047950] systemd[581]: Reload requested from client PID 2658 ('switch-to-confi')...1444machine # [ 59.050340] systemd[581]: Reloading...1445machine # [ 59.229448] systemd[581]: Reloading finished in 176 ms.1446machine # [ 59.240131] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1447machine # [ 59.249994] systemd[1]: Stopped target Reactivate sysinit units.1448machine # [ 59.250934] systemd[1]: Stopping Reactivate sysinit units...1449machine # [ 59.251725] systemd[1]: Reached target Reactivate sysinit units.1450machine # [ 59.254319] systemd[1]: Reached target Remote File Systems.1451machine # [ 59.256847] systemd[1]: Reached target Local File Systems.1452machine # [ 59.259995] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1453machine # [ 59.263900] systemd[1]: Starting Create SUID/SGID Wrappers...1454machine # [ 59.266318] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1455machine # [ 59.273344] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671456machine # [ 59.275550] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1457machine # [ 59.281542] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1458machine # [ 59.282817] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1459machine # [ 59.285030] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1460machine # [ 59.286311] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1461machine # [ 59.578160] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1462machine # [ 59.582650] systemd[1]: Finished Create SUID/SGID Wrappers.1463machine # [ 59.586143] systemd[1]: Starting linger-users.service...1464machine # [ 59.589114] systemd[1]: Starting test.service...1465machine # [ 59.631183] systemd[1]: Finished test.service.1466machine # [ 59.656139] systemd[1]: linger-users.service: Deactivated successfully.1467machine # [ 59.658744] systemd[1]: Finished linger-users.service.1468machine # [ 59.916557] nixos[2590]: finished switching to system configuration /nix/store/9jjx92m9ym6whrg55xyvnjf1krr5frad-nixos-system-machine-test1469machine: (finished: must succeed: /nix/store/d6ryfp12kfvzvs5yhn3y5nagh1ilpa08-separate-activation-script/bin/switch-to-configuration test 2>&1, in 2.92 seconds)1470machine: must succeed: ! test -e /run/current-system/activate1471machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.03 seconds)1472machine: must succeed: ! test -e /run/current-system/dry-activate1473machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.03 seconds)1474machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration1475machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.02 seconds)1476machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&11477machine # [ 60.563875] nixos[2738]: switching to system configuration /nix/store/zzz8fhr5yfj7x3lqx0bmd9zcbq46prmy-nixos-system-machine-test1478machine # [ 60.567405] systemd[1]: Stopped target Local File Systems.1479machine # [ 60.569129] systemd[1]: Stopped target Remote File Systems.1480machine # [ 60.569907] systemd[1]: test.service: Deactivated successfully.1481machine # [ 60.570705] systemd[1]: Stopped test.service.1482machine # [ 61.053516] systemd[1]: Reload requested from client PID 2738 ('.switch-to-conf') (unit backdoor.service)...1483machine # [ 61.055380] systemd[1]: Reloading...1484machine # [ 61.684572] systemd[1]: Reloading finished in 627 ms.1485machine # [ 61.815762] systemd[581]: Reexecution requested from client PID 2806 ('switch-to-confi')...1486machine # [ 61.819259] systemd[581]: Reexecuting.1487machine # [ 61.881540] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1488machine # [ 62.061297] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1489machine # [ 62.067653] systemd[581]: Reload requested from client PID 2806 ('switch-to-confi')...1490machine # [ 62.070041] systemd[581]: Reloading...1491machine # [ 62.246801] systemd[581]: Reloading finished in 175 ms.1492machine # [ 62.260136] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1493machine # [ 62.270836] systemd[581]: Starting Run user-specific NixOS activation...1494machine # [ 62.314200] systemd[581]: Finished Run user-specific NixOS activation.1495machine # [ 62.316769] systemd[581]: Stopped Run user-specific NixOS activation.1496machine # [ 62.318803] systemd[581]: Stopping Run user-specific NixOS activation...1497machine # [ 62.321600] systemd[581]: Starting Run user-specific NixOS activation...1498machine # [ 62.324716] systemd[1]: Stopped target Reactivate sysinit units.1499machine # [ 62.325571] systemd[1]: Stopping Reactivate sysinit units...1500machine # [ 62.326369] systemd[1]: Reached target Reactivate sysinit units.1501machine # [ 62.333322] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1502machine # [ 62.339131] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1503machine # [ 62.340979] systemd[1]: Reached target Remote File Systems.1504machine # [ 62.344003] systemd[1]: Starting linger-users.service...1505machine # [ 62.348221] systemd[1]: Reached target Local File Systems.1506machine # [ 62.367545] systemd[1]: Started test.service.1507machine # [ 62.379270] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1508machine # [ 62.394369] systemd[1]: Starting Create SUID/SGID Wrappers...1509machine # [ 62.395206] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1510machine # [ 62.401072] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671511machine # [ 62.403842] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1512machine # [ 62.406480] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1513machine # [ 62.409171] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1514machine # [ 62.411443] systemd[581]: Finished Run user-specific NixOS activation.1515machine # [ 62.444496] systemd[1]: test.service: Deactivated successfully.1516machine # [ 62.465167] systemd[1]: linger-users.service: Deactivated successfully.1517machine # [ 62.468197] systemd[1]: Finished linger-users.service.1518machine # [ 62.733158] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1519machine # [ 62.736256] systemd[1]: Finished Create SUID/SGID Wrappers.1520machine # [ 62.993043] nixos[2738]: finished switching to system configuration /nix/store/zzz8fhr5yfj7x3lqx0bmd9zcbq46prmy-nixos-system-machine-test1521machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 3.00 seconds)1522machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&11523machine # [ 63.595027] nixos[2883]: switching to system configuration /nix/store/9rdif6mjxhcqb7zv79czddfxz8vy96ng-nixos-system-machine-test1524machine # [ 63.597776] systemd[1]: Stopped target Local File Systems.1525machine # [ 63.600141] systemd[1]: Stopped target Remote File Systems.1526machine # [ 64.085209] systemd[1]: Reload requested from client PID 2883 ('.switch-to-conf') (unit backdoor.service)...1527machine # [ 64.087081] systemd[1]: Reloading...1528machine # [ 64.706212] systemd[1]: Reloading finished in 616 ms.1529machine # [ 64.847320] systemd[581]: Reexecution requested from client PID 2951 ('switch-to-confi')...1530machine # [ 64.850909] systemd[581]: Reexecuting.1531machine # [ 64.913691] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1532machine # [ 65.105000] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1533machine # [ 65.111744] systemd[581]: Reload requested from client PID 2951 ('switch-to-confi')...1534machine # [ 65.114809] systemd[581]: Reloading...1535machine # [ 65.298629] systemd[581]: Reloading finished in 184 ms.1536machine # [ 65.312141] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1537machine # [ 65.320632] systemd[581]: Stopped Run user-specific NixOS activation.1538machine # [ 65.322836] systemd[581]: Stopping Run user-specific NixOS activation...1539machine # [ 65.325757] systemd[581]: Starting Run user-specific NixOS activation...1540machine # [ 65.371490] systemd[581]: Finished Run user-specific NixOS activation.1541machine # [ 65.375381] systemd[1]: Stopped target Reactivate sysinit units.1542machine # [ 65.377053] systemd[1]: Stopping Reactivate sysinit units...1543machine # [ 65.377824] systemd[1]: Reached target Reactivate sysinit units.1544machine # [ 65.381437] systemd[1]: Reached target Local File Systems.1545machine # [ 65.384553] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1546machine # [ 65.388811] systemd[1]: Starting Create SUID/SGID Wrappers...1547machine # [ 65.389659] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1548machine # [ 65.390876] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671549machine # [ 65.403862] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1550machine # [ 65.406735] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1551machine # [ 65.408988] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1552machine # [ 65.410187] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1553machine # [ 65.411532] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1554machine # [ 65.414874] systemd[1]: Reached target Remote File Systems.1555machine # [ 65.717610] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1556machine # [ 65.720698] systemd[1]: Finished Create SUID/SGID Wrappers.1557machine # [ 65.724392] systemd[1]: Starting escaped\x2ddash.service...1558machine # [ 65.728720] systemd[1]: Starting linger-users.service...1559machine # [ 65.771555] systemd[1]: Finished escaped\x2ddash.service.1560machine # [ 65.799074] systemd[1]: linger-users.service: Deactivated successfully.1561machine # [ 65.801918] systemd[1]: Finished linger-users.service.1562machine # [ 66.060939] nixos[2883]: finished switching to system configuration /nix/store/9rdif6mjxhcqb7zv79czddfxz8vy96ng-nixos-system-machine-test1563machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 3.07 seconds)1564machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&11565machine # [ 66.723467] nixos[3025]: switching to system configuration /nix/store/qxjgf5pnzfivsn440rn8zbjz6p9das1x-nixos-system-machine-test1566machine # [ 66.727852] systemd[1]: Stopped target Local File Systems.1567machine # [ 66.729681] systemd[1]: Stopped target Remote File Systems.1568machine # [ 66.730510] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1569machine # [ 66.731464] systemd[1]: Stopped escaped\x2ddash.service.1570machine # [ 67.230292] systemd[1]: Reload requested from client PID 3025 ('.switch-to-conf') (unit backdoor.service)...1571machine # [ 67.232779] systemd[1]: Reloading...1572machine # [ 67.910572] systemd[1]: Reloading finished in 675 ms.1573machine # [ 68.067828] systemd[581]: Reexecution requested from client PID 3094 ('switch-to-confi')...1574machine # [ 68.070307] systemd[581]: Reexecuting.1575machine # [ 68.138800] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1576machine # [ 68.332117] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1577machine # [ 68.338828] systemd[581]: Reload requested from client PID 3094 ('switch-to-confi')...1578machine # [ 68.341198] systemd[581]: Reloading...1579machine # [ 68.530700] systemd[581]: Reloading finished in 188 ms.1580machine # [ 68.548149] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1581machine # [ 68.557460] systemd[581]: Stopped Run user-specific NixOS activation.1582machine # [ 68.559745] systemd[581]: Stopping Run user-specific NixOS activation...1583machine # [ 68.562564] systemd[581]: Starting Run user-specific NixOS activation...1584machine # [ 68.609348] systemd[581]: Finished Run user-specific NixOS activation.1585machine # [ 68.613628] systemd[1]: Stopped target Reactivate sysinit units.1586machine # [ 68.615529] systemd[1]: Stopping Reactivate sysinit units...1587machine # [ 68.617558] systemd[1]: Reached target Reactivate sysinit units.1588machine # [ 68.619929] systemd[1]: Reached target Local File Systems.1589machine # [ 68.623538] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1590machine # [ 68.628326] systemd[1]: Starting Create SUID/SGID Wrappers...1591machine # [ 68.629187] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1592machine # [ 68.630471] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671593machine # [ 68.634545] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1594machine # [ 68.644240] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1595machine # [ 68.647993] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1596machine # [ 68.649772] systemd[1]: Reached target Remote File Systems.1597machine # [ 68.651579] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1598machine # [ 68.654511] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1599machine # [ 68.961574] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1600machine # [ 68.966097] systemd[1]: Finished Create SUID/SGID Wrappers.1601machine # [ 68.969694] systemd[1]: Starting escaped\x2ddash.service...1602machine # [ 68.972849] systemd[1]: Starting linger-users.service...1603machine # [ 69.016461] systemd[1]: Finished escaped\x2ddash.service.1604machine # [ 69.042937] systemd[1]: linger-users.service: Deactivated successfully.1605machine # [ 69.045559] systemd[1]: Finished linger-users.service.1606machine # [ 69.303517] nixos[3025]: finished switching to system configuration /nix/store/qxjgf5pnzfivsn440rn8zbjz6p9das1x-nixos-system-machine-test1607machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 3.24 seconds)1608machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&11609machine # [ 69.935250] nixos[3167]: switching to system configuration /nix/store/qxznba6gr7f2v16rrc458a401zgxyyy8-nixos-system-machine-test1610machine # [ 69.939002] systemd[1]: Stopped target Local File Systems.1611machine # [ 69.940828] systemd[1]: Stopped target Remote File Systems.1612machine # [ 69.941657] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1613machine # [ 69.942633] systemd[1]: Stopped escaped\x2ddash.service.1614machine # [ 70.454253] systemd[1]: Reload requested from client PID 3167 ('.switch-to-conf') (unit backdoor.service)...1615machine # [ 70.456356] systemd[1]: Reloading...1616machine # [ 71.093766] systemd[1]: Reloading finished in 635 ms.1617machine # [ 71.246842] systemd[581]: Reexecution requested from client PID 3236 ('switch-to-confi')...1618machine # [ 71.249945] systemd[581]: Reexecuting.1619machine # [ 71.298441] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1620machine # [ 71.497026] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1621machine # [ 71.503770] systemd[581]: Reload requested from client PID 3236 ('switch-to-confi')...1622machine # [ 71.506087] systemd[581]: Reloading...1623machine # [ 71.696264] systemd[581]: Reloading finished in 189 ms.1624machine # [ 71.713544] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1625machine # [ 71.720737] systemd[581]: Stopped Run user-specific NixOS activation.1626machine # [ 71.722967] systemd[581]: Stopping Run user-specific NixOS activation...1627machine # [ 71.725780] systemd[581]: Starting Run user-specific NixOS activation...1628machine # [ 71.773558] systemd[581]: Finished Run user-specific NixOS activation.1629machine # [ 71.777633] systemd[1]: Stopped target Reactivate sysinit units.1630machine # [ 71.780742] systemd[1]: Stopping Reactivate sysinit units...1631machine # [ 71.781609] systemd[1]: Reached target Reactivate sysinit units.1632machine # [ 71.782463] systemd[1]: Reached target Local File Systems.1633machine # [ 71.785221] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1634machine # [ 71.786580] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1635machine # [ 71.792437] systemd[1]: Reached target Remote File Systems.1636machine # [ 71.798033] systemd[1]: Starting -.service...1637machine # [ 71.801376] systemd[1]: Starting linger-users.service...1638machine # [ 71.806441] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1639machine # [ 71.814308] systemd[1]: Starting Create SUID/SGID Wrappers...1640machine # [ 71.815166] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1641machine # [ 71.824980] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671642machine # [ 71.827181] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1643machine # [ 71.833936] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1644machine # [ 71.837352] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1645machine # [ 71.866615] systemd[1]: Finished -.service.1646machine # [ 71.902685] systemd[1]: linger-users.service: Deactivated successfully.1647machine # [ 71.904994] systemd[1]: Finished linger-users.service.1648machine # [ 72.166767] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1649machine # [ 72.169605] systemd[1]: Finished Create SUID/SGID Wrappers.1650machine # [ 72.429381] nixos[3167]: finished switching to system configuration /nix/store/qxznba6gr7f2v16rrc458a401zgxyyy8-nixos-system-machine-test1651machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 3.12 seconds)1652machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&11653machine # [ 73.068842] nixos[3309]: switching to system configuration /nix/store/2bq1ggm9kl3hx7n2mm77yhs9l86k6h0n-nixos-system-machine-test1654machine # [ 73.072048] systemd[1]: Stopped target Local File Systems.1655machine # [ 73.073399] systemd[1]: Stopped target Remote File Systems.1656machine # [ 73.562623] systemd[1]: Reload requested from client PID 3309 ('.switch-to-conf') (unit backdoor.service)...1657machine # [ 73.564704] systemd[1]: Reloading...1658machine # [ 74.219654] systemd[1]: Reloading finished in 652 ms.1659machine # [ 74.368970] systemd[581]: Reexecution requested from client PID 3378 ('switch-to-confi')...1660machine # [ 74.372644] systemd[581]: Reexecuting.1661machine # [ 74.421625] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1662machine # [ 74.610464] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1663machine # [ 74.616616] systemd[581]: Reload requested from client PID 3378 ('switch-to-confi')...1664machine # [ 74.619010] systemd[581]: Reloading...1665machine # [ 74.808066] systemd[581]: Reloading finished in 187 ms.1666machine # [ 74.824157] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1667machine # [ 74.834793] systemd[581]: Stopped Run user-specific NixOS activation.1668machine # [ 74.835859] systemd[581]: Stopping Run user-specific NixOS activation...1669machine # [ 74.838857] systemd[581]: Starting Run user-specific NixOS activation...1670machine # [ 74.885507] systemd[581]: Finished Run user-specific NixOS activation.1671machine # [ 74.889423] systemd[1]: Stopped target Reactivate sysinit units.1672machine # [ 74.898844] systemd[1]: Stopping Reactivate sysinit units...1673machine # [ 74.900391] systemd[1]: Reached target Reactivate sysinit units.1674machine # [ 74.902350] systemd[1]: Reloading -.service...1675machine # [ 74.941348] systemd[1]: Reloaded -.service.1676machine # [ 74.943767] systemd[1]: Reached target Remote File Systems.1677machine # [ 74.946617] systemd[1]: Reached target Local File Systems.1678machine # [ 74.949970] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1679machine # [ 74.954655] systemd[1]: Starting Create SUID/SGID Wrappers...1680machine # [ 74.955546] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1681machine # [ 74.959074] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671682machine # [ 74.965961] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1683machine # [ 74.967559] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1684machine # [ 74.976003] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1685machine # [ 74.977277] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1686machine # [ 74.978586] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1687machine # [ 75.291907] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1688machine # [ 75.296328] systemd[1]: Finished Create SUID/SGID Wrappers.1689machine # [ 75.298999] systemd[1]: Starting linger-users.service...1690machine # [ 75.362377] systemd[1]: linger-users.service: Deactivated successfully.1691machine # [ 75.363943] systemd[1]: Finished linger-users.service.1692machine # [ 75.622629] nixos[3309]: finished switching to system configuration /nix/store/2bq1ggm9kl3hx7n2mm77yhs9l86k6h0n-nixos-system-machine-test1693machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 3.19 seconds)1694machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&11695machine # [ 76.228088] nixos[3451]: switching to system configuration /nix/store/slxsx8psy74kvvhxzah9bvqh53wxvrxv-nixos-system-machine-test1696machine # [ 76.230557] systemd[1]: -.service: Deactivated successfully.1697machine # [ 76.233701] systemd[1]: Stopped -.service.1698machine # [ 76.234585] systemd[1]: Stopped target Local File Systems.1699machine # [ 76.235423] systemd[1]: Stopped target Remote File Systems.1700machine # [ 76.724866] systemd[1]: Reload requested from client PID 3451 ('.switch-to-conf') (unit backdoor.service)...1701machine # [ 76.726794] systemd[1]: Reloading...1702machine # [ 77.379852] systemd[1]: Reloading finished in 650 ms.1703machine # [ 77.526031] systemd[581]: Reexecution requested from client PID 3520 ('switch-to-confi')...1704machine # [ 77.529909] systemd[581]: Reexecuting.1705machine # [ 77.593782] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1706machine # [ 77.782024] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1707machine # [ 77.789157] systemd[581]: Reload requested from client PID 3520 ('switch-to-confi')...1708machine # [ 77.791596] systemd[581]: Reloading...1709machine # [ 77.975997] systemd[581]: Reloading finished in 183 ms.1710machine # [ 77.992172] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1711machine # [ 78.002491] systemd[581]: Stopped Run user-specific NixOS activation.1712machine # [ 78.003546] systemd[581]: Stopping Run user-specific NixOS activation...1713machine # [ 78.006375] systemd[581]: Starting Run user-specific NixOS activation...1714machine # [ 78.053303] systemd[581]: Finished Run user-specific NixOS activation.1715machine # [ 78.057692] systemd[1]: Stopped target Reactivate sysinit units.1716machine # [ 78.059510] systemd[1]: Stopping Reactivate sysinit units...1717machine # [ 78.061223] systemd[1]: Reached target Reactivate sysinit units.1718machine # [ 78.062941] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1719machine # [ 78.065578] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1720machine # [ 78.069354] systemd[1]: Reached target Remote File Systems.1721machine # [ 78.072887] systemd[1]: Reached target Local File Systems.1722machine # [ 78.076388] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1723machine # [ 78.080540] systemd[1]: Starting Create SUID/SGID Wrappers...1724machine # [ 78.081406] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1725machine # [ 78.082605] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671726machine # [ 78.094606] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1727machine # [ 78.096372] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1728machine # [ 78.097610] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1729machine # [ 78.409107] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1730machine # [ 78.412220] systemd[1]: Finished Create SUID/SGID Wrappers.1731machine # [ 78.417962] systemd[1]: Starting linger-users.service...1732machine # [ 78.421916] systemd[1]: Starting required-service.service...1733machine # [ 78.425513] systemd[1]: Starting test-service.service...1734machine # [ 78.473393] systemd[1]: Finished required-service.service.1735machine # [ 78.477680] systemd[1]: Finished test-service.service.1736machine # [ 78.504726] systemd[1]: linger-users.service: Deactivated successfully.1737machine # [ 78.507279] systemd[1]: Finished linger-users.service.1738machine # [ 78.767036] nixos[3451]: finished switching to system configuration /nix/store/slxsx8psy74kvvhxzah9bvqh53wxvrxv-nixos-system-machine-test1739machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 3.14 seconds)1740machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&11741machine # [ 79.418251] nixos[3595]: switching to system configuration /nix/store/4gr70zn9x7ryj2inpk5nddn4yjnba0cz-nixos-system-machine-test1742machine # [ 79.422996] systemd[1]: Stopped target Local File Systems.1743machine # [ 79.425796] systemd[1]: Stopped target Remote File Systems.1744machine # [ 79.426819] systemd[1]: required-service.service: Deactivated successfully.1745machine # [ 79.427864] systemd[1]: Stopped required-service.service.1746machine # [ 79.428959] systemd[1]: test-service.service: Deactivated successfully.1747machine # [ 79.430086] systemd[1]: Stopped test-service.service.1748machine # [ 79.920923] systemd[1]: Reload requested from client PID 3595 ('.switch-to-conf') (unit backdoor.service)...1749machine # [ 79.922867] systemd[1]: Reloading...1750machine # [ 80.567101] systemd[1]: Reloading finished in 641 ms.1751machine # [ 80.713856] systemd[581]: Reexecution requested from client PID 3664 ('switch-to-confi')...1752machine # [ 80.717481] systemd[581]: Reexecuting.1753machine # [ 80.769726] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1754machine # [ 80.959288] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1755machine # [ 80.966596] systemd[581]: Reload requested from client PID 3664 ('switch-to-confi')...1756machine # [ 80.967871] systemd[581]: Reloading...1757machine # [ 81.153029] systemd[581]: Reloading finished in 183 ms.1758machine # [ 81.168153] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1759machine # [ 81.177980] systemd[581]: Stopped Run user-specific NixOS activation.1760machine # [ 81.179019] systemd[581]: Stopping Run user-specific NixOS activation...1761machine # [ 81.181822] systemd[581]: Starting Run user-specific NixOS activation...1762machine # [ 81.227914] systemd[581]: Finished Run user-specific NixOS activation.1763machine # [ 81.231847] systemd[1]: Stopped target Reactivate sysinit units.1764machine # [ 81.233505] systemd[1]: Stopping Reactivate sysinit units...1765machine # [ 81.234318] systemd[1]: Reached target Reactivate sysinit units.1766machine # [ 81.242474] systemd[1]: Reached target Remote File Systems.1767machine # [ 81.248309] systemd[1]: Starting linger-users.service...1768machine # [ 81.251762] systemd[1]: Starting required-service.service...1769machine # [ 81.254941] systemd[1]: Starting test-service.service...1770machine # [ 81.267040] systemd[1]: Reached target Local File Systems.1771machine # [ 81.267938] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1772machine # [ 81.277093] systemd[1]: Starting Create SUID/SGID Wrappers...1773machine # [ 81.282441] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1774machine # [ 81.293780] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671775machine # [ 81.300335] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1776machine # [ 81.303594] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1777machine # [ 81.307956] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1778machine # [ 81.311530] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1779machine # [ 81.315111] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1780machine # [ 81.347027] systemd[1]: Finished required-service.service.1781machine # [ 81.349028] systemd[1]: Finished test-service.service.1782machine # [ 81.380321] systemd[1]: linger-users.service: Deactivated successfully.1783machine # [ 81.383626] systemd[1]: Finished linger-users.service.1784machine # [ 81.653162] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1785machine # [ 81.655747] systemd[1]: Finished Create SUID/SGID Wrappers.1786machine # [ 81.915217] nixos[3595]: finished switching to system configuration /nix/store/4gr70zn9x7ryj2inpk5nddn4yjnba0cz-nixos-system-machine-test1787machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 3.15 seconds)1788machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&11789machine # [ 82.543643] nixos[3739]: switching to system configuration /nix/store/k110hnwbj1h4v3f3bwwxwvs6gai9br7r-nixos-system-machine-test1790machine # [ 82.546479] systemd[1]: Stopped target Local File Systems.1791machine # [ 82.548509] systemd[1]: Stopped target Remote File Systems.1792machine # [ 82.550466] systemd[1]: required-service.service: Deactivated successfully.1793machine # [ 82.551430] systemd[1]: Stopped required-service.service.1794machine # [ 82.552935] systemd[1]: test-service.service: Deactivated successfully.1795machine # [ 82.554073] systemd[1]: Stopped test-service.service.1796machine # [ 83.043328] systemd[1]: Reload requested from client PID 3739 ('.switch-to-conf') (unit backdoor.service)...1797machine # [ 83.045457] systemd[1]: Reloading...1798machine # [ 83.651811] systemd[1]: Reloading finished in 604 ms.1799machine # [ 83.794576] systemd[581]: Reexecution requested from client PID 3808 ('switch-to-confi')...1800machine # [ 83.798263] systemd[581]: Reexecuting.1801machine # [ 83.861602] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1802machine # [ 84.053117] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1803machine # [ 84.059757] systemd[581]: Reload requested from client PID 3808 ('switch-to-confi')...1804machine # [ 84.063405] systemd[581]: Reloading...1805machine # [ 84.258545] systemd[581]: Reloading finished in 196 ms.1806machine # [ 84.273547] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1807machine # [ 84.281173] systemd[581]: Stopped Run user-specific NixOS activation.1808machine # [ 84.283489] systemd[581]: Stopping Run user-specific NixOS activation...1809machine # [ 84.286598] systemd[581]: Starting Run user-specific NixOS activation...1810machine # [ 84.335194] systemd[581]: Finished Run user-specific NixOS activation.1811machine # [ 84.339725] systemd[1]: Stopped target Reactivate sysinit units.1812machine # [ 84.342664] systemd[1]: Stopping Reactivate sysinit units...1813machine # [ 84.343493] systemd[1]: Reached target Reactivate sysinit units.1814machine # [ 84.344931] systemd[1]: Reached target Local File Systems.1815machine # [ 84.347162] systemd[1]: Reached target Remote File Systems.1816machine # [ 84.352229] systemd[1]: Starting linger-users.service...1817machine # [ 84.357812] systemd[1]: Starting required-service.service...1818machine # [ 84.364825] systemd[1]: Starting test-service.service...1819machine # [ 84.369200] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1820machine # [ 84.382563] systemd[1]: Starting Create SUID/SGID Wrappers...1821machine # [ 84.385788] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1822machine # [ 84.387081] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671823machine # [ 84.401734] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1824machine # [ 84.407237] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1825machine # [ 84.411241] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1826machine # [ 84.415085] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1827machine # [ 84.419642] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1828machine # [ 84.449012] systemd[1]: Finished required-service.service.1829machine # [ 84.457744] systemd[1]: Finished test-service.service.1830machine # [ 84.493220] systemd[1]: linger-users.service: Deactivated successfully.1831machine # [ 84.495980] systemd[1]: Finished linger-users.service.1832machine # [ 84.768458] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1833machine # [ 84.771859] systemd[1]: Finished Create SUID/SGID Wrappers.1834machine # [ 85.028788] nixos[3739]: finished switching to system configuration /nix/store/k110hnwbj1h4v3f3bwwxwvs6gai9br7r-nixos-system-machine-test1835machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 3.11 seconds)1836machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&11837machine # [ 85.656004] nixos[3883]: switching to system configuration /nix/store/j3awzq1hl7gszm7w8xv0jl1xsxap4cgb-nixos-system-machine-test1838machine # [ 85.658997] systemd[1]: Stopped target Local File Systems.1839machine # [ 85.662306] systemd[1]: Stopped target Remote File Systems.1840machine # [ 85.663207] systemd[1]: test-service.service: Deactivated successfully.1841machine # [ 85.665624] systemd[1]: Stopped test-service.service.1842machine # [ 85.666721] systemd[1]: required-service.service: Deactivated successfully.1843machine # [ 85.667753] systemd[1]: Stopped required-service.service.1844machine # [ 86.170667] systemd[1]: Reload requested from client PID 3883 ('.switch-to-conf') (unit backdoor.service)...1845machine # [ 86.172756] systemd[1]: Reloading...1846machine # [ 86.821644] systemd[1]: Reloading finished in 646 ms.1847machine # [ 86.962134] systemd[581]: Reexecution requested from client PID 3952 ('switch-to-confi')...1848machine # [ 86.966378] systemd[581]: Reexecuting.1849machine # [ 87.025708] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1850machine # [ 87.206181] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1851machine # [ 87.213268] systemd[581]: Reload requested from client PID 3952 ('switch-to-confi')...1852machine # [ 87.215495] systemd[581]: Reloading...1853machine # [ 87.397827] systemd[581]: Reloading finished in 181 ms.1854machine # [ 87.412152] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1855machine # [ 87.421200] systemd[581]: Stopped Run user-specific NixOS activation.1856machine # [ 87.423444] systemd[581]: Stopping Run user-specific NixOS activation...1857machine # [ 87.426141] systemd[581]: Starting Run user-specific NixOS activation...1858machine # [ 87.473287] systemd[581]: Finished Run user-specific NixOS activation.1859machine # [ 87.477373] systemd[1]: Stopped target Reactivate sysinit units.1860machine # [ 87.479766] systemd[1]: Stopping Reactivate sysinit units...1861machine # [ 87.482978] systemd[1]: Reached target Reactivate sysinit units.1862machine # [ 87.483831] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1863machine # [ 87.485915] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1864machine # [ 87.490052] systemd[1]: Reached target Local File Systems.1865machine # [ 87.493036] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1866machine # [ 87.498908] systemd[1]: Starting Create SUID/SGID Wrappers...1867machine # [ 87.503321] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1868machine # [ 87.509046] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671869machine # [ 87.511236] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1870machine # [ 87.517928] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1871machine # [ 87.519292] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1872machine # [ 87.520583] systemd[1]: Created slice Slice /system/instantiated.1873machine # [ 87.521413] systemd[1]: Reached target Remote File Systems.1874machine # [ 87.842708] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1875machine # [ 87.847068] systemd[1]: Finished Create SUID/SGID Wrappers.1876machine # [ 87.851211] systemd[1]: Starting instantiated@one.service...1877machine # [ 87.855400] systemd[1]: Starting instantiated@two.service...1878machine # [ 87.858622] systemd[1]: Starting linger-users.service...1879machine # [ 87.912562] systemd[1]: Finished instantiated@one.service.1880machine # [ 87.916376] systemd[1]: Finished instantiated@two.service.1881machine # [ 87.941583] systemd[1]: linger-users.service: Deactivated successfully.1882machine # [ 87.943831] systemd[1]: Finished linger-users.service.1883machine # [ 88.203931] nixos[3883]: finished switching to system configuration /nix/store/j3awzq1hl7gszm7w8xv0jl1xsxap4cgb-nixos-system-machine-test1884machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 3.17 seconds)1885machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&11886machine # [ 88.842112] nixos[4027]: switching to system configuration /nix/store/kv4m8ibjy8gqkncp257qbfy4l8q4fz58-nixos-system-machine-test1887machine # [ 88.846729] systemd[1]: Stopped target Local File Systems.1888machine # [ 88.850124] systemd[1]: Stopped target Remote File Systems.1889machine # [ 88.851167] systemd[1]: instantiated@one.service: Deactivated successfully.1890machine # [ 88.852390] systemd[1]: Stopped instantiated@one.service.1891machine # [ 88.853380] systemd[1]: instantiated@two.service: Deactivated successfully.1892machine # [ 88.854632] systemd[1]: Stopped instantiated@two.service.1893machine # [ 89.386587] systemd[1]: Reload requested from client PID 4027 ('.switch-to-conf') (unit backdoor.service)...1894machine # [ 89.388629] systemd[1]: Reloading...1895machine # [ 90.059322] systemd[1]: Reloading finished in 668 ms.1896machine # [ 90.207644] systemd[581]: Reexecution requested from client PID 4096 ('switch-to-confi')...1897machine # [ 90.211249] systemd[581]: Reexecuting.1898machine # [ 90.274134] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1899machine # [ 90.460841] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1900machine # [ 90.467218] systemd[581]: Reload requested from client PID 4096 ('switch-to-confi')...1901machine # [ 90.469722] systemd[581]: Reloading...1902machine # [ 90.655722] systemd[581]: Reloading finished in 185 ms.1903machine # [ 90.668150] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1904machine # [ 90.677424] systemd[581]: Stopped Run user-specific NixOS activation.1905machine # [ 90.679687] systemd[581]: Stopping Run user-specific NixOS activation...1906machine # [ 90.682450] systemd[581]: Starting Run user-specific NixOS activation...1907machine # [ 90.728697] systemd[581]: Finished Run user-specific NixOS activation.1908machine # [ 90.732879] systemd[1]: Stopped target Reactivate sysinit units.1909machine # [ 90.734929] systemd[1]: Stopping Reactivate sysinit units...1910machine # [ 90.739312] systemd[1]: Reached target Reactivate sysinit units.1911machine # [ 90.740618] systemd[1]: Reached target Remote File Systems.1912machine # [ 90.743565] systemd[1]: Starting instantiated@one.service...1913machine # [ 90.747325] systemd[1]: Starting instantiated@two.service...1914machine # [ 90.750542] systemd[1]: Starting linger-users.service...1915machine # [ 90.759129] systemd[1]: Reached target Local File Systems.1916machine # [ 90.761902] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1917machine # [ 90.772075] systemd[1]: Starting Create SUID/SGID Wrappers...1918machine # [ 90.773001] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1919machine # [ 90.774228] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671920machine # [ 90.794586] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1921machine # [ 90.797410] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1922machine # [ 90.801331] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1923machine # [ 90.804532] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1924machine # [ 90.807655] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1925machine # [ 90.840427] systemd[1]: Finished instantiated@one.service.1926machine # [ 90.842616] systemd[1]: Finished instantiated@two.service.1927machine # [ 90.877361] systemd[1]: linger-users.service: Deactivated successfully.1928machine # [ 90.879621] systemd[1]: Finished linger-users.service.1929machine # [ 91.149296] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1930machine # [ 91.152702] systemd[1]: Finished Create SUID/SGID Wrappers.1931machine # [ 91.411859] nixos[4027]: finished switching to system configuration /nix/store/kv4m8ibjy8gqkncp257qbfy4l8q4fz58-nixos-system-machine-test1932machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 3.21 seconds)1933(finished: subtest: services, in 65.45 seconds)1934subtest: failing units1935machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11936machine # [ 91.986689] nixos[4171]: switching to system configuration /nix/store/r7ly5vgiiy16h1wf0db10pqxzlzffnss-nixos-system-machine-test1937machine # [ 91.990131] systemd[1]: instantiated@two.service: Deactivated successfully.1938machine # [ 91.991150] systemd[1]: Stopped instantiated@two.service.1939machine # [ 91.994552] systemd[1]: instantiated@one.service: Deactivated successfully.1940machine # [ 91.995667] systemd[1]: Stopped instantiated@one.service.1941machine # [ 91.996937] systemd[1]: Stopped target Remote File Systems.1942machine # [ 91.997916] systemd[1]: Stopped target Local File Systems.1943machine # [ 92.448116] systemd[1]: Reload requested from client PID 4171 ('.switch-to-conf') (unit backdoor.service)...1944machine # [ 92.450307] systemd[1]: Reloading...1945machine # [ 93.047513] systemd[1]: Reloading finished in 594 ms.1946machine # [ 93.192182] systemd[581]: Reexecution requested from client PID 4240 ('switch-to-confi')...1947machine # [ 93.195749] systemd[581]: Reexecuting.1948machine # [ 93.245393] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1949machine # [ 93.437191] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1950machine # [ 93.443955] systemd[581]: Reload requested from client PID 4240 ('switch-to-confi')...1951machine # [ 93.446529] systemd[581]: Reloading...1952machine # [ 93.637753] systemd[581]: Reloading finished in 190 ms.1953machine # [ 93.652156] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1954machine # [ 93.661860] systemd[581]: Stopped Run user-specific NixOS activation.1955machine # [ 93.664124] systemd[581]: Stopping Run user-specific NixOS activation...1956machine # [ 93.667230] systemd[581]: Starting Run user-specific NixOS activation...1957machine # [ 93.713062] systemd[581]: Finished Run user-specific NixOS activation.1958machine # [ 93.717510] systemd[1]: Stopped target Reactivate sysinit units.1959machine # [ 93.720962] systemd[1]: Stopping Reactivate sysinit units...1960machine # [ 93.723627] systemd[1]: Reached target Reactivate sysinit units.1961machine # [ 93.725844] systemd[1]: Reached target Local File Systems.1962machine # [ 93.726636] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1963machine # [ 93.727904] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1964machine # [ 93.731038] systemd[1]: Reached target Remote File Systems.1965machine # [ 93.733570] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1966machine # [ 93.739965] systemd[1]: Starting Create SUID/SGID Wrappers...1967machine # [ 93.740848] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1968machine # [ 93.742135] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671969machine # [ 93.746094] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1970machine # [ 93.756121] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1971machine # [ 93.757451] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1972machine # [ 94.073499] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1973machine # [ 94.076671] systemd[1]: Finished Create SUID/SGID Wrappers.1974machine # [ 94.081902] systemd[1]: Starting linger-users.service...1975machine # [ 94.085025] systemd[1]: Starting test.service...1976machine # [ 94.128493] systemd[1]: Finished test.service.1977machine # [ 94.155952] systemd[1]: linger-users.service: Deactivated successfully.1978machine # [ 94.158595] systemd[1]: Finished linger-users.service.1979machine # [ 94.418975] nixos[4171]: finished switching to system configuration /nix/store/r7ly5vgiiy16h1wf0db10pqxzlzffnss-nixos-system-machine-test1980machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 3.01 seconds)1981machine: must fail: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&11982machine # [ 95.047760] nixos[4313]: switching to system configuration /nix/store/x7l56rw13xpa08mq7xh6vvs1sax6xblg-nixos-system-machine-test1983machine # [ 95.050881] systemd[1]: Stopped target Local File Systems.1984machine # [ 95.054192] systemd[1]: test.service: Deactivated successfully.1985machine # [ 95.055308] systemd[1]: Stopped test.service.1986machine # [ 95.056094] systemd[1]: Stopped target Remote File Systems.1987machine # [ 95.562538] systemd[1]: Reload requested from client PID 4313 ('.switch-to-conf') (unit backdoor.service)...1988machine # [ 95.564576] systemd[1]: Reloading...1989machine # [ 96.170528] systemd[1]: Reloading finished in 603 ms.1990machine # [ 96.322854] systemd[581]: Reexecution requested from client PID 4382 ('switch-to-confi')...1991machine # [ 96.324901] systemd[581]: Reexecuting.1992machine # [ 96.386021] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1993machine # [ 96.573058] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1994machine # [ 96.580170] systemd[581]: Reload requested from client PID 4382 ('switch-to-confi')...1995machine # [ 96.582562] systemd[581]: Reloading...1996machine # [ 96.776518] systemd[581]: Reloading finished in 193 ms.1997machine # [ 96.796169] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1998machine # [ 96.805376] systemd[581]: Stopped Run user-specific NixOS activation.1999machine # [ 96.807754] systemd[581]: Stopping Run user-specific NixOS activation...2000machine # [ 96.810802] systemd[581]: Starting Run user-specific NixOS activation...2001machine # [ 96.858141] systemd[581]: Finished Run user-specific NixOS activation.2002machine # [ 96.862283] systemd[1]: Stopped target Reactivate sysinit units.2003machine # [ 96.865573] systemd[1]: Stopping Reactivate sysinit units...2004machine # [ 96.866780] systemd[1]: Reached target Reactivate sysinit units.2005machine # [ 96.869692] systemd[1]: Reached target Remote File Systems.2006machine # [ 96.874824] systemd[1]: Starting linger-users.service...2007machine # [ 96.877798] systemd[1]: Starting test.service...2008machine # [ 96.884640] systemd[1]: Reached target Local File Systems.2009machine # [ 96.893133] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2010machine # [ 96.894530] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2011machine # [ 96.901012] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2012machine # [ 96.909539] systemd[1]: Starting Create SUID/SGID Wrappers...2013machine # [ 96.910444] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2014machine # [ 96.911620] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672015machine # [ 96.921135] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2016machine # [ 96.923978] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2017machine # [ 96.926741] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2018machine # [ 96.957458] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE2019machine # [ 96.961219] systemd[1]: test.service: Failed with result 'exit-code'.2020machine # [ 96.963608] systemd[1]: Failed to start test.service.2021machine # [ 96.996431] systemd[1]: linger-users.service: Deactivated successfully.2022machine # [ 96.998765] systemd[1]: Finished linger-users.service.2023machine # [ 97.264169] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2024machine # [ 97.267389] systemd[1]: Finished Create SUID/SGID Wrappers.2025machine # [ 97.579601] nixos[4313]: switching to system configuration /nix/store/x7l56rw13xpa08mq7xh6vvs1sax6xblg-nixos-system-machine-test failed (status 4)2026machine: (finished: must fail: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 3.16 seconds)2027machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12028machine # [ 98.187361] nixos[4456]: switching to system configuration /nix/store/dpffmlis1216n73zfyalckw46ipcp798-nixos-system-machine-test2029machine # [ 98.189955] systemd[1]: Stopped target Local File Systems.2030machine # [ 98.192191] systemd[1]: Stopped target Remote File Systems.2031machine # [ 98.700643] systemd[1]: Reload requested from client PID 4456 ('.switch-to-conf') (unit backdoor.service)...2032machine # [ 98.702615] systemd[1]: Reloading...2033machine # [ 99.353494] systemd[1]: Reloading finished in 648 ms.2034machine # [ 99.495649] systemd[581]: Reexecution requested from client PID 4525 ('switch-to-confi')...2035machine # [ 99.499519] systemd[581]: Reexecuting.2036machine # [ 99.553971] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2037machine # [ 99.726440] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2038machine # [ 99.732950] systemd[581]: Reload requested from client PID 4525 ('switch-to-confi')...2039machine # [ 99.735452] systemd[581]: Reloading...2040machine # [ 99.922143] systemd[581]: Reloading finished in 185 ms.2041machine # [ 99.936158] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2042machine # [ 99.946096] systemd[581]: Stopped Run user-specific NixOS activation.2043machine # [ 99.948510] systemd[581]: Stopping Run user-specific NixOS activation...2044machine # [ 99.951453] systemd[581]: Starting Run user-specific NixOS activation...2045machine # [ 99.996832] systemd[581]: Finished Run user-specific NixOS activation.2046machine # [ 100.001295] systemd[1]: Stopped target Reactivate sysinit units.2047machine # [ 100.003308] systemd[1]: Stopping Reactivate sysinit units...2048machine # [ 100.005241] systemd[1]: Reached target Reactivate sysinit units.2049machine # [ 100.007562] systemd[1]: Reached target Remote File Systems.2050machine # [ 100.016273] systemd[1]: Started autorestart.service.2051machine # [ 100.020439] systemd[1]: Starting linger-users.service...2052machine # [ 100.027039] systemd[1]: Reached target Local File Systems.2053machine # [ 100.034511] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2054machine # [ 100.040800] systemd[1]: Starting Create SUID/SGID Wrappers...2055machine # [ 100.045550] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2056machine # [ 100.046810] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672057machine # [ 100.052932] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2058machine # [ 100.055358] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2059machine # [ 100.058656] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2060machine # [ 100.062110] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2061machine # [ 100.064809] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2062machine # [ 100.091730] systemd[1]: autorestart.service: Deactivated successfully.2063machine # [ 100.126156] systemd[1]: linger-users.service: Deactivated successfully.2064machine # [ 100.129017] systemd[1]: Finished linger-users.service.2065machine # [ 100.391241] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2066machine # [ 100.394672] systemd[1]: Finished Create SUID/SGID Wrappers.2067machine # [ 100.654829] nixos[4456]: finished switching to system configuration /nix/store/dpffmlis1216n73zfyalckw46ipcp798-nixos-system-machine-test2068machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 3.07 seconds)2069machine # [ 100.738260] systemd[1]: Stopped autorestart.service.2070machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12071machine # [ 101.297832] nixos[4603]: switching to system configuration /nix/store/dpffmlis1216n73zfyalckw46ipcp798-nixos-system-machine-test2072machine # [ 101.300920] systemd[1]: Stopped target Local File Systems.2073machine # [ 101.302637] systemd[1]: Stopped target Remote File Systems.2074machine # [ 101.774794] systemd[1]: Reload requested from client PID 4603 ('.switch-to-conf') (unit backdoor.service)...2075machine # [ 101.777069] systemd[1]: Reloading...2076machine # [ 102.409787] systemd[1]: Reloading finished in 630 ms.2077machine # [ 102.563094] systemd[581]: Reexecution requested from client PID 4672 ('switch-to-confi')...2078machine # [ 102.565183] systemd[581]: Reexecuting.2079machine # [ 102.625874] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2080machine # [ 102.823218] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2081machine # [ 102.830515] systemd[581]: Reload requested from client PID 4672 ('switch-to-confi')...2082machine # [ 102.833078] systemd[581]: Reloading...2083machine # [ 103.026486] systemd[581]: Reloading finished in 192 ms.2084machine # [ 103.040158] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2085machine # [ 103.049334] systemd[581]: Stopped Run user-specific NixOS activation.2086machine # [ 103.051709] systemd[581]: Stopping Run user-specific NixOS activation...2087machine # [ 103.054524] systemd[581]: Starting Run user-specific NixOS activation...2088machine # [ 103.103475] systemd[581]: Finished Run user-specific NixOS activation.2089machine # [ 103.107851] systemd[1]: Stopped target Reactivate sysinit units.2090machine # [ 103.110855] systemd[1]: Stopping Reactivate sysinit units...2091machine # [ 103.111704] systemd[1]: Reached target Reactivate sysinit units.2092machine # [ 103.114583] systemd[1]: Reached target Remote File Systems.2093machine # [ 103.120375] systemd[1]: Started autorestart.service.2094machine # [ 103.124940] systemd[1]: Starting linger-users.service...2095machine # [ 103.129045] systemd[1]: Reached target Local File Systems.2096machine # [ 103.140260] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2097machine # [ 103.146906] systemd[1]: Starting Create SUID/SGID Wrappers...2098machine # [ 103.147857] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2099machine # [ 103.157514] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672100machine # [ 103.164758] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2101machine # [ 103.168998] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2102machine # [ 103.171591] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2103machine # [ 103.175238] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2104machine # [ 103.177711] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2105machine # [ 103.203467] systemd[1]: autorestart.service: Deactivated successfully.2106machine # [ 103.239495] systemd[1]: linger-users.service: Deactivated successfully.2107machine # [ 103.242279] systemd[1]: Finished linger-users.service.2108machine # [ 103.523805] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2109machine # [ 103.527562] systemd[1]: Finished Create SUID/SGID Wrappers.2110machine # [ 103.787696] nixos[4603]: finished switching to system configuration /nix/store/dpffmlis1216n73zfyalckw46ipcp798-nixos-system-machine-test2111machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 3.05 seconds)2112machine # [ 103.868934] systemd[1]: Stopped autorestart.service.2113machine: must fail: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&12114machine # [ 104.467989] nixos[4750]: switching to system configuration /nix/store/csn3d366lgsdbixlv4lqhw3amrknazx0-nixos-system-machine-test2115machine # [ 104.471554] systemd[1]: Stopped target Local File Systems.2116machine # [ 104.472722] systemd[1]: Stopped target Remote File Systems.2117machine # [ 104.969759] systemd[1]: Reload requested from client PID 4750 ('.switch-to-conf') (unit backdoor.service)...2118machine # [ 104.971840] systemd[1]: Reloading...2119machine # [ 105.658468] systemd[1]: Reloading finished in 684 ms.2120machine # [ 105.808449] systemd[581]: Reexecution requested from client PID 4819 ('switch-to-confi')...2121machine # [ 105.809927] systemd[581]: Reexecuting.2122machine # [ 105.874697] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2123machine # [ 106.076748] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2124machine # [ 106.084503] systemd[581]: Reload requested from client PID 4819 ('switch-to-confi')...2125machine # [ 106.087101] systemd[581]: Reloading...2126machine # [ 106.286158] systemd[581]: Reloading finished in 197 ms.2127machine # [ 106.304185] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2128machine # [ 106.313331] systemd[581]: Stopped Run user-specific NixOS activation.2129machine # [ 106.315832] systemd[581]: Stopping Run user-specific NixOS activation...2130machine # [ 106.318851] systemd[581]: Starting Run user-specific NixOS activation...2131machine # [ 106.367415] systemd[581]: Finished Run user-specific NixOS activation.2132machine # [ 106.371946] systemd[1]: Stopped target Reactivate sysinit units.2133machine # [ 106.374568] systemd[1]: Stopping Reactivate sysinit units...2134machine # [ 106.375426] systemd[1]: Reached target Reactivate sysinit units.2135machine # [ 106.377939] systemd[1]: Reached target Remote File Systems.2136machine # [ 106.384399] systemd[1]: Started autorestart.service.2137machine # [ 106.387162] systemd[1]: Starting linger-users.service...2138machine # [ 106.392622] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2139machine # [ 106.393956] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2140machine # [ 106.395195] systemd[1]: Reached target Local File Systems.2141machine # [ 106.407010] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2142machine # [ 106.418147] systemd[1]: Starting Create SUID/SGID Wrappers...2143machine # [ 106.419084] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2144machine # [ 106.424794] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672145machine # [ 106.427629] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2146machine # [ 106.432857] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2147machine # [ 106.434132] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2148machine # [ 106.463846] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE2149machine # [ 106.466597] systemd[1]: autorestart.service: Failed with result 'exit-code'.2150machine # [ 106.502200] systemd[1]: linger-users.service: Deactivated successfully.2151machine # [ 106.505621] systemd[1]: Finished linger-users.service.2152machine # [ 106.788917] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2153machine # [ 106.791793] systemd[1]: Finished Create SUID/SGID Wrappers.2154machine # [ 107.105670] nixos[4750]: switching to system configuration /nix/store/csn3d366lgsdbixlv4lqhw3amrknazx0-nixos-system-machine-test failed (status 4)2155machine: (finished: must fail: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 3.24 seconds)2156(finished: subtest: failing units, in 15.69 seconds)2157subtest: unit file parser2158machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12159machine # [ 107.689847] nixos[4893]: switching to system configuration /nix/store/8w1qkrbnln7x21ymczhvirs6win356ij-nixos-system-machine-test2160machine # [ 107.692610] systemd[1]: Stopped target Local File Systems.2161machine # [ 107.695635] systemd[1]: Stopped target Remote File Systems.2162machine # [ 107.696947] systemd[1]: Stopped autorestart.service.2163machine # [ 108.139749] systemd[1]: Reload requested from client PID 4893 ('.switch-to-conf') (unit backdoor.service)...2164machine # [ 108.142059] systemd[1]: Reloading...2165machine # [ 108.706465] systemd[1]: Reloading finished in 562 ms.2166machine # [ 108.855774] systemd[581]: Reexecution requested from client PID 4962 ('switch-to-confi')...2167machine # [ 108.858083] systemd[581]: Reexecuting.2168machine # [ 108.921982] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2169machine # [ 109.120734] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2170machine # [ 109.128120] systemd[581]: Reload requested from client PID 4962 ('switch-to-confi')...2171machine # [ 109.130820] systemd[581]: Reloading...2172machine # [ 109.319474] systemd[581]: Reloading finished in 187 ms.2173machine # [ 109.336219] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2174machine # [ 109.346003] systemd[581]: Stopped Run user-specific NixOS activation.2175machine # [ 109.348556] systemd[581]: Stopping Run user-specific NixOS activation...2176machine # [ 109.351698] systemd[581]: Starting Run user-specific NixOS activation...2177machine # [ 109.399120] systemd[581]: Finished Run user-specific NixOS activation.2178machine # [ 109.403615] systemd[1]: Stopped target Reactivate sysinit units.2179machine # [ 109.405406] systemd[1]: Stopping Reactivate sysinit units...2180machine # [ 109.406260] systemd[1]: Reached target Reactivate sysinit units.2181machine # [ 109.411101] systemd[1]: Reached target Local File Systems.2182machine # [ 109.416543] systemd[1]: Reached target Remote File Systems.2183machine # [ 109.422793] systemd[1]: Starting linger-users.service...2184machine # [ 109.426611] systemd[1]: Starting test.service...2185machine # [ 109.433379] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2186machine # [ 109.434820] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2187machine # [ 109.446328] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2188machine # [ 109.452233] systemd[1]: Starting Create SUID/SGID Wrappers...2189machine # [ 109.453147] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2190machine # [ 109.454386] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672191machine # [ 109.459029] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2192machine # [ 109.465191] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2193machine # [ 109.471067] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2194machine # [ 109.503510] systemd[1]: Finished test.service.2195machine # [ 109.543215] systemd[1]: linger-users.service: Deactivated successfully.2196machine # [ 109.545825] systemd[1]: Finished linger-users.service.2197machine # [ 109.823165] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2198machine # [ 109.826437] systemd[1]: Finished Create SUID/SGID Wrappers.2199machine # [ 110.085391] nixos[4893]: finished switching to system configuration /nix/store/8w1qkrbnln7x21ymczhvirs6win356ij-nixos-system-machine-test2200machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.98 seconds)2201machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&12202machine # [ 110.740866] nixos[5035]: switching to system configuration /nix/store/0c26wv6v5gwff136lhnyawb2avnlxgh1-nixos-system-machine-test2203machine # [ 110.743342] systemd[1]: Stopped target Local File Systems.2204machine # [ 110.745699] systemd[1]: Stopped target Remote File Systems.2205machine # [ 111.259194] systemd[1]: Reload requested from client PID 5035 ('.switch-to-conf') (unit backdoor.service)...2206machine # [ 111.261378] systemd[1]: Reloading...2207machine # [ 111.923452] systemd[1]: Reloading finished in 660 ms.2208machine # [ 112.079127] systemd[581]: Reexecution requested from client PID 5104 ('switch-to-confi')...2209machine # [ 112.082630] systemd[581]: Reexecuting.2210machine # [ 112.150120] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2211machine # [ 112.352588] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2212machine # [ 112.359141] systemd[581]: Reload requested from client PID 5104 ('switch-to-confi')...2213machine # [ 112.361247] systemd[581]: Reloading...2214machine # [ 112.549744] systemd[581]: Reloading finished in 187 ms.2215machine # [ 112.564156] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2216machine # [ 112.573314] systemd[581]: Stopped Run user-specific NixOS activation.2217machine # [ 112.575581] systemd[581]: Stopping Run user-specific NixOS activation...2218machine # [ 112.578413] systemd[581]: Starting Run user-specific NixOS activation...2219machine # [ 112.624653] systemd[581]: Finished Run user-specific NixOS activation.2220machine # [ 112.629210] systemd[1]: Stopped target Reactivate sysinit units.2221machine # [ 112.630465] systemd[1]: Stopping Reactivate sysinit units...2222machine # [ 112.631291] systemd[1]: Reached target Reactivate sysinit units.2223machine # [ 112.633722] systemd[1]: test.service: Deactivated successfully.2224machine # [ 112.636329] systemd[1]: Stopped test.service.2225machine # [ 112.637078] systemd[1]: Stopping test.service...2226machine # [ 112.640004] systemd[1]: Starting test.service...2227machine # [ 112.675912] systemd[1]: Finished test.service.2228machine # [ 112.682409] systemd[1]: Reached target Local File Systems.2229machine # [ 112.683233] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2230machine # [ 112.688146] systemd[1]: Starting Create SUID/SGID Wrappers...2231machine # [ 112.689009] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2232machine # [ 112.690213] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672233machine # [ 112.702694] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2234machine # [ 112.707073] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2235machine # [ 112.708460] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2236machine # [ 112.709629] systemd[1]: Reached target Remote File Systems.2237machine # [ 112.710393] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2238machine # [ 112.711615] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2239machine # [ 113.026955] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2240machine # [ 113.031651] systemd[1]: Finished Create SUID/SGID Wrappers.2241machine # [ 113.034375] systemd[1]: Starting linger-users.service...2242machine # [ 113.094748] systemd[1]: linger-users.service: Deactivated successfully.2243machine # [ 113.097231] systemd[1]: Finished linger-users.service.2244machine # [ 113.355308] nixos[5035]: finished switching to system configuration /nix/store/0c26wv6v5gwff136lhnyawb2avnlxgh1-nixos-system-machine-test2245machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 3.27 seconds)2246machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&12247machine # [ 114.010519] nixos[5177]: switching to system configuration /nix/store/rjfi4rgw28mamxf3wjgs4n5dpfhjyy0r-nixos-system-machine-test2248machine # [ 114.013980] systemd[1]: Stopped target Local File Systems.2249machine # [ 114.015432] systemd[1]: Stopped target Remote File Systems.2250machine # [ 114.529569] systemd[1]: Reload requested from client PID 5177 ('.switch-to-conf') (unit backdoor.service)...2251machine # [ 114.531571] systemd[1]: Reloading...2252machine # [ 115.213980] systemd[1]: Reloading finished in 679 ms.2253machine # [ 115.369965] systemd[581]: Reexecution requested from client PID 5246 ('switch-to-confi')...2254machine # [ 115.371414] systemd[581]: Reexecuting.2255machine # [ 115.438385] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2256machine # [ 115.646169] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2257machine # [ 115.652356] systemd[581]: Reload requested from client PID 5246 ('switch-to-confi')...2258machine # [ 115.654616] systemd[581]: Reloading...2259machine # [ 115.849256] systemd[581]: Reloading finished in 193 ms.2260machine # [ 115.864209] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2261machine # [ 115.874274] systemd[581]: Stopped Run user-specific NixOS activation.2262machine # [ 115.877204] systemd[581]: Stopping Run user-specific NixOS activation...2263machine # [ 115.881083] systemd[581]: Starting Run user-specific NixOS activation...2264machine # [ 115.931338] systemd[581]: Finished Run user-specific NixOS activation.2265machine # [ 115.935426] systemd[1]: Stopped target Reactivate sysinit units.2266machine # [ 115.937087] systemd[1]: Stopping Reactivate sysinit units...2267machine # [ 115.937953] systemd[1]: Reached target Reactivate sysinit units.2268machine # [ 115.939982] systemd[1]: test.service: Deactivated successfully.2269machine # [ 115.943005] systemd[1]: Stopped test.service.2270machine # [ 115.943657] systemd[1]: Stopping test.service...2271machine # [ 115.946100] systemd[1]: Starting test.service...2272machine # [ 115.980631] systemd[1]: Finished test.service.2273machine # [ 115.985412] systemd[1]: Reached target Remote File Systems.2274machine # [ 115.987874] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2275machine # [ 115.990286] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2276machine # [ 115.992465] systemd[1]: Reached target Local File Systems.2277machine # [ 115.999208] systemd[1]: Starting linger-users.service...2278machine # [ 116.010655] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2279machine # [ 116.015437] systemd[1]: Starting Create SUID/SGID Wrappers...2280machine # [ 116.017499] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2281machine # [ 116.018869] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672282machine # [ 116.022447] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2283machine # [ 116.023995] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2284machine # [ 116.028506] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2285machine # [ 116.085561] systemd[1]: linger-users.service: Deactivated successfully.2286machine # [ 116.088791] systemd[1]: Finished linger-users.service.2287machine # [ 116.369710] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2288machine # [ 116.372992] systemd[1]: Finished Create SUID/SGID Wrappers.2289machine # [ 116.629960] nixos[5177]: finished switching to system configuration /nix/store/rjfi4rgw28mamxf3wjgs4n5dpfhjyy0r-nixos-system-machine-test2290machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 3.27 seconds)2291machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12292machine # [ 117.240268] nixos[5319]: switching to system configuration /nix/store/8w1qkrbnln7x21ymczhvirs6win356ij-nixos-system-machine-test2293machine # [ 117.242878] systemd[1]: Stopped target Local File Systems.2294machine # [ 117.245165] systemd[1]: Stopped target Remote File Systems.2295machine # [ 117.704868] systemd[1]: Reload requested from client PID 5319 ('.switch-to-conf') (unit backdoor.service)...2296machine # [ 117.706896] systemd[1]: Reloading...2297machine # [ 118.304656] systemd[1]: Reloading finished in 595 ms.2298machine # [ 118.461351] systemd[581]: Reexecution requested from client PID 5388 ('switch-to-confi')...2299machine # [ 118.466585] systemd[581]: Reexecuting.2300machine # [ 118.517995] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2301machine # [ 118.715043] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2302machine # [ 118.721617] systemd[581]: Reload requested from client PID 5388 ('switch-to-confi')...2303machine # [ 118.724165] systemd[581]: Reloading...2304machine # [ 118.917284] systemd[581]: Reloading finished in 191 ms.2305machine # [ 118.932186] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2306machine # [ 118.943008] systemd[581]: Stopped Run user-specific NixOS activation.2307machine # [ 118.945616] systemd[581]: Stopping Run user-specific NixOS activation...2308machine # [ 118.948898] systemd[581]: Starting Run user-specific NixOS activation...2309machine # [ 119.002243] systemd[581]: Finished Run user-specific NixOS activation.2310machine # [ 119.007311] systemd[1]: Stopped target Reactivate sysinit units.2311machine # [ 119.012635] systemd[1]: Stopping Reactivate sysinit units...2312machine # [ 119.013881] systemd[1]: Reached target Reactivate sysinit units.2313machine # [ 119.014760] systemd[1]: test.service: Deactivated successfully.2314machine # [ 119.015587] systemd[1]: Stopped test.service.2315machine # [ 119.016401] systemd[1]: Stopping test.service...2316machine # [ 119.018624] systemd[1]: Starting test.service...2317machine # [ 119.056319] systemd[1]: Finished test.service.2318machine # [ 119.058503] systemd[1]: Reached target Remote File Systems.2319machine # [ 119.064893] systemd[1]: Starting linger-users.service...2320machine # [ 119.073312] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2321machine # [ 119.074668] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2322machine # [ 119.081598] systemd[1]: Reached target Local File Systems.2323machine # [ 119.083309] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2324machine # [ 119.089274] systemd[1]: Starting Create SUID/SGID Wrappers...2325machine # [ 119.090172] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2326machine # [ 119.091373] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672327machine # [ 119.095089] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2328machine # [ 119.097686] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2329machine # [ 119.099419] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2330machine # [ 119.159320] systemd[1]: linger-users.service: Deactivated successfully.2331machine # [ 119.162775] systemd[1]: Finished linger-users.service.2332machine # [ 119.437031] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2333machine # [ 119.440316] systemd[1]: Finished Create SUID/SGID Wrappers.2334machine # [ 119.699214] nixos[5319]: finished switching to system configuration /nix/store/8w1qkrbnln7x21ymczhvirs6win356ij-nixos-system-machine-test2335machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.07 seconds)2336machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&12337machine # [ 120.329161] nixos[5461]: switching to system configuration /nix/store/4pikxa98hhvazfb0x8cj3rj2z4216szj-nixos-system-machine-test2338machine # [ 120.332694] systemd[1]: Stopped target Local File Systems.2339machine # [ 120.334126] systemd[1]: Stopped target Remote File Systems.2340machine # [ 120.852282] systemd[1]: Reload requested from client PID 5461 ('.switch-to-conf') (unit backdoor.service)...2341machine # [ 120.854894] systemd[1]: Reloading...2342machine # [ 121.525208] systemd[1]: Reloading finished in 667 ms.2343machine # [ 121.682581] systemd[581]: Reexecution requested from client PID 5530 ('switch-to-confi')...2344machine # [ 121.686248] systemd[581]: Reexecuting.2345machine # [ 121.741397] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2346machine # [ 121.952954] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2347machine # [ 121.960800] systemd[581]: Reload requested from client PID 5530 ('switch-to-confi')...2348machine # [ 121.963616] systemd[581]: Reloading...2349machine # [ 122.155981] systemd[581]: Reloading finished in 191 ms.2350machine # [ 122.172193] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2351machine # [ 122.182947] systemd[581]: Stopped Run user-specific NixOS activation.2352machine # [ 122.184128] systemd[581]: Stopping Run user-specific NixOS activation...2353machine # [ 122.187219] systemd[581]: Starting Run user-specific NixOS activation...2354machine # [ 122.229960] systemd[581]: Finished Run user-specific NixOS activation.2355machine # [ 122.234524] systemd[1]: Stopped target Reactivate sysinit units.2356machine # [ 122.238090] systemd[1]: Stopping Reactivate sysinit units...2357machine # [ 122.238986] systemd[1]: Reached target Reactivate sysinit units.2358machine # [ 122.243097] systemd[1]: Reached target Remote File Systems.2359machine # [ 122.249326] systemd[1]: Starting linger-users.service...2360machine # [ 122.257610] systemd[1]: Reached target Local File Systems.2361machine # [ 122.262849] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2362machine # [ 122.269610] systemd[1]: Starting Create SUID/SGID Wrappers...2363machine # [ 122.270541] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2364machine # [ 122.271811] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672365machine # [ 122.278087] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2366machine # [ 122.284528] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2367machine # [ 122.286698] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2368machine # [ 122.289122] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2369machine # [ 122.291344] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2370machine # [ 122.351590] systemd[1]: linger-users.service: Deactivated successfully.2371machine # [ 122.355559] systemd[1]: Finished linger-users.service.2372machine # [ 122.622733] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2373machine # [ 122.626458] systemd[1]: Finished Create SUID/SGID Wrappers.2374machine # [ 122.883737] nixos[5461]: finished switching to system configuration /nix/store/4pikxa98hhvazfb0x8cj3rj2z4216szj-nixos-system-machine-test2375machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 3.19 seconds)2376machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&12377machine # [ 123.496543] nixos[5601]: switching to system configuration /nix/store/c19lqp0s3gvv2ksg5y3g4w1khm6wicfb-nixos-system-machine-test2378machine # [ 123.500469] systemd[1]: Stopped target Remote File Systems.2379machine # [ 123.501634] systemd[1]: Stopped target Local File Systems.2380machine # [ 124.001930] systemd[1]: Reload requested from client PID 5601 ('.switch-to-conf') (unit backdoor.service)...2381machine # [ 124.003868] systemd[1]: Reloading...2382machine # [ 124.649842] systemd[1]: Reloading finished in 642 ms.2383machine # [ 124.795692] systemd[581]: Reexecution requested from client PID 5670 ('switch-to-confi')...2384machine # [ 124.799620] systemd[581]: Reexecuting.2385machine # [ 124.861561] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2386machine # [ 125.043053] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2387machine # [ 125.049711] systemd[581]: Reload requested from client PID 5670 ('switch-to-confi')...2388machine # [ 125.052369] systemd[581]: Reloading...2389machine # [ 125.234029] systemd[581]: Reloading finished in 180 ms.2390machine # [ 125.248178] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2391machine # [ 125.258378] systemd[581]: Stopped Run user-specific NixOS activation.2392machine # [ 125.261002] systemd[581]: Stopping Run user-specific NixOS activation...2393machine # [ 125.264100] systemd[581]: Starting Run user-specific NixOS activation...2394machine # [ 125.309048] systemd[581]: Finished Run user-specific NixOS activation.2395machine # [ 125.313394] systemd[1]: Stopped target Reactivate sysinit units.2396machine # [ 125.315368] systemd[1]: Stopping Reactivate sysinit units...2397machine # [ 125.316957] systemd[1]: Reached target Reactivate sysinit units.2398machine # [ 125.320220] systemd[1]: test.service: Deactivated successfully.2399machine # [ 125.321121] systemd[1]: Stopped test.service.2400machine # [ 125.321775] systemd[1]: Stopping test.service...2401machine # [ 125.324387] systemd[1]: Starting test.service...2402machine # [ 125.359342] systemd[1]: Finished test.service.2403machine # [ 125.367785] systemd[1]: Reached target Remote File Systems.2404machine # [ 125.370418] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2405machine # [ 125.373302] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2406machine # [ 125.374610] systemd[1]: Reached target Local File Systems.2407machine # [ 125.377369] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2408machine # [ 125.384655] systemd[1]: Starting Create SUID/SGID Wrappers...2409machine # [ 125.387005] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2410machine # [ 125.388967] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672411machine # [ 125.391410] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2412machine # [ 125.393335] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2413machine # [ 125.398708] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2414machine # [ 125.714585] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2415machine # [ 125.718869] systemd[1]: Finished Create SUID/SGID Wrappers.2416machine # [ 125.721591] systemd[1]: Starting linger-users.service...2417machine # [ 125.783309] systemd[1]: linger-users.service: Deactivated successfully.2418machine # [ 125.786218] systemd[1]: Finished linger-users.service.2419machine # [ 126.045183] nixos[5601]: finished switching to system configuration /nix/store/c19lqp0s3gvv2ksg5y3g4w1khm6wicfb-nixos-system-machine-test2420machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 3.16 seconds)2421machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&12422machine # [ 126.701497] nixos[5743]: switching to system configuration /nix/store/1xy4rzdi8rmmk10s23cylq1lrl47k85j-nixos-system-machine-test2423machine # [ 126.704439] systemd[1]: Stopped target Local File Systems.2424machine # [ 126.706980] systemd[1]: Stopped target Remote File Systems.2425machine # [ 127.235401] systemd[1]: Reload requested from client PID 5743 ('.switch-to-conf') (unit backdoor.service)...2426machine # [ 127.237700] systemd[1]: Reloading...2427machine # [ 127.925209] systemd[1]: Reloading finished in 685 ms.2428machine # [ 128.068668] systemd[581]: Reexecution requested from client PID 5812 ('switch-to-confi')...2429machine # [ 128.073367] systemd[581]: Reexecuting.2430machine # [ 128.117726] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2431machine # [ 128.309253] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2432machine # [ 128.316002] systemd[581]: Reload requested from client PID 5812 ('switch-to-confi')...2433machine # [ 128.318591] systemd[581]: Reloading...2434machine # [ 128.508449] systemd[581]: Reloading finished in 188 ms.2435machine # [ 128.524164] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2436machine # [ 128.534420] systemd[581]: Stopped Run user-specific NixOS activation.2437machine # [ 128.535477] systemd[581]: Stopping Run user-specific NixOS activation...2438machine # [ 128.538590] systemd[581]: Starting Run user-specific NixOS activation...2439machine # [ 128.587544] systemd[581]: Finished Run user-specific NixOS activation.2440machine # [ 128.591616] systemd[1]: Stopped target Reactivate sysinit units.2441machine # [ 128.593873] systemd[1]: Stopping Reactivate sysinit units...2442machine # [ 128.594688] systemd[1]: Reached target Reactivate sysinit units.2443machine # [ 128.598382] systemd[1]: test.service: Deactivated successfully.2444machine # [ 128.599295] systemd[1]: Stopped test.service.2445machine # [ 128.599929] systemd[1]: Stopping test.service...2446machine # [ 128.602409] systemd[1]: Starting test.service...2447machine # [ 128.638908] systemd[1]: Finished test.service.2448machine # [ 128.643212] systemd[1]: Reached target Local File Systems.2449machine # [ 128.645095] systemd[1]: Reached target Remote File Systems.2450machine # [ 128.648974] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2451machine # [ 128.655537] systemd[1]: Starting Create SUID/SGID Wrappers...2452machine # [ 128.658654] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2453machine # [ 128.661234] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672454machine # [ 128.663432] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2455machine # [ 128.666163] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2456machine # [ 128.675481] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2457machine # [ 128.676908] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2458machine # [ 128.678193] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2459machine # [ 128.994188] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2460machine # [ 128.998988] systemd[1]: Finished Create SUID/SGID Wrappers.2461machine # [ 129.001461] systemd[1]: Starting linger-users.service...2462machine # [ 129.064988] systemd[1]: linger-users.service: Deactivated successfully.2463machine # [ 129.067471] systemd[1]: Finished linger-users.service.2464machine # [ 129.326058] nixos[5743]: finished switching to system configuration /nix/store/1xy4rzdi8rmmk10s23cylq1lrl47k85j-nixos-system-machine-test2465machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 3.28 seconds)2466machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&12467machine # [ 129.932987] nixos[5885]: switching to system configuration /nix/store/irk09arrbwf6w42569g461hq6bjccw1i-nixos-system-machine-test2468machine # [ 129.935689] systemd[1]: Stopped target Remote File Systems.2469machine # [ 129.937860] systemd[1]: Stopped target Local File Systems.2470machine # [ 130.439189] systemd[1]: Reload requested from client PID 5885 ('.switch-to-conf') (unit backdoor.service)...2471machine # [ 130.441303] systemd[1]: Reloading...2472machine # [ 131.097983] systemd[1]: Reloading finished in 654 ms.2473machine # [ 131.244426] systemd[581]: Reexecution requested from client PID 5954 ('switch-to-confi')...2474machine # [ 131.247478] systemd[581]: Reexecuting.2475machine # [ 131.309923] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2476machine # [ 131.501255] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2477machine # [ 131.507523] systemd[581]: Reload requested from client PID 5954 ('switch-to-confi')...2478machine # [ 131.510249] systemd[581]: Reloading...2479machine # [ 131.698402] systemd[581]: Reloading finished in 187 ms.2480machine # [ 131.712158] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2481machine # [ 131.722506] systemd[581]: Stopped Run user-specific NixOS activation.2482machine # [ 131.723546] systemd[581]: Stopping Run user-specific NixOS activation...2483machine # [ 131.726537] systemd[581]: Starting Run user-specific NixOS activation...2484machine # [ 131.772317] systemd[581]: Finished Run user-specific NixOS activation.2485machine # [ 131.776716] systemd[1]: Stopped target Reactivate sysinit units.2486machine # [ 131.778748] systemd[1]: Stopping Reactivate sysinit units...2487machine # [ 131.782823] systemd[1]: Reached target Reactivate sysinit units.2488machine # [ 131.783727] systemd[1]: test.service: Deactivated successfully.2489machine # [ 131.784733] systemd[1]: Stopped test.service.2490machine # [ 131.785732] systemd[1]: Stopping test.service...2491machine # [ 131.787613] systemd[1]: Starting test.service...2492machine # [ 131.823002] systemd[1]: Finished test.service.2493machine # [ 131.826160] systemd[1]: Reached target Remote File Systems.2494machine # [ 131.828956] systemd[1]: Reached target Local File Systems.2495machine # [ 131.834375] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2496machine # [ 131.838132] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2497machine # [ 131.844078] systemd[1]: Starting linger-users.service...2498machine # [ 131.851047] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2499machine # [ 131.859001] systemd[1]: Starting Create SUID/SGID Wrappers...2500machine # [ 131.859895] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2501machine # [ 131.862610] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672502machine # [ 131.868224] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2503machine # [ 131.869883] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2504machine # [ 131.874909] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2505machine # [ 131.934582] systemd[1]: linger-users.service: Deactivated successfully.2506machine # [ 131.938537] systemd[1]: Finished linger-users.service.2507machine # [ 132.210329] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2508machine # [ 132.213534] systemd[1]: Finished Create SUID/SGID Wrappers.2509machine # [ 132.471547] nixos[5885]: finished switching to system configuration /nix/store/irk09arrbwf6w42569g461hq6bjccw1i-nixos-system-machine-test2510machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 3.15 seconds)2511machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12512machine # [ 133.041551] nixos[6027]: switching to system configuration /nix/store/8w1qkrbnln7x21ymczhvirs6win356ij-nixos-system-machine-test2513machine # [ 133.044297] systemd[1]: Stopped target Remote File Systems.2514machine # [ 133.046740] systemd[1]: Stopped target Local File Systems.2515machine # [ 133.495181] systemd[1]: Reload requested from client PID 6027 ('.switch-to-conf') (unit backdoor.service)...2516machine # [ 133.497431] systemd[1]: Reloading...2517machine # [ 134.083274] systemd[1]: Reloading finished in 583 ms.2518machine # [ 134.221350] systemd[581]: Reexecution requested from client PID 6096 ('switch-to-confi')...2519machine # [ 134.226270] systemd[581]: Reexecuting.2520machine # [ 134.269615] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2521machine # [ 134.451958] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2522machine # [ 134.459022] systemd[581]: Reload requested from client PID 6096 ('switch-to-confi')...2523machine # [ 134.461679] systemd[581]: Reloading...2524machine # [ 134.643751] systemd[581]: Reloading finished in 181 ms.2525machine # [ 134.657981] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2526machine # [ 134.666167] systemd[581]: Stopped Run user-specific NixOS activation.2527machine # [ 134.667127] systemd[581]: Stopping Run user-specific NixOS activation...2528machine # [ 134.669911] systemd[581]: Starting Run user-specific NixOS activation...2529machine # [ 134.716424] systemd[581]: Finished Run user-specific NixOS activation.2530machine # [ 134.720562] systemd[1]: Stopped target Reactivate sysinit units.2531machine # [ 134.721514] systemd[1]: Stopping Reactivate sysinit units...2532machine # [ 134.723068] systemd[1]: Reached target Reactivate sysinit units.2533machine # [ 134.727072] systemd[1]: test.service: Deactivated successfully.2534machine # [ 134.728312] systemd[1]: Stopped test.service.2535machine # [ 134.730113] systemd[1]: Stopping test.service...2536machine # [ 134.731107] systemd[1]: Starting test.service...2537machine # [ 134.766061] systemd[1]: Finished test.service.2538machine # [ 134.768608] systemd[1]: Reached target Local File Systems.2539machine # [ 134.770690] systemd[1]: Reached target Remote File Systems.2540machine # [ 134.776281] systemd[1]: Starting linger-users.service...2541machine # [ 134.785288] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2542machine # [ 134.786670] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2543machine # [ 134.793262] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2544machine # [ 134.801715] systemd[1]: Starting Create SUID/SGID Wrappers...2545machine # [ 134.802601] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2546machine # [ 134.803784] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672547machine # [ 134.806767] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2548machine # [ 134.809151] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2549machine # [ 134.810871] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2550machine # [ 134.868974] systemd[1]: linger-users.service: Deactivated successfully.2551machine # [ 134.870734] systemd[1]: Finished linger-users.service.2552machine # [ 135.140340] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2553machine # [ 135.143358] systemd[1]: Finished Create SUID/SGID Wrappers.2554machine # [ 135.401814] nixos[6027]: finished switching to system configuration /nix/store/8w1qkrbnln7x21ymczhvirs6win356ij-nixos-system-machine-test2555machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.93 seconds)2556machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&12557machine # [ 136.033455] nixos[6169]: switching to system configuration /nix/store/6yzjjnn9sij0pl2nhnhqlpbch23x8ivh-nixos-system-machine-test2558machine # [ 136.035947] systemd[1]: Stopped target Remote File Systems.2559machine # [ 136.038312] systemd[1]: Stopped target Local File Systems.2560machine # [ 136.569495] systemd[1]: Reload requested from client PID 6169 ('.switch-to-conf') (unit backdoor.service)...2561machine # [ 136.571504] systemd[1]: Reloading...2562machine # [ 137.219126] systemd[1]: Reloading finished in 645 ms.2563machine # [ 137.364434] systemd[581]: Reexecution requested from client PID 6238 ('switch-to-confi')...2564machine # [ 137.365994] systemd[581]: Reexecuting.2565machine # [ 137.426112] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2566machine # [ 137.621652] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2567machine # [ 137.628607] systemd[581]: Reload requested from client PID 6238 ('switch-to-confi')...2568machine # [ 137.631430] systemd[581]: Reloading...2569machine # [ 137.830467] systemd[581]: Reloading finished in 197 ms.2570machine # [ 137.844209] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2571machine # [ 137.856087] systemd[581]: Stopped Run user-specific NixOS activation.2572machine # [ 137.857234] systemd[581]: Stopping Run user-specific NixOS activation...2573machine # [ 137.860431] systemd[581]: Starting Run user-specific NixOS activation...2574machine # [ 137.916170] systemd[581]: Finished Run user-specific NixOS activation.2575machine # [ 137.921509] systemd[1]: Stopped target Reactivate sysinit units.2576machine # [ 137.926812] systemd[1]: Stopping Reactivate sysinit units...2577machine # [ 137.928382] systemd[1]: Reached target Reactivate sysinit units.2578machine # [ 137.931195] systemd[1]: Reloading test.service...2579machine # [ 137.970898] systemd[1]: Reloaded test.service.2580machine # [ 137.975791] systemd[1]: Reached target Remote File Systems.2581machine # [ 137.979657] systemd[1]: Reached target Local File Systems.2582machine # [ 137.982981] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2583machine # [ 137.990844] systemd[1]: Starting Create SUID/SGID Wrappers...2584machine # [ 137.991813] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2585machine # [ 137.993523] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672586machine # [ 137.998291] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2587machine # [ 138.005943] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2588machine # [ 138.007218] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2589machine # [ 138.013592] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2590machine # [ 138.015045] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2591machine # [ 138.338002] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2592machine # [ 138.342712] systemd[1]: Finished Create SUID/SGID Wrappers.2593machine # [ 138.345693] systemd[1]: Starting linger-users.service...2594machine # [ 138.409060] systemd[1]: linger-users.service: Deactivated successfully.2595machine # [ 138.412178] systemd[1]: Finished linger-users.service.2596machine # [ 138.669268] nixos[6169]: finished switching to system configuration /nix/store/6yzjjnn9sij0pl2nhnhqlpbch23x8ivh-nixos-system-machine-test2597machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 3.27 seconds)2598machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&12599machine # [ 139.302307] nixos[6311]: switching to system configuration /nix/store/ic2qxchr51l4jk5fnlyazazh036k7p7h-nixos-system-machine-test2600machine # [ 139.306061] systemd[1]: Stopped target Local File Systems.2601machine # [ 139.307572] systemd[1]: Stopped target Remote File Systems.2602machine # [ 139.855492] systemd[1]: Reload requested from client PID 6311 ('.switch-to-conf') (unit backdoor.service)...2603machine # [ 139.857774] systemd[1]: Reloading...2604machine # [ 140.535309] systemd[1]: Reloading finished in 675 ms.2605machine # [ 140.686913] systemd[581]: Reexecution requested from client PID 6380 ('switch-to-confi')...2606machine # [ 140.689077] systemd[581]: Reexecuting.2607machine # [ 140.754397] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2608machine # [ 140.951125] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2609machine # [ 140.958161] systemd[581]: Reload requested from client PID 6380 ('switch-to-confi')...2610machine # [ 140.960508] systemd[581]: Reloading...2611machine # [ 141.154697] systemd[581]: Reloading finished in 193 ms.2612machine # [ 141.168176] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2613machine # [ 141.178309] systemd[581]: Stopped Run user-specific NixOS activation.2614machine # [ 141.180836] systemd[581]: Stopping Run user-specific NixOS activation...2615machine # [ 141.183907] systemd[581]: Starting Run user-specific NixOS activation...2616machine # [ 141.231900] systemd[581]: Finished Run user-specific NixOS activation.2617machine # [ 141.236497] systemd[1]: Stopped target Reactivate sysinit units.2618machine # [ 141.240518] systemd[1]: Stopping Reactivate sysinit units...2619machine # [ 141.241443] systemd[1]: Reached target Reactivate sysinit units.2620machine # [ 141.244831] systemd[1]: Reloading test.service...2621machine # [ 141.284632] systemd[1]: Reloaded test.service.2622machine # [ 141.287237] systemd[1]: Reached target Remote File Systems.2623machine # [ 141.291049] systemd[1]: Reached target Local File Systems.2624machine # [ 141.297608] systemd[1]: Starting linger-users.service...2625machine # [ 141.308657] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2626machine # [ 141.314119] systemd[1]: Starting Create SUID/SGID Wrappers...2627machine # [ 141.320053] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2628machine # [ 141.321706] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672629machine # [ 141.328959] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2630machine # [ 141.330721] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2631machine # [ 141.332818] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2632machine # [ 141.335159] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2633machine # [ 141.337405] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2634machine # [ 141.400316] systemd[1]: linger-users.service: Deactivated successfully.2635machine # [ 141.401370] systemd[1]: Finished linger-users.service.2636machine # [ 141.693260] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2637machine # [ 141.696625] systemd[1]: Finished Create SUID/SGID Wrappers.2638machine # [ 141.956561] nixos[6311]: finished switching to system configuration /nix/store/ic2qxchr51l4jk5fnlyazazh036k7p7h-nixos-system-machine-test2639machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 3.28 seconds)2640machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&12641machine # [ 142.602813] nixos[6453]: switching to system configuration /nix/store/1ycalbazc4valagma4v1j01p36rg1ays-nixos-system-machine-test2642machine # [ 142.605304] systemd[1]: Stopped target Local File Systems.2643machine # [ 142.607196] systemd[1]: Stopped target Remote File Systems.2644machine # [ 143.117753] systemd[1]: Reload requested from client PID 6453 ('.switch-to-conf') (unit backdoor.service)...2645machine # [ 143.119693] systemd[1]: Reloading...2646machine # [ 143.793799] systemd[1]: Reloading finished in 670 ms.2647machine # [ 143.944435] systemd[581]: Reexecution requested from client PID 6522 ('switch-to-confi')...2648machine # [ 143.947774] systemd[581]: Reexecuting.2649machine # [ 144.006334] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2650machine # [ 144.197450] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2651machine # [ 144.204164] systemd[581]: Reload requested from client PID 6522 ('switch-to-confi')...2652machine # [ 144.206603] systemd[581]: Reloading...2653machine # [ 144.397653] systemd[581]: Reloading finished in 189 ms.2654machine # [ 144.412203] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2655machine # [ 144.422463] systemd[581]: Stopped Run user-specific NixOS activation.2656machine # [ 144.425274] systemd[581]: Stopping Run user-specific NixOS activation...2657machine # [ 144.428435] systemd[581]: Starting Run user-specific NixOS activation...2658machine # [ 144.480486] systemd[581]: Finished Run user-specific NixOS activation.2659machine # [ 144.486996] systemd[1]: Stopped target Reactivate sysinit units.2660machine # [ 144.490044] systemd[1]: Stopping Reactivate sysinit units...2661machine # [ 144.491003] systemd[1]: Reached target Reactivate sysinit units.2662machine # [ 144.494625] systemd[1]: test.service: Deactivated successfully.2663machine # [ 144.495628] systemd[1]: Stopped test.service.2664machine # [ 144.496614] systemd[1]: Stopping test.service...2665machine # [ 144.499138] systemd[1]: Starting test.service...2666machine # [ 144.536565] systemd[1]: Finished test.service.2667machine # [ 144.543219] systemd[1]: Reached target Local File Systems.2668machine # [ 144.547114] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2669machine # [ 144.549153] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2670machine # [ 144.553400] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2671machine # [ 144.555019] systemd[1]: Starting Create SUID/SGID Wrappers...2672machine # [ 144.555817] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2673machine # [ 144.565846] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672674machine # [ 144.573790] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2675machine # [ 144.575412] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2676machine # [ 144.576777] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2677machine # [ 144.577973] systemd[1]: Reached target Remote File Systems.2678machine # [ 144.899229] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2679machine # [ 144.901987] systemd[1]: Finished Create SUID/SGID Wrappers.2680machine # [ 144.907165] systemd[1]: Starting linger-users.service...2681machine # [ 144.972935] systemd[1]: linger-users.service: Deactivated successfully.2682machine # [ 144.975336] systemd[1]: Finished linger-users.service.2683machine # [ 145.236263] nixos[6453]: finished switching to system configuration /nix/store/1ycalbazc4valagma4v1j01p36rg1ays-nixos-system-machine-test2684machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 3.28 seconds)2685machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&12686machine # [ 145.836439] nixos[6595]: switching to system configuration /nix/store/c19lqp0s3gvv2ksg5y3g4w1khm6wicfb-nixos-system-machine-test2687machine # [ 145.839235] systemd[1]: Stopped target Local File Systems.2688machine # [ 145.841452] systemd[1]: Stopped target Remote File Systems.2689machine # [ 146.312900] systemd[1]: Reload requested from client PID 6595 ('.switch-to-conf') (unit backdoor.service)...2690machine # [ 146.314728] systemd[1]: Reloading...2691machine # [ 146.931532] systemd[1]: Reloading finished in 613 ms.2692machine # [ 147.067158] systemd[581]: Reexecution requested from client PID 6664 ('switch-to-confi')...2693machine # [ 147.069620] systemd[581]: Reexecuting.2694machine # [ 147.135293] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2695machine # [ 147.327038] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2696machine # [ 147.333825] systemd[581]: Reload requested from client PID 6664 ('switch-to-confi')...2697machine # [ 147.336351] systemd[581]: Reloading...2698machine # [ 147.524203] systemd[581]: Reloading finished in 185 ms.2699machine # [ 147.540173] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2700machine # [ 147.550789] systemd[581]: Stopped Run user-specific NixOS activation.2701machine # [ 147.551803] systemd[581]: Stopping Run user-specific NixOS activation...2702machine # [ 147.554764] systemd[581]: Starting Run user-specific NixOS activation...2703machine # [ 147.600715] systemd[581]: Finished Run user-specific NixOS activation.2704machine # [ 147.604885] systemd[1]: Stopped target Reactivate sysinit units.2705machine # [ 147.607893] systemd[1]: Stopping Reactivate sysinit units...2706machine # [ 147.609372] systemd[1]: Reached target Reactivate sysinit units.2707machine # [ 147.610666] systemd[1]: Reached target Local File Systems.2708machine # [ 147.613838] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2709machine # [ 147.620884] systemd[1]: Starting Create SUID/SGID Wrappers...2710machine # [ 147.624206] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2711machine # [ 147.627450] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672712machine # [ 147.635824] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2713machine # [ 147.639235] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2714machine # [ 147.642126] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2715machine # [ 147.643318] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2716machine # [ 147.644909] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2717machine # [ 147.646331] systemd[1]: Reached target Remote File Systems.2718machine # [ 147.932255] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2719machine # [ 147.936620] systemd[1]: Finished Create SUID/SGID Wrappers.2720machine # [ 147.939287] systemd[1]: Starting linger-users.service...2721machine # [ 147.998724] systemd[1]: linger-users.service: Deactivated successfully.2722machine # [ 148.001368] systemd[1]: Finished linger-users.service.2723machine # [ 148.259443] nixos[6595]: finished switching to system configuration /nix/store/c19lqp0s3gvv2ksg5y3g4w1khm6wicfb-nixos-system-machine-test2724machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 3.02 seconds)2725(finished: subtest: unit file parser, in 41.16 seconds)2726subtest: restart and reload by activation script2727machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&12728machine # [ 148.823127] nixos[6735]: switching to system configuration /nix/store/12zh8y7plvai6dd6gnzisvgwx1593956-nixos-system-machine-test2729machine # [ 148.825932] systemd[1]: Stopped target Remote File Systems.2730machine # [ 148.828518] systemd[1]: Stopped target Local File Systems.2731machine # [ 149.276571] systemd[1]: Reload requested from client PID 6735 ('.switch-to-conf') (unit backdoor.service)...2732machine # [ 149.278502] systemd[1]: Reloading...2733machine # [ 149.885285] systemd[1]: Reloading finished in 604 ms.2734machine # [ 150.035035] systemd[581]: Reexecution requested from client PID 6804 ('switch-to-confi')...2735machine # [ 150.037087] systemd[581]: Reexecuting.2736machine # [ 150.089981] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2737machine # [ 150.280191] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2738machine # [ 150.288241] systemd[581]: Reload requested from client PID 6804 ('switch-to-confi')...2739machine # [ 150.290488] systemd[581]: Reloading...2740machine # [ 150.483182] systemd[581]: Reloading finished in 191 ms.2741machine # [ 150.497673] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2742machine # [ 150.507077] systemd[581]: Stopped Run user-specific NixOS activation.2743machine # [ 150.508211] systemd[581]: Stopping Run user-specific NixOS activation...2744machine # [ 150.511437] systemd[581]: Starting Run user-specific NixOS activation...2745machine # [ 150.558986] systemd[581]: Finished Run user-specific NixOS activation.2746machine # [ 150.563690] systemd[1]: Stopped target Reactivate sysinit units.2747machine # [ 150.566253] systemd[1]: Stopping Reactivate sysinit units...2748machine # [ 150.567149] systemd[1]: Reached target Reactivate sysinit units.2749machine # [ 150.570516] systemd[1]: Reached target Remote File Systems.2750machine # [ 150.576384] systemd[1]: Starting linger-users.service...2751machine # [ 150.587293] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2752machine # [ 150.591852] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2753machine # [ 150.593384] systemd[1]: Reached target Local File Systems.2754machine # [ 150.594178] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2755machine # [ 150.601848] systemd[1]: Starting Create SUID/SGID Wrappers...2756machine # [ 150.607683] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2757machine # [ 150.609394] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672758machine # [ 150.616262] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2759machine # [ 150.617901] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2760machine # [ 150.619096] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2761machine # [ 150.674685] systemd[1]: linger-users.service: Deactivated successfully.2762machine # [ 150.676388] systemd[1]: Finished linger-users.service.2763machine # [ 150.946917] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2764machine # [ 150.950553] systemd[1]: Finished Create SUID/SGID Wrappers.2765machine # [ 151.207783] nixos[6735]: finished switching to system configuration /nix/store/12zh8y7plvai6dd6gnzisvgwx1593956-nixos-system-machine-test2766machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 2.95 seconds)2767machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12768machine # [ 151.866412] nixos[6875]: switching to system configuration /nix/store/c2hv4d4c4s3qhdpgbpazm22whvpd46rj-nixos-system-machine-test2769machine # [ 151.870512] systemd[1]: Stopped target Local File Systems.2770machine # [ 151.872329] systemd[1]: Stopped target Remote File Systems.2771machine # [ 151.873204] systemd[1]: test.service: Deactivated successfully.2772machine # [ 151.874043] systemd[1]: Stopped test.service.2773machine # [ 152.417365] systemd[1]: Reload requested from client PID 6875 ('.switch-to-conf') (unit backdoor.service)...2774machine # [ 152.419448] systemd[1]: Reloading...2775machine # [ 153.114174] systemd[1]: Reloading finished in 690 ms.2776machine # [ 153.264446] systemd[581]: Reexecution requested from client PID 6946 ('switch-to-confi')...2777machine # [ 153.265877] systemd[581]: Reexecuting.2778machine # [ 153.329729] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2779machine # [ 153.526883] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2780machine # [ 153.533383] systemd[581]: Reload requested from client PID 6946 ('switch-to-confi')...2781machine # [ 153.535885] systemd[581]: Reloading...2782machine # [ 153.727753] systemd[581]: Reloading finished in 190 ms.2783machine # [ 153.740158] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2784machine # [ 153.750068] systemd[581]: Stopped Run user-specific NixOS activation.2785machine # [ 153.752556] systemd[581]: Stopping Run user-specific NixOS activation...2786machine # [ 153.755448] systemd[581]: Starting Run user-specific NixOS activation...2787machine # [ 153.802446] systemd[581]: Finished Run user-specific NixOS activation.2788machine # [ 153.806651] systemd[1]: Stopped target Reactivate sysinit units.2789machine # [ 153.808609] systemd[1]: Stopping Reactivate sysinit units...2790machine # [ 153.809710] systemd[1]: Reached target Reactivate sysinit units.2791machine # [ 153.817298] systemd[1]: Starting no-restart-service.service...2792machine # [ 153.834066] systemd[1]: Created slice Slice /system/templated-simple-reload-service.2793machine # [ 153.839587] systemd[1]: Starting templated-simple-reload-service@instance.service...2794machine # [ 153.856087] systemd[1]: Created slice Slice /system/templated-simple-service.2795machine # [ 153.861279] systemd[1]: Starting templated-simple-service@instance.service...2796machine # [ 153.868613] systemd[1]: Reached target Local File Systems.2797machine # [ 153.870711] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2798machine # [ 153.884433] systemd[1]: Starting Create SUID/SGID Wrappers...2799machine # [ 153.885330] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2800machine # [ 153.886609] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672801machine # [ 153.900849] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2802machine # [ 153.903275] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2803machine # [ 153.907032] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2804machine # [ 153.919181] systemd[1]: Created slice Slice /system/templated-simple-restart-service.2805machine # [ 153.940462] systemd[1]: Created slice Slice /system/templated-no-restart-service.2806machine # [ 153.951253] systemd[1]: Reached target Remote File Systems.2807machine # [ 153.964611] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2808machine # [ 153.966112] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2809machine # [ 153.967501] systemd[1]: Finished no-restart-service.service.2810machine # [ 153.982393] systemd[1]: Created slice Slice /system/templated-reload-triggers.2811machine # [ 153.986712] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart.2812machine # [ 153.995608] systemd[1]: Finished templated-simple-reload-service@instance.service.2813machine # [ 154.013288] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as.2814machine # [ 154.017345] systemd[1]: Finished templated-simple-service@instance.service.2815machine # [ 154.325992] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2816machine # [ 154.330832] systemd[1]: Finished Create SUID/SGID Wrappers.2817machine # [ 154.334946] systemd[1]: Starting linger-users.service...2818machine # [ 154.339150] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2819machine # [ 154.343534] systemd[1]: Starting reload-triggers-and-restart.service...2820machine # [ 154.353797] systemd[1]: Starting reload-triggers.service...2821machine # [ 154.358605] systemd[1]: Starting simple-reload-service.service...2822machine # [ 154.366771] systemd[1]: Starting simple-restart-service.service...2823machine # [ 154.380356] systemd[1]: Starting simple-service.service...2824machine # [ 154.390125] systemd[1]: Starting templated-no-restart-service@instance.service...2825machine # [ 154.405735] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2826machine # [ 154.424668] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2827machine # [ 154.426049] systemd[1]: Starting templated-reload-triggers@instance.service...2828machine # [ 154.463206] systemd[1]: Starting templated-simple-restart-service@instance.service...2829machine # [ 154.509902] systemd[1]: Finished reload-triggers-and-restart.service.2830machine # [ 154.517315] systemd[1]: Finished templated-no-restart-service@instance.service.2831machine # [ 154.537317] systemd[1]: Finished templated-simple-restart-service@instance.service.2832machine # [ 154.581259] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2833machine # [ 154.582386] systemd[1]: Finished simple-reload-service.service.2834machine # [ 154.583208] systemd[1]: Finished simple-restart-service.service.2835machine # [ 154.595257] systemd[1]: Finished simple-service.service.2836machine # [ 154.598938] systemd[1]: Finished reload-triggers.service.2837machine # [ 154.601382] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2838machine # [ 154.610816] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2839machine # [ 154.614423] systemd[1]: Finished templated-reload-triggers@instance.service.2840machine # [ 154.633051] systemd[1]: linger-users.service: Deactivated successfully.2841machine # [ 154.635331] systemd[1]: Finished linger-users.service.2842machine # [ 154.895619] nixos[6875]: finished switching to system configuration /nix/store/c2hv4d4c4s3qhdpgbpazm22whvpd46rj-nixos-system-machine-test2843machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.69 seconds)2844machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12845machine # [ 155.608859] nixos[7045]: switching to system configuration /nix/store/c2hv4d4c4s3qhdpgbpazm22whvpd46rj-nixos-system-machine-test2846machine # [ 155.611992] systemd[1]: Stopped target Local File Systems.2847machine # [ 155.614876] systemd[1]: Stopped target Remote File Systems.2848machine # [ 156.129544] systemd[1]: Reload requested from client PID 7045 ('.switch-to-conf') (unit backdoor.service)...2849machine # [ 156.131477] systemd[1]: Reloading...2850machine # [ 156.786239] systemd[1]: Reloading finished in 652 ms.2851machine # [ 156.936681] systemd[581]: Reexecution requested from client PID 7116 ('switch-to-confi')...2852machine # [ 156.940959] systemd[581]: Reexecuting.2853machine # [ 156.994011] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2854machine # [ 157.187898] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2855machine # [ 157.195871] systemd[581]: Reload requested from client PID 7116 ('switch-to-confi')...2856machine # [ 157.199306] systemd[581]: Reloading...2857machine # [ 157.390737] systemd[581]: Reloading finished in 192 ms.2858machine # [ 157.404185] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2859machine # [ 157.413837] systemd[581]: Stopped Run user-specific NixOS activation.2860machine # [ 157.416149] systemd[581]: Stopping Run user-specific NixOS activation...2861machine # [ 157.419392] systemd[581]: Starting Run user-specific NixOS activation...2862machine # [ 157.465183] systemd[581]: Finished Run user-specific NixOS activation.2863machine # [ 157.469652] systemd[1]: Stopped target Reactivate sysinit units.2864machine # [ 157.470564] systemd[1]: Stopping Reactivate sysinit units...2865machine # [ 157.471348] systemd[1]: Reached target Reactivate sysinit units.2866machine # [ 157.478089] systemd[1]: Reloading reload-triggers-and-restart.service...2867machine # [ 157.486291] systemd[1]: Reloading reload-triggers.service...2868machine # [ 157.492480] systemd[1]: Reloading simple-reload-service.service...2869machine # [ 157.506307] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service...2870machine # [ 157.512968] systemd[1]: Reloading templated-reload-triggers@instance.service...2871machine # [ 157.520561] systemd[1]: Reloading templated-simple-reload-service@instance.service...2872machine # [ 157.572290] systemd[1]: Reloaded reload-triggers-and-restart.service.2873machine # [ 157.582211] systemd[1]: Reloaded reload-triggers.service.2874machine # [ 157.587210] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service.2875machine # [ 157.591893] systemd[1]: Reloaded simple-reload-service.service.2876machine # [ 157.600824] systemd[1]: Reloaded templated-reload-triggers@instance.service.2877machine # [ 157.603750] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2878machine # [ 157.607146] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2879machine # [ 157.610588] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2880machine # [ 157.611775] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2881machine # [ 157.614585] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2882machine # [ 157.618486] systemd[1]: simple-restart-service.service: Deactivated successfully.2883machine # [ 157.619796] systemd[1]: Stopped simple-restart-service.service.2884machine # [ 157.621284] systemd[1]: Stopping simple-restart-service.service...2885machine # [ 157.628720] systemd[1]: Starting simple-restart-service.service...2886machine # [ 157.629657] systemd[1]: simple-service.service: Deactivated successfully.2887machine # [ 157.630580] systemd[1]: Stopped simple-service.service.2888machine # [ 157.631295] systemd[1]: Stopping simple-service.service...2889machine # [ 157.645074] systemd[1]: Starting simple-service.service...2890machine # [ 157.646330] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2891machine # [ 157.650095] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2892machine # [ 157.651685] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2893machine # [ 157.658499] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2894machine # [ 157.664701] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2895machine # [ 157.676354] systemd[1]: Stopped templated-simple-restart-service@instance.service.2896machine # [ 157.677552] systemd[1]: Stopping templated-simple-restart-service@instance.service...2897machine # [ 157.678683] systemd[1]: Starting templated-simple-restart-service@instance.service...2898machine # [ 157.679706] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2899machine # [ 157.685986] systemd[1]: Stopped templated-simple-service@instance.service.2900machine # [ 157.687518] systemd[1]: Stopping templated-simple-service@instance.service...2901machine # [ 157.698962] systemd[1]: Starting templated-simple-service@instance.service...2902machine # [ 157.735256] systemd[1]: Finished simple-service.service.2903machine # [ 157.740789] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2904machine # [ 157.743640] systemd[1]: Finished simple-restart-service.service.2905machine # [ 157.752613] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2906machine # [ 157.755581] systemd[1]: Finished templated-simple-restart-service@instance.service.2907machine # [ 157.762764] systemd[1]: Finished templated-simple-service@instance.service.2908machine # [ 157.769388] systemd[1]: Reached target Local File Systems.2909machine # [ 157.771991] systemd[1]: Reached target Remote File Systems.2910machine # [ 157.778091] systemd[1]: Starting linger-users.service...2911machine # [ 157.782576] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2912machine # [ 157.790897] systemd[1]: Starting Create SUID/SGID Wrappers...2913machine # [ 157.791848] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2914machine # [ 157.801337] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672915machine # [ 157.803568] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2916machine # [ 157.807406] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2917machine # [ 157.810562] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2918machine # [ 157.812969] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2919machine # [ 157.815418] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2920machine # [ 157.874789] systemd[1]: linger-users.service: Deactivated successfully.2921machine # [ 157.877323] systemd[1]: Finished linger-users.service.2922machine # [ 158.142849] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2923machine # [ 158.146199] systemd[1]: Finished Create SUID/SGID Wrappers.2924machine # [ 158.403242] nixos[7045]: finished switching to system configuration /nix/store/c2hv4d4c4s3qhdpgbpazm22whvpd46rj-nixos-system-machine-test2925machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.51 seconds)2926machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&12927machine # [ 159.192179] nixos[7211]: switching to system configuration /nix/store/fcvqsmcbfrq8nqh280idms8f6pp293nn-nixos-system-machine-test2928machine # [ 159.195532] systemd[1]: Stopped target Local File Systems.2929machine # [ 159.196928] systemd[1]: Stopped target Remote File Systems.2930machine # [ 159.770332] systemd[1]: Reload requested from client PID 7211 ('.switch-to-conf') (unit backdoor.service)...2931machine # [ 159.772350] systemd[1]: Reloading...2932machine # [ 160.502949] systemd[1]: Reloading finished in 727 ms.2933machine # [ 160.659893] systemd[581]: Reexecution requested from client PID 7282 ('switch-to-confi')...2934machine # [ 160.662091] systemd[581]: Reexecuting.2935machine # [ 160.730084] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2936machine # [ 160.928485] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2937machine # [ 160.935636] systemd[581]: Reload requested from client PID 7282 ('switch-to-confi')...2938machine # [ 160.938995] systemd[581]: Reloading...2939machine # [ 161.111964] systemd[581]: Reloading finished in 173 ms.2940machine # [ 161.124152] systemd[581]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2941machine # [ 161.133962] systemd[581]: Stopped Run user-specific NixOS activation.2942machine # [ 161.136112] systemd[581]: Stopping Run user-specific NixOS activation...2943machine # [ 161.139137] systemd[581]: Starting Run user-specific NixOS activation...2944machine # [ 161.184620] systemd[581]: Finished Run user-specific NixOS activation.2945machine # [ 161.188607] systemd[1]: Stopped target Reactivate sysinit units.2946machine # [ 161.193445] systemd[1]: Stopping Reactivate sysinit units...2947machine # [ 161.194343] systemd[1]: Reached target Reactivate sysinit units.2948machine # [ 161.197038] systemd[1]: Reloading reload-triggers.service...2949machine # [ 161.204284] systemd[1]: Reloading simple-reload-service.service...2950machine # [ 161.207387] systemd[1]: Reloading templated-reload-triggers@instance.service...2951machine # [ 161.220607] systemd[1]: Reloading templated-simple-reload-service@instance.service...2952machine # [ 161.269166] systemd[1]: Reloaded reload-triggers.service.2953machine # [ 161.271874] systemd[1]: Reloaded simple-reload-service.service.2954machine # [ 161.276661] systemd[1]: Reloaded templated-reload-triggers@instance.service.2955machine # [ 161.282916] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2956machine # [ 161.286368] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2957machine # [ 161.289876] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2958machine # [ 161.291033] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2959machine # [ 161.293911] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2960machine # [ 161.297697] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully.2961machine # [ 161.299233] systemd[1]: Stopped reload-triggers-and-restart.service.2962machine # [ 161.304662] systemd[1]: Stopping reload-triggers-and-restart.service...2963machine # [ 161.305857] systemd[1]: Starting reload-triggers-and-restart.service...2964machine # [ 161.315011] systemd[1]: simple-restart-service.service: Deactivated successfully.2965machine # [ 161.317096] systemd[1]: Stopped simple-restart-service.service.2966machine # [ 161.326007] systemd[1]: Stopping simple-restart-service.service...2967machine # [ 161.334180] systemd[1]: Starting simple-restart-service.service...2968machine # [ 161.337799] systemd[1]: simple-service.service: Deactivated successfully.2969machine # [ 161.339240] systemd[1]: Stopped simple-service.service.2970machine # [ 161.351099] systemd[1]: Stopping simple-service.service...2971machine # [ 161.362798] systemd[1]: Starting simple-service.service...2972machine # [ 161.370108] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2973machine # [ 161.371543] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2974machine # [ 161.393813] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2975machine # [ 161.401803] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2976machine # [ 161.412460] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully.2977machine # [ 161.426005] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service.2978machine # [ 161.445452] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service...2979machine # [ 161.446799] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2980machine # [ 161.447882] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2981machine # [ 161.450607] systemd[1]: Stopped templated-simple-restart-service@instance.service.2982machine # [ 161.452629] systemd[1]: Stopping templated-simple-restart-service@instance.service...2983machine # [ 161.456813] systemd[1]: Starting templated-simple-restart-service@instance.service...2984machine # [ 161.458261] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2985machine # [ 161.460512] systemd[1]: Stopped templated-simple-service@instance.service.2986machine # [ 161.461775] systemd[1]: Stopping templated-simple-service@instance.service...2987machine # [ 161.462967] systemd[1]: Starting templated-simple-service@instance.service...2988machine # [ 161.464637] systemd[1]: Finished reload-triggers-and-restart.service.2989machine # [ 161.466360] systemd[1]: Finished simple-restart-service.service.2990machine # [ 161.467773] systemd[1]: Finished simple-service.service.2991machine # [ 161.469549] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2992machine # [ 161.477963] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2993machine # [ 161.480515] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2994machine # [ 161.484890] systemd[1]: Finished templated-simple-service@instance.service.2995machine # [ 161.489210] systemd[1]: Finished templated-simple-restart-service@instance.service.2996machine # [ 161.493432] systemd[1]: Reached target Local File Systems.2997machine # [ 161.497048] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2998machine # [ 161.501131] systemd[1]: Starting Create SUID/SGID Wrappers...2999machine # [ 161.502016] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.3000machine # [ 161.503461] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc673001machine # [ 161.516487] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore3002machine # [ 161.518108] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3003machine # [ 161.519314] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3004machine # [ 161.522298] systemd[1]: Reached target Remote File Systems.3005machine # [ 161.523937] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os3006machine # [ 161.525332] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki3007machine # [ 161.838904] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.3008machine # [ 161.843554] systemd[1]: Finished Create SUID/SGID Wrappers.3009machine # [ 161.846216] systemd[1]: Starting linger-users.service...3010machine # [ 161.907432] systemd[1]: linger-users.service: Deactivated successfully.3011machine # [ 161.910434] systemd[1]: Finished linger-users.service.3012machine # [ 162.167275] nixos[7211]: finished switching to system configuration /nix/store/fcvqsmcbfrq8nqh280idms8f6pp293nn-nixos-system-machine-test3013machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 3.76 seconds)3014machine: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&13015machine: (finished: must succeed: /nix/store/kz11kvzsjdhwhh3qp3ack06r7ibgf35m-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.90 seconds)3016(finished: subtest: restart and reload by activation script, in 14.81 seconds)3017(finished: run the VM test script, in 163.83 seconds)3018test script finished in 163.88s3019cleanup3020kill QemuMachine (pid 45)3021machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)3022(finished: cleanup, in 0.21 seconds)3023additionally exposed symbols:3024 machine, other,3025 vlan1,3026 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