vm-test-run-switch-test-services
checks.aarch64-linux.switchTest
· build #21
· raw
1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.01 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 # Disk image does not exist, creating the virtualisation disk image...11machine: QEMU running (pid 45)12machine # Formatting '/build/vm-state-machine/tmp.31fXKd9QEo', 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: ba3e954d-d93a-4fa7-8371-d9f1c9bbef2317machine # Superblock backups stored on blocks:18machine # 32768, 98304, 163840, 22937619machine # 20machine # Allocating group tables: 0/8 done21machine # Writing inode tables: 0/8 done22machine # Creating journal (8192 blocks): done23machine # Writing superblocks and filesystem accounting information: 0/8 done24machine # 25machine # Virtualisation disk image created.26machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]27machine # [ 0.000000] Linux version 6.18.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Aug 28 06:22:54 UTC 202628machine # [ 0.000000] KASLR enabled29machine # [ 0.000000] random: crng init done30machine # [ 0.000000] Machine model: linux,dummy-virt31machine # [ 0.000000] efi: UEFI not found.32machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT33machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]34machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f]35machine # [ 0.000000] Zone ranges:36machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]37machine # [ 0.000000] DMA32 empty38machine # [ 0.000000] Normal empty39machine # [ 0.000000] Device empty40machine # [ 0.000000] Movable zone start for each node41machine # [ 0.000000] Early memory node ranges42machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]43machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]44machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc0000045machine # [ 0.000000] psci: probing for conduit method from DT.46machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.47machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs48machine # [ 0.000000] psci: Trusted OS migration not required49machine # [ 0.000000] psci: SMC Calling Convention v1.150machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)51machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u31129652machine # [ 0.000000] Detected PIPT I-cache on CPU053machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)54machine # [ 0.000000] CPU features: detected: GICv3 CPU interface55machine # [ 0.000000] CPU features: detected: Spectre-v456machine # [ 0.000000] CPU features: detected: Spectre-BHB57machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_3858machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_2359machine # [ 0.000000] alternatives: applying boot alternatives60machine # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/init regInfo=/nix/store/xnabmz5mzjmnf1ig382687zqn5523hkz-closure-info/registration console=ttyAMA0,115200n8 console=tty061machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/xnabmz5mzjmnf1ig382687zqn5523hkz-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 @0x0000000044d1000098machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d2000099machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.100machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns101machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).102machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns103machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns104machine # [ 0.000030] arm-pv: using stolen time PV105machine # [ 0.000396] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)106machine # [ 0.000570] Console: colour dummy device 80x25107machine # [ 0.000578] printk: legacy console [tty0] enabled108machine # [ 0.000787] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)109machine # [ 0.000795] pid_max: default: 32768 minimum: 301110machine # [ 0.000877] LSM: initializing lsm=capability,landlock,yama,bpf,ima111machine # [ 0.001009] landlock: Up and running.112machine # [ 0.001012] Yama: becoming mindful.113machine # [ 0.001477] LSM support for eBPF active114machine # [ 0.001604] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)115machine # [ 0.001623] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)116machine # [ 0.002754] cacheinfo: Unable to detect cache hierarchy for CPU 0117machine # [ 0.003544] rcu: Hierarchical SRCU implementation.118machine # [ 0.003548] rcu: Max phase no-delay instances is 1000.119machine # [ 0.004781] fsl-mc MSI: its@8080000 domain created120machine # [ 0.004871] EFI services will not be available.121machine # [ 0.004955] smp: Bringing up secondary CPUs ...122machine # [ 0.004963] smp: Brought up 1 node, 1 CPU123machine # [ 0.004967] SMP: Total of 1 processors activated.124machine # [ 0.004970] CPU: All CPU(s) started at EL1125machine # [ 0.004984] CPU features: detected: Branch Target Identification126machine # [ 0.004989] CPU features: detected: ARMv8.4 Translation Table Level127machine # [ 0.004992] CPU features: detected: Instruction cache invalidation not required for I/D coherence128machine # [ 0.004996] CPU features: detected: Data cache clean to the PoU not required for I/D coherence129machine # [ 0.004999] CPU features: detected: Common not Private translations130machine # [ 0.005002] CPU features: detected: CRC32 instructions131machine # [ 0.005005] CPU features: detected: Data cache clean to Point of Deep Persistence132machine # [ 0.005008] CPU features: detected: Data cache clean to Point of Persistence133machine # [ 0.005012] CPU features: detected: Data independent timing control (DIT)134machine # [ 0.005015] CPU features: detected: E0PD135machine # [ 0.005017] CPU features: detected: Enhanced Counter Virtualization136machine # [ 0.005020] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)137machine # [ 0.005024] CPU features: detected: Enhanced Virtualization Traps138machine # [ 0.005027] CPU features: detected: Fine Grained Traps139machine # [ 0.005031] CPU features: detected: Generic authentication (architected QARMA5 algorithm)140machine # [ 0.005036] CPU features: detected: RCpc load-acquire (LDAPR)141machine # [ 0.005039] CPU features: detected: LSE atomic instructions142machine # [ 0.005042] CPU features: detected: Privileged Access Never143machine # [ 0.005044] CPU features: detected: PMUv3144machine # [ 0.005047] CPU features: detected: RAS Extension Support145machine # [ 0.005049] CPU features: detected: RASv1p1 Extension Support146machine # [ 0.005052] CPU features: detected: Random Number Generator147machine # [ 0.005054] CPU features: detected: Speculation barrier (SB)148machine # [ 0.005057] CPU features: detected: Stage-2 Force Write-Back149machine # [ 0.005060] CPU features: detected: TLB range maintenance instructions150machine # [ 0.005065] CPU features: detected: Speculative Store Bypassing Safe (SSBS)151machine # [ 0.005103] alternatives: applying system-wide alternatives152machine # [ 0.008134] CPU features: detected: BBM Level 2 without TLB conflict abort153machine # [ 0.008354] Memory: 894664K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 112584K reserved, 32768K cma-reserved)154machine # [ 0.008721] devtmpfs: initialized155machine # [ 0.010521] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)156machine # [ 0.010546] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).157machine # [ 0.010748] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL158machine # [ 0.010752] 0 pages in range for non-PLT usage159machine # [ 0.010753] 508288 pages in range for PLT usage160machine # [ 0.010864] pinctrl core: initialized pinctrl subsystem161machine # [ 0.011657] DMI not present or invalid.162machine # [ 0.014788] NET: Registered PF_NETLINK/PF_ROUTE protocol family163machine # [ 0.017068] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations164machine # [ 0.017215] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations165machine # [ 0.017377] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations166machine # [ 0.017398] audit: initializing netlink subsys (disabled)167machine # [ 0.018007] thermal_sys: Registered thermal governor 'fair_share'168machine # [ 0.018009] thermal_sys: Registered thermal governor 'bang_bang'169machine # [ 0.018013] thermal_sys: Registered thermal governor 'step_wise'170machine # [ 0.018016] thermal_sys: Registered thermal governor 'user_space'171machine # [ 0.018021] thermal_sys: Registered thermal governor 'power_allocator'172machine # [ 0.018046] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1173machine # [ 0.018055] cpuidle: using governor ladder174machine # [ 0.018061] cpuidle: using governor menu175machine # [ 0.018260] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.176machine # [ 0.018276] ASID allocator initialised with 65536 entries177machine # [ 0.019455] Serial: AMBA PL011 UART driver178machine # [ 0.024668] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1179machine # [ 0.024833] printk: console [ttyAMA0] enabled180machine # [ 0.146555] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages181machine # [ 0.146576] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page182machine # [ 0.146582] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages183machine # [ 0.146586] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page184machine # [ 0.146591] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages185machine # [ 0.146595] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page186machine # [ 0.146601] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages187machine # [ 0.146605] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page188machine # [ 0.154057] fbcon: Taking over console189machine # [ 0.154076] ACPI: Interpreter disabled.190machine # [ 0.156001] iommu: Default domain type: Translated191machine # [ 0.156011] iommu: DMA domain TLB invalidation policy: strict mode192machine # [ 0.157716] SCSI subsystem initialized193machine # [ 0.162934] usbcore: registered new interface driver usbfs194machine # [ 0.162969] usbcore: registered new interface driver hub195machine # [ 0.162986] usbcore: registered new device driver usb196machine # [ 0.163266] pps_core: LinuxPPS API ver. 1 registered197machine # [ 0.163272] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>198machine # [ 0.163282] PTP clock support registered199machine # [ 0.163331] EDAC MC: Ver: 3.0.0200machine # [ 0.168029] scmi_core: SCMI protocol bus registered201machine # [ 0.169017] FPGA manager framework202machine # [ 0.169975] vgaarb: loaded203machine # [ 0.170630] clocksource: Switched to clocksource arch_sys_counter204machine # [ 0.174625] VFS: Disk quotas dquot_6.6.0205machine # [ 0.177226] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)206machine # [ 0.178460] netfs: FS-Cache loaded207machine # [ 0.178599] pnp: PnP ACPI: disabled208machine # [ 0.182687] NET: Registered PF_INET protocol family209machine # [ 0.182862] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)210machine # [ 0.213685] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)211machine # [ 0.213739] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)212machine # [ 0.213768] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)213machine # [ 0.213819] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)214machine # [ 0.213898] TCP: Hash tables configured (established 8192 bind 8192)215machine # [ 0.213989] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)216machine # [ 0.214052] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)217machine # [ 0.214111] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)218machine # [ 0.214193] NET: Registered PF_UNIX/PF_LOCAL protocol family219machine # [ 0.214258] NET: Registered PF_XDP protocol family220machine # [ 0.214281] PCI: CLS 0 bytes, default 64221machine # [ 0.214543] Trying to unpack rootfs image as initramfs...222machine # [ 0.232486] kvm [1]: HYP mode not available223machine # [ 0.361475] Initialise system trusted keyrings224machine # [ 0.362264] workingset: timestamp_bits=42 max_order=18 bucket_order=0225machine # [ 0.363615] squashfs: version 4.0 (2009/01/31) Phillip Lougher226machine # [ 0.364402] 9p: Installing v9fs 9p2000 file system support227machine # [ 0.388504] Key type asymmetric registered228machine # [ 0.388536] Asymmetric key parser 'x509' registered229machine # [ 0.388623] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)230machine # [ 0.394715] io scheduler mq-deadline registered231machine # [ 0.394740] io scheduler kyber registered232machine # [ 0.406814] pl061_gpio 9030000.pl061: PL061 GPIO chip registered233machine # [ 0.407564] ledtrig-cpu: registered to indicate activity on CPUs234machine # [ 0.407944] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:235machine # [ 0.407963] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000236machine # [ 0.407991] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000237machine # [ 0.408000] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000238machine # [ 0.408023] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits239machine # [ 0.408049] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]240machine # [ 0.408159] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00241machine # [ 0.408168] pci_bus 0000:00: root bus resource [bus 00-ff]242machine # [ 0.408175] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]243machine # [ 0.408180] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]244machine # [ 0.408185] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]245machine # [ 0.408309] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint246machine # [ 0.408752] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint247machine # [ 0.408942] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]248machine # [ 0.408960] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]249machine # [ 0.408991] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]250machine # [ 0.409008] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]251machine # [ 0.409467] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint252machine # [ 0.409648] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]253machine # [ 0.409664] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]254machine # [ 0.409694] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]255machine # [ 0.410139] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint256machine # [ 0.410318] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]257machine # [ 0.410334] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]258machine # [ 0.410364] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]259machine # [ 0.410852] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint260machine # [ 0.411054] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]261machine # [ 0.411071] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]262machine # [ 0.411101] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]263machine # [ 0.411562] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint264machine # [ 0.411754] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]265machine # [ 0.411770] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]266machine # [ 0.411800] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]267machine # [ 0.412249] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint268machine # [ 0.412428] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]269machine # [ 0.412445] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]270machine # [ 0.412475] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]271machine # [ 0.412913] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint272machine # [ 0.413096] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]273machine # [ 0.413112] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]274machine # [ 0.413142] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]275machine # [ 0.413158] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]276machine # [ 0.413649] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint277machine # [ 0.413840] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]278machine # [ 0.413870] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]279machine # [ 0.414322] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint280machine # [ 0.414511] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]281machine # [ 0.414541] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]282machine # [ 0.463087] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint283machine # [ 0.463298] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]284machine # [ 0.463565] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint285machine # [ 0.463851] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]286machine # [ 0.463869] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]287machine # [ 0.463899] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]288machine # [ 0.464352] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint289machine # [ 0.464531] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]290machine # [ 0.464547] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]291machine # [ 0.464577] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]292machine # [ 0.465169] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned293machine # [ 0.465181] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned294machine # [ 0.465188] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned295machine # [ 0.465234] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned296machine # [ 0.465281] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned297machine # [ 0.465329] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned298machine # [ 0.465375] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned299machine # [ 0.465422] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned300machine # [ 0.465469] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned301machine # [ 0.465517] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned302machine # [ 0.465568] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned303machine # [ 0.465615] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned304machine # [ 0.465680] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned305machine # [ 0.465725] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned306machine # [ 0.465747] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned307machine # [ 0.465815] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned308machine # [ 0.465838] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned309machine # [ 0.465859] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned310machine # [ 0.465887] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned311machine # [ 0.465909] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned312machine # [ 0.465931] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned313machine # [ 0.465954] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned314machine # [ 0.465977] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned315machine # [ 0.466000] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned316machine # [ 0.466024] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned317machine # [ 0.466045] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned318machine # [ 0.466067] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned319machine # [ 0.466090] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned320machine # [ 0.466112] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned321machine # [ 0.466134] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned322machine # [ 0.466155] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned323machine # [ 0.466177] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned324machine # [ 0.466198] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned325machine # [ 0.466220] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned326machine # [ 0.466249] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]327machine # [ 0.466259] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]328machine # [ 0.466264] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]329machine # [ 0.506347] pci 0000:00:0a.0: enabling device (0000 -> 0002)330machine # [ 0.530465] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)331machine # [ 0.540150] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)332machine # [ 0.551412] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)333machine # [ 0.555787] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)334machine # [ 0.557935] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)335machine # [ 0.568603] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)336machine # [ 0.571728] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)337machine # [ 0.574198] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)338machine # [ 0.584874] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)339machine # [ 0.594962] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)340machine # [ 0.599454] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)341machine # [ 0.613249] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled342machine # [ 0.616135] msm_serial: driver initialized343machine # [ 0.616324] SuperH (H)SCI(F) driver initialized344machine # [ 0.616378] STM32 USART driver initialized345machine # [ 0.653649] loop: module loaded346machine # [ 0.653886] virtio_blk virtio5: 1/0/0 default/read/poll queues347machine # [ 0.656307] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)348machine # [ 0.667542] megasas: 07.734.00.00-rc1349machine # [ 0.668382] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]350machine # [ 0.670441] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000351machine # [ 0.670486] Intel/Sharp Extended Query Table at 0x0031352machine # [ 0.672378] Using buffer write method353machine # [ 0.672533] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]354machine # [ 0.674452] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000355machine # [ 0.674493] Intel/Sharp Extended Query Table at 0x0031356machine # [ 0.693861] Using buffer write method357machine # [ 0.693940] Concatenating MTD devices:358machine # [ 0.693944] (0): "0.flash"359machine # [ 0.693949] (1): "0.flash"360machine # [ 0.693953] into device "0.flash"361machine # [ 0.983300] Freeing initrd memory: 25724K362machine # [ 0.989695] tun: Universal TUN/TAP device driver, 1.6363machine # [ 0.994268] thunder_xcv, ver 1.0364machine # [ 0.994338] thunder_bgx, ver 1.0365machine # [ 0.994363] nicpf, ver 1.0366machine # [ 0.996206] e1000: Intel(R) PRO/1000 Network Driver367machine # [ 0.996221] e1000: Copyright (c) 1999-2006 Intel Corporation.368machine # [ 0.996254] e1000e: Intel(R) PRO/1000 Network Driver369machine # [ 0.996267] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.370machine # [ 0.996295] igb: Intel(R) Gigabit Ethernet Network Driver371machine # [ 0.996301] igb: Copyright (c) 2007-2014 Intel Corporation.372machine # [ 0.996324] igbvf: Intel(R) Gigabit Virtual Function Network Driver373machine # [ 0.996330] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.374machine # [ 0.996470] sky2: driver version 1.30375machine # [ 0.998148] usbcore: registered new interface driver usb-storage376machine # [ 0.998264] usbcore: registered new interface driver usbserial_generic377machine # [ 0.998280] usbserial: USB Serial support registered for generic378machine # [ 0.999442] ehci-pci 0000:00:0a.0: EHCI Host Controller379machine # [ 0.999492] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1380machine # [ 0.999730] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000381machine # [ 1.011192] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00382machine # [ 1.011670] hub 1-0:1.0: USB hub found383machine # [ 1.011699] hub 1-0:1.0: 6 ports detected384machine # [ 1.014342] hv_vmbus: registering driver hyperv_keyboard385machine # [ 1.016225] rtc-pl031 9010000.pl031: registered as rtc0386machine # [ 1.016270] rtc-pl031 9010000.pl031: setting system clock to 2026-09-04T02:32:49 UTC (1788489169)387machine # [ 1.016637] i2c_dev: i2c /dev entries driver388machine # [ 1.022074] sdhci: Secure Digital Host Controller Interface driver389machine # [ 1.022092] sdhci: Copyright(c) Pierre Ossman390machine # [ 1.022373] Synopsys Designware Multimedia Card Interface Driver391machine # [ 1.024921] sdhci-pltfm: SDHCI platform and OF driver helper392machine # [ 1.027666] hid: raw HID events driver (C) Jiri Kosina393machine # [ 1.027934] usbcore: registered new interface driver usbhid394machine # [ 1.027943] usbhid: USB HID core driver395machine # [ 1.031064] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available396machine # [ 1.032708] drop_monitor: Initializing network drop monitor service397machine # [ 1.032918] NET: Registered PF_INET6 protocol family398machine # [ 1.036468] Segment Routing with IPv6399machine # [ 1.036498] In-situ OAM (IOAM) with IPv6400machine # [ 1.036529] NET: Registered PF_PACKET protocol family401machine # [ 1.038209] 9pnet: Installing 9P2000 support402machine # [ 1.041268] Key type dns_resolver registered403machine # [ 1.047853] registered taskstats version 1404machine # [ 1.048022] Loading compiled-in X.509 certificates405machine # [ 1.057276] Demotion targets for Node 0: null406machine # [ 1.057419] Key type .fscrypt registered407machine # [ 1.057428] Key type fscrypt-provisioning registered408machine # [ 1.057535] ima: No TPM chip found, activating TPM-bypass!409machine # [ 1.057556] ima: Allocated hash algorithm: sha1410machine # [ 1.057580] ima: No architecture policies found411machine # [ 1.061982] input: gpio-keys as /devices/platform/gpio-keys/input/input0412machine # [ 1.081891] clk: Disabling unused clocks413machine # [ 1.081937] PM: genpd: Disabling unused power domains414machine # [ 1.086327] Freeing unused kernel memory: 4736K415machine # [ 1.086567] Run /init as init process416machine # [ 1.105201] systemd[1]: Successfully made /usr/ read-only.417machine # [ 1.259412] usb 1-1: new high-speed USB device number 2 using ehci-pci418machine # [ 1.409067] 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.440276] systemd[1]: systemd 262-175b52e 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.444493] systemd[1]: Detected virtualization qemu.421machine # [ 1.445179] systemd[1]: Detected architecture arm64.422machine # [ 1.445879] systemd[1]: Running in initrd.423machine # [ 1.446932] systemd[1]: Initializing machine ID from random generator.424machine # [ 1.447931] systemd[1]: Hostname set to <machine>.425machine # [ 1.498967] 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.581775] systemd[1]: bpf-restrict-fs: LSM BPF program attached427machine # [ 1.618761] usb 1-2: new high-speed USB device number 3 using ehci-pci428machine # [ 1.641848] systemd[1]: Queued start job for default target Initrd Default Target.429machine # [ 1.648867] systemd[1]: Created slice Slice /system/modprobe.430machine # [ 1.649923] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.431machine # [ 1.651069] systemd[1]: Expecting device /dev/disk/by-label/nixos...432machine # [ 1.651108] systemd[1]: Reached target Path Units.433machine # [ 1.651125] systemd[1]: Reached target Slice Units.434machine # [ 1.651141] systemd[1]: Reached target Swaps.435machine # [ 1.651157] systemd[1]: Reached target Timer Units.436machine # [ 1.651322] systemd[1]: Listening on D-Bus System Message Bus Socket.437machine # [ 1.651490] systemd[1]: Listening on Journal Socket (/dev/log).438machine # [ 1.651624] systemd[1]: Listening on Journal Sockets.439machine # [ 1.651709] systemd[1]: Listening on udev Kernel Socket.440machine # [ 1.651726] systemd[1]: Reached target Socket Units.441machine # [ 1.660082] systemd[1]: Starting Create List of Static Device Nodes...442machine # [ 1.670263] systemd[1]: Starting Load Kernel Module 9pnet_virtio...443machine # [ 1.671731] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs444machine # [ 1.684488] systemd[1]: Mounting Kernel Configuration File System...445machine # [ 1.707145] systemd[1]: Starting Journal Service...446machine # [ 1.714990] systemd[1]: Starting Load Kernel Modules...447machine # [ 1.715863] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os448machine # [ 1.723012] systemd[1]: Starting Coldplug All udev Devices...449machine # [ 1.739158] systemd[1]: Finished Create List of Static Device Nodes.450machine # [ 1.751936] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.451machine # [ 1.755231] systemd[1]: Finished Load Kernel Module 9pnet_virtio.452machine # [ 1.782978] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...453machine # [ 1.784883] 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/input2454machine # [ 1.785027] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0455machine # [ 1.790577] systemd-journald[73]: Collecting audit messages is disabled.456machine # [ 1.795816] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.457machine # [ 1.811516] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev458machine # [ 1.814004] systemd[1]: Mounted Kernel Configuration File System.459machine # [ 1.827296] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0460machine # [ 1.827549] [drm] features: -virgl +edid -resource_blob -host_visible461machine # [ 1.827559] [drm] features: -context_init462machine # [ 1.828286] [drm] number of scanouts: 1463machine # [ 1.828304] [drm] number of cap sets: 0464machine # [ 1.842820] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.465machine # [ 1.851157] systemd[1]: Starting Create Static Device Nodes in /dev...466machine # [ 1.855973] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic467machine # [ 1.856000] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0468machine # [ 1.882986] Console: switching to colour frame buffer device 160x50469machine # [ 1.890040] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device470machine # [ 1.911592] systemd[1]: Finished Create Static Device Nodes in /dev.471machine # [ 1.911808] systemd[1]: Reached target Preparation for Local File Systems.472machine # [ 1.911845] systemd[1]: Reached target Local File Systems.473machine # [ 1.919359] systemd[1]: Starting Rule-based Manager for Device Events and Files...474machine # [ 1.944579] systemd[1]: Finished Load Kernel Modules.475machine # [ 1.959428] systemd[1]: Starting Apply Kernel Variables...476machine # [ 2.011298] systemd[1]: Started Journal Service.477machine # [ 2.000979] systemd-modules-load[74]: Inserted module 'dm_mod'478machine # [ 2.004731] systemd-modules-load[74]: Module 'virtio_balloon' is built in479machine # [ 2.005945] systemd-modules-load[74]: Module 'virtio_console' is built in480machine # [ 2.006976] systemd-modules-load[74]: Inserted module 'virtio_gpu'481machine # [ 2.022170] systemd-modules-load[74]: Module 'virtio_rng' is built in482machine # [ 2.023297] systemd[1]: Starting Create System Files and Directories...483machine # [ 2.034278] systemd[1]: Finished Apply Kernel Variables.484machine # [ 2.042567] systemd-udevd[80]: Using default interface naming scheme 'v261'.485machine # [ 2.082683] systemd[1]: Finished Create System Files and Directories.486machine # [ 2.091914] systemd[1]: Started Rule-based Manager for Device Events and Files.487machine # [ 2.184283] systemd[1]: Starting Virtual Console Setup...488machine # [ 2.264721] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.489machine # [ 2.270703] systemd[1]: Finished Virtual Console Setup.490machine # [ 2.885348] systemd[1]: Finished Coldplug All udev Devices.491machine # [ 2.887014] systemd[1]: Reached target System Initialization.492machine # [ 2.889415] systemd[1]: Reached target Basic System.493machine # [ 3.028352] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line.494machine # [ 3.060919] (udev-worker)[95]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.495machine # [ 3.068206] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.496machine # [ 3.143435] systemd[1]: Found device /dev/disk/by-label/nixos.497machine # [ 3.146798] systemd[1]: Reached target Initrd Root Device.498machine # [ 3.151510] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...499machine # [ 3.206008] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks500machine # [ 3.212274] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.501machine # [ 3.220443] systemd[1]: Mounting /sysroot...502machine # [ 3.283714] EXT4-fs (vda): mounted filesystem ba3e954d-d93a-4fa7-8371-d9f1c9bbef23 r/w with ordered data mode. Quota mode: none.503machine # [ 3.275800] systemd[1]: Mounted /sysroot.504machine # [ 3.279221] systemd[1]: Reached target Initrd Root File System.505machine # [ 3.284551] systemd[1]: Starting Mountpoints Configured in the Real Root...506machine # [ 3.320443] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload.507machine # [ 3.326577] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)...508machine # [ 3.332279] systemd[1]: Reloading...509machine # [ 3.535951] systemd[1]: Reloading finished in 202 ms.510machine # [ 3.568505] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace...511machine # [ 3.573693] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace...512machine # [ 3.580890] systemd[1]: Starting Load Kernel Module 9pnet_virtio...513machine # [ 3.583828] systemd[1]: initrd-parse-etc.service: Deactivated successfully.514machine # [ 3.591712] systemd[1]: Finished Mountpoints Configured in the Real Root.515machine # [ 3.593237] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.516machine # [ 3.619595] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.517machine # [ 3.623457] systemd[1]: Finished Load Kernel Module 9pnet_virtio.518machine # [ 3.725047] systemd[1]: Mounting /sysroot/nix/.ro-store...519machine # [ 3.742635] systemd[1]: Mounting /sysroot/nix/.rw-store...520machine # [ 3.755244] systemd[1]: Mounting /sysroot/run...521machine # [ 3.766577] systemd[1]: Mounting /sysroot/tmp/shared...522machine # [ 3.798064] systemd[1]: Mounting /sysroot/tmp/xchg...523machine # [ 3.827385] systemd[1]: Mounted /sysroot/nix/.rw-store.524machine # [ 3.867408] systemd[1]: Starting rw-sysroot-nix-store.service...525machine # [ 3.887913] systemd[1]: Mounted /sysroot/nix/.ro-store.526machine # [ 3.894732] systemd[1]: Mounted /sysroot/run.527machine # [ 3.903622] systemd[1]: Mounted /sysroot/tmp/shared.528machine # [ 3.922579] systemd[1]: Mounted /sysroot/tmp/xchg.529machine # [ 3.930661] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.530machine # [ 3.935892] systemd[1]: Finished rw-sysroot-nix-store.service.531machine # [ 3.939301] systemd[1]: Mounting /sysroot/nix/store...532machine # [ 3.993232] systemd[1]: Mounted /sysroot/nix/store.533machine # [ 3.995726] systemd[1]: Reached target Initrd File Systems.534machine # [ 4.000200] systemd[1]: Starting Find NixOS closure...535machine # [ 4.013004] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...536machine # [ 4.056858] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.537machine # [ 4.078364] systemd[1]: Finished Find NixOS closure.538machine # [ 4.080893] systemd[1]: Reached target Initrd Default Target.539machine # [ 4.086098] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...540machine # [ 4.138688] systemd[1]: Stopped target Initrd Default Target.541machine # [ 4.141254] systemd[1]: Stopped target Basic System.542machine # [ 4.143000] systemd[1]: Stopped target Initrd Root Device.543machine # [ 4.148449] systemd[1]: Stopped target Path Units.544machine # [ 4.150207] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.545machine # [ 4.152134] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.546machine # [ 4.156536] systemd[1]: Stopped target Slice Units.547machine # [ 4.160161] systemd[1]: Stopped target Socket Units.548machine # [ 4.162398] systemd[1]: Stopped target System Initialization.549machine # [ 4.165251] systemd[1]: Stopped target Swaps.550machine # [ 4.168987] systemd[1]: Stopped target Timer Units.551machine # [ 4.170974] systemd[1]: dbus.socket: Deactivated successfully.552machine # [ 4.176715] systemd[1]: Closed D-Bus System Message Bus Socket.553machine # [ 4.178175] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.554machine # [ 4.179653] systemd[1]: Stopped Find NixOS closure.555machine # [ 4.185828] systemd[1]: Starting Load Kernel Module 9pnet_virtio...556machine # [ 4.189065] systemd[1]: Starting rw-sysroot-nix-store.service...557machine # [ 4.192931] systemd[1]: systemd-sysctl.service: Deactivated successfully.558machine # [ 4.196406] systemd[1]: Stopped Apply Kernel Variables.559machine # [ 4.200140] systemd[1]: systemd-modules-load.service: Deactivated successfully.560machine # [ 4.204267] systemd[1]: Stopped Load Kernel Modules.561machine # [ 4.205121] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.562machine # [ 4.213174] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.563machine # [ 4.222082] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.564machine # [ 4.226272] systemd[1]: Stopped Create System Files and Directories.565machine # [ 4.232322] systemd[1]: Stopped target Local File Systems.566machine # [ 4.236310] systemd[1]: Stopped target Preparation for Local File Systems.567machine # [ 4.246544] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.568machine # [ 4.247746] systemd[1]: Stopped Coldplug All udev Devices.569machine # [ 4.250168] systemd[1]: Stopping Rule-based Manager for Device Events and Files...570machine # [ 4.251269] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.571machine # [ 4.255707] systemd[1]: Stopped Virtual Console Setup.572machine # [ 4.256949] systemd[1]: initrd-cleanup.service: Deactivated successfully.573machine # [ 4.260329] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.574machine # [ 4.261354] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.575machine # [ 4.262381] systemd[1]: Finished Load Kernel Module 9pnet_virtio.576machine # [ 4.263691] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.577machine # [ 4.264948] systemd[1]: Finished rw-sysroot-nix-store.service.578machine # [ 4.271527] systemd[1]: systemd-udevd.service: Deactivated successfully.579machine # [ 4.274540] systemd[1]: Stopped Rule-based Manager for Device Events and Files.580machine # [ 4.276762] systemd[1]: systemd-udevd.service: Consumed 1.057s CPU time over 2.366s wall clock time, 16.1M memory peak.581machine # [ 4.280537] systemd[1]: Starting Cleanup udev Database...582machine # [ 4.283962] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.583machine # [ 4.285561] systemd[1]: Stopped Create Static Device Nodes in /dev.584machine # [ 4.286478] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.585machine # [ 4.287629] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.586machine # [ 4.288798] systemd[1]: kmod-static-nodes.service: Deactivated successfully.587machine # [ 4.289798] systemd[1]: Stopped Create List of Static Device Nodes.588machine # [ 4.322542] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.589machine # [ 4.325413] systemd[1]: Finished Cleanup udev Database.590machine # [ 4.326293] systemd[1]: Reached target Switch Root.591machine # [ 4.328626] systemd[1]: Starting NixOS Activation...592machine # [ 4.543920] initrd-nixos-activation-start[172]: booting system configuration /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test593machine # [ 4.624790] initrd-nixos-activation-start[172]: running activation script...594machine # [ 5.121508] initrd-nixos-activation-start[195]: setting up /etc...595machine # [ 5.450418] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.596machine # [ 5.453784] systemd[1]: Finished NixOS Activation.597machine # [ 5.455303] systemd[1]: Starting Switch Root...598machine # [ 5.482687] systemd[1]: Switching root.599machine # [ 5.676632] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).600machine # [ 6.286198] systemd[1]: systemd 262-175b52e 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 # [ 6.298862] systemd[1]: Detected virtualization qemu.602machine # [ 6.302142] systemd[1]: Detected architecture arm64.603machine # [ 6.306218] systemd[1]: Detected first boot.604machine # [ 6.314733] systemd[1]: Initializing machine ID from random generator.605machine # [ 6.509407] systemd[1]: bpf-restrict-fs: LSM BPF program attached606machine # [ 6.682178] systemd[1]: Applying preset policy.607machine # [ 7.181803] systemd[1]: Populated /etc with preset unit settings.608machine # [ 7.736073] systemd[1]: initrd-switch-root.service: Deactivated successfully.609machine # [ 7.737541] systemd[1]: Stopped initrd-switch-root.service.610machine # [ 7.741197] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.611machine # [ 7.745440] systemd[1]: Created slice Slice /system/getty.612machine # [ 7.748890] systemd[1]: Created slice User and Session Slice.613machine # [ 7.750945] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.614machine # [ 7.752658] systemd[1]: Started Forward Password Requests to Wall Directory Watch.615machine # [ 7.755436] systemd[1]: Expecting device /dev/hvc0...616machine # [ 7.757349] systemd[1]: Expecting device /dev/ttyAMA0...617machine # [ 7.759370] systemd[1]: Reached target Local Encrypted Volumes.618machine # [ 7.761383] systemd[1]: Stopped target initrd-fs.target.619machine # [ 7.763493] systemd[1]: Stopped target initrd-root-fs.target.620machine # [ 7.765481] systemd[1]: Stopped target initrd-switch-root.target.621machine # [ 7.767652] systemd[1]: Reached target Virtual Machines and Containers.622machine # [ 7.769823] systemd[1]: Reached target Path Units.623machine # [ 7.771847] systemd[1]: Reached target Remote File Systems.624machine # [ 7.772949] systemd[1]: Reached target Slice Units.625machine # [ 7.774454] systemd[1]: Reached target Swaps.626machine # [ 7.779189] systemd[1]: Listening on Query the User Interactively for a Password.627machine # [ 7.784447] systemd[1]: Listening on Process Core Dump Socket.628machine # [ 7.788770] systemd[1]: Listening on Credential Encryption/Decryption.629machine # [ 7.792887] systemd[1]: Listening on Factory Reset Management.630machine # [ 7.794235] systemd[1]: Listening on Hostname Service Socket.631machine # [ 7.801086] systemd[1]: Starting Journal Log Access Socket...632machine # [ 7.804594] systemd[1]: Listening on Journal Audit Socket.633machine # [ 7.809770] systemd[1]: Listening on Console Output Muting Service Socket.634machine # [ 7.813569] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.635machine # [ 7.816209] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os636machine # [ 7.818867] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki637machine # [ 7.830807] systemd[1]: Listening on Disk Repartitioning Service Socket.638machine # [ 7.833444] systemd[1]: Listening on udev Varlink Socket.639machine # [ 7.839756] systemd[1]: Mounting Huge Pages File System...640machine # [ 7.846288] systemd[1]: Mounting POSIX Message Queue File System...641machine # [ 7.860774] systemd[1]: Mounting Kernel Debug File System...642machine # [ 7.871655] systemd[1]: Mounting Kernel Trace File System...643machine # [ 7.883504] systemd[1]: Starting Create List of Static Device Nodes...644machine # [ 7.895433] systemd[1]: Starting Load Kernel Module 9pnet_virtio...645machine # [ 7.897101] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs646machine # [ 7.912136] systemd[1]: Mounting Kernel Configuration File System...647machine # [ 7.915122] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm648machine # [ 7.918457] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore649machine # [ 7.932743] systemd[1]: Starting Load Kernel Module fuse...650machine # [ 7.936025] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67651machine # [ 7.993330] systemd[1]: Starting Journal Service...652machine # [ 8.050324] systemd[1]: Starting Load Kernel Modules...653machine # [ 8.064900] fuse: init (API version 7.45)654machine # [ 8.081224] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...655machine # [ 8.116327] systemd[1]: Starting Remount Root and Kernel File Systems...656machine # [ 8.119060] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os657machine # [ 8.127427] systemd-journald[268]: Collecting audit messages is enabled.658machine # [ 8.121069] systemd[1]: Queued start job for default target Multi-User System.659machine # [ 8.124512] systemd[1]: systemd-journald.service: Deactivated successfully.660machine # [ 8.144112] systemd[1]: Starting Coldplug All udev Devices...661machine # [ 8.157792] systemd[1]: Started Journal Service.662machine # [ 8.171584] systemd[1]: Listening on Journal Log Access Socket.663machine # [ 8.177811] systemd[1]: Mounted Huge Pages File System.664machine # [ 8.184725] systemd[1]: Mounted POSIX Message Queue File System.665machine # [ 8.193546] systemd[1]: Mounted Kernel Debug File System.666machine # [ 8.194540] systemd[1]: Mounted Kernel Trace File System.667machine # [ 8.195333] systemd[1]: Finished Create List of Static Device Nodes.668machine # [ 8.205022] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.669machine # [ 8.214563] systemd[1]: Finished Load Kernel Module 9pnet_virtio.670machine # [ 8.221196] systemd[1]: Mounted Kernel Configuration File System.671machine # [ 8.224638] systemd[1]: modprobe@fuse.service: Deactivated successfully.672machine # [ 8.229326] systemd[1]: Finished Load Kernel Module fuse.673machine # [ 8.246814] EXT4-fs (vda): re-mounted ba3e954d-d93a-4fa7-8371-d9f1c9bbef23.674machine # [ 8.236625] systemd-modules-load[269]: Module 'atkbd' is built in675machine # [ 8.241048] systemd-modules-load[269]: Module 'loop' is built in676machine # [ 8.245310] systemd[1]: Finished Load Kernel Modules.677machine # [ 8.258521] systemd[1]: Mounting FUSE Control File System...678machine # [ 8.265385] systemd[1]: Starting Firewall...679machine # [ 8.296943] systemd-oomd[271]: No swap; memory pressure usage will be degraded680machine # [ 8.304259] systemd[1]: Starting Apply Kernel Variables...681machine # [ 8.320474] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...682machine # [ 8.330663] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.683machine # [ 8.333964] systemd[1]: Finished Remount Root and Kernel File Systems.684machine # [ 8.339315] systemd[1]: Listening on Disk Image Download Service Socket.685machine # [ 8.371051] systemd[1]: Starting Flush Journal to Persistent Storage...686machine # [ 8.373846] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore687machine # [ 8.402482] systemd[1]: Starting Load/Save OS Random Seed...688machine # [ 8.404561] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os689machine # [ 8.469082] systemd[1]: Mounted FUSE Control File System.690machine # [ 8.491955] systemd-journald[268]: Received client request to flush runtime journal.691machine # [ 8.566433] systemd[1]: Finished Apply Kernel Variables.692machine # [ 8.577243] systemd[1]: Finished Load/Save OS Random Seed.693machine # [ 8.578149] systemd[1]: Reached target First Boot Complete.694machine # [ 8.587536] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.695machine # [ 8.589145] systemd[1]: Finished Flush Journal to Persistent Storage.696machine # [ 8.592860] systemd[1]: Starting Create Static Device Nodes in /dev...697machine # [ 8.703372] systemd[1]: Finished Create Static Device Nodes in /dev.698machine # [ 8.708343] systemd[1]: Reached target Preparation for Local File Systems.699machine # [ 8.711922] systemd[1]: Starting Rule-based Manager for Device Events and Files...700machine # [ 8.735845] systemd[1]: Mounting /run/wrappers...701machine # [ 8.817313] systemd[1]: Mounted /run/wrappers.702machine # [ 8.818295] systemd[1]: Reached target Local File Systems.703machine # [ 8.827206] systemd[1]: Listening on Boot Loader Control Service Socket.704machine # [ 8.834874] systemd[1]: Starting register-nix-paths.service...705machine # [ 8.851356] systemd[1]: Starting Create SUID/SGID Wrappers...706machine # [ 8.854469] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.707machine # [ 8.876747] systemd[1]: Starting Save Transient machine-id to Disk...708machine # [ 8.910038] systemd[1]: Starting Create System Files and Directories...709machine # [ 8.989690] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.710machine # [ 9.010106] systemd[1]: Finished Save Transient machine-id to Disk.711machine # [ 9.181063] systemd[1]: Finished Create System Files and Directories.712machine # [ 9.210972] systemd[1]: Starting Rebuild Journal Catalog...713machine # [ 9.223260] systemd[1]: Starting Record System Boot/Shutdown in UTMP...714machine # [ 9.395806] systemd-udevd[310]: Using default interface naming scheme 'v261'.715machine # [ 9.413189] systemd[1]: Finished Record System Boot/Shutdown in UTMP.716machine # [ 9.491254] systemd[1]: Finished Rebuild Journal Catalog.717machine # [ 9.520521] systemd[1]: Starting Update is Completed...718machine # [ 9.649251] systemd[1]: Finished Update is Completed.719machine # [ 9.721473] systemd[1]: Started Rule-based Manager for Device Events and Files.720machine # [ 10.094227] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.721machine # [ 10.098240] systemd[1]: Finished Create SUID/SGID Wrappers.722machine # [ 10.930322] systemd[1]: Finished register-nix-paths.service.723machine # [ 10.952077] systemd[1]: Finished Coldplug All udev Devices.724machine # [ 10.954330] systemd[1]: Reached target System Initialization.725machine # [ 10.959633] systemd[1]: Started Discard unused filesystem blocks once a week.726machine # [ 10.968752] systemd[1]: Started Daily Cleanup of Temporary Directories.727machine # [ 10.969896] systemd[1]: Reached target Timer Units.728machine # [ 10.971338] systemd[1]: Listening on D-Bus System Message Bus Socket.729machine # [ 10.977812] systemd[1]: Listening on Nix Daemon Socket.730machine # [ 10.986567] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.731machine # [ 10.987837] systemd[1]: Reached target Socket Units.732machine # [ 10.994026] systemd[1]: Reached target Basic System.733machine # [ 10.999747] systemd[1]: Starting Import lastlog data into lastlog2 database...734machine # [ 11.009303] systemd[1]: Starting Name Service Cache Daemon (nsncd)...735machine # [ 11.010527] systemd[1]: Starting Post-Boot Actions...736machine # [ 11.056123] systemd[1]: Started Reset console on configuration changes.737machine # [ 11.084379] systemd[1]: Starting resolvconf update...738machine # [ 11.157203] systemd[1]: Starting D-Bus System Message Bus...739machine # [ 11.189218] systemd[1]: Finished Post-Boot Actions.740machine # [ 11.211150] nsncd[468]: Sep 04 02:32:59.708 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"741machine # [ 11.225339] systemd[1]: Finished Firewall.742machine # [ 11.228504] systemd[1]: Started Name Service Cache Daemon (nsncd).743machine # [ 11.263920] systemd[1]: Reached target Host and Network Name Lookups.744machine # [ 11.270066] systemd[1]: Reached target User and Group Name Lookups.745machine # [ 11.288850] systemd[1]: Starting User Login Management...746machine # [ 11.328900] systemd[1]: Finished Import lastlog data into lastlog2 database.747machine # [ 11.434509] dbus-broker-launch[478]: Looking up NSS user entry for 'systemd-timesync'...748machine # [ 11.447139] dbus-broker-launch[478]: NSS returned no entry for 'systemd-timesync'749machine # [ 11.453746] dbus-broker-launch[478]: Invalid user-name in /nix/store/zihqny80khrxshjrz8dszaixmccx9dn8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"750machine # [ 11.497916] systemd[1]: Started D-Bus System Message Bus.751machine # [ 11.523595] systemd-logind[497]: New seat seat0.752machine # [ 11.532142] systemd[1]: Started User Login Management.753machine # [ 11.547302] systemd[1]: Starting linger-users.service...754machine # [ 11.561308] dbus-broker-launch[478]: Ready755machine # [ 11.592926] systemd[1]: Stopped target Host and Network Name Lookups.756machine # [ 11.597833] systemd[1]: Stopping Host and Network Name Lookups...757machine # [ 11.604510] systemd[1]: Stopped target User and Group Name Lookups.758machine # [ 11.607566] systemd[1]: Stopping User and Group Name Lookups...759machine # [ 11.612505] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...760machine # [ 11.617310] systemd[1]: nscd.service: Deactivated successfully.761machine # [ 11.621200] systemd[1]: Stopped Name Service Cache Daemon (nsncd).762machine # [ 11.643632] systemd[1]: Starting Name Service Cache Daemon (nsncd)...763machine # [ 11.710983] systemd[1]: Created slice Slice /user/1001.764machine # [ 11.722641] systemd[1]: Starting User Runtime Directory /run/user/1001...765machine # [ 11.749527] nsncd[544]: Sep 04 02:33:00.246 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"766machine # [ 11.768403] systemd[1]: Started Name Service Cache Daemon (nsncd).767machine # [ 11.773245] systemd[1]: linger-users.service: Deactivated successfully.768machine # [ 11.778193] systemd[1]: Finished linger-users.service.769machine # [ 11.789665] systemd[1]: Reached target Host and Network Name Lookups.770machine # [ 11.794716] systemd[1]: Reached target User and Group Name Lookups.771machine # [ 11.832095] systemd[1]: Finished resolvconf update.772machine # [ 11.838045] systemd[1]: Reached target Preparation for Network.773machine # [ 11.848662] systemd[1]: Starting DHCP Client...774machine # [ 11.854293] systemd[1]: Starting Extra networking commands....775machine # [ 11.885976] systemd[1]: Finished User Runtime Directory /run/user/1001.776machine # [ 11.933137] systemd[1]: Starting User Manager for UID 1001...777machine # [ 12.117872] (systemd)[576]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0)778machine # [ 12.140460] systemd-logind[497]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'.779machine # [ 12.241817] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3780machine # [ 12.237014] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy781machine # [ 12.466066] systemd[576]: Queued start job for default target Main User Target.782machine # [ 12.476606] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy783machine # [ 12.506981] systemd[576]: Created slice User Application Slice.784machine # [ 12.526709] systemd[576]: Started Daily Cleanup of User's Temporary Directories.785machine # [ 12.537749] systemd[576]: Reached target Paths.786machine # [ 12.547522] systemd[576]: Reached target Timers.787machine # [ 12.555556] systemd[576]: Starting D-Bus User Message Bus Socket...788machine # [ 12.567338] systemd[576]: Starting Create User Files and Directories...789machine # [ 12.575102] systemd[576]: Finished Create User Files and Directories.790machine # [ 12.604485] systemd[576]: Listening on D-Bus User Message Bus Socket.791machine # [ 12.612589] systemd[576]: Reached target Sockets.792machine # [ 12.621281] systemd[576]: Reached target Basic System.793machine # [ 12.624316] systemd[1]: Started User Manager for UID 1001.794machine # [ 12.629686] systemd[576]: Starting Run user-specific NixOS activation...795machine # [ 12.677792] systemd[576]: Finished Run user-specific NixOS activation.796machine # [ 12.683417] systemd[576]: Reached target Main User Target.797machine # [ 12.689831] systemd[576]: Startup finished in 491ms.798machine # [ 12.856623] dhcpcd[592]: dhcpcd-10.3.2 starting799machine # [ 12.924987] dhcpcd[655]: dev: loaded udev800machine # [ 12.938659] systemd[1]: Finished Extra networking commands..801machine # [ 12.955501] systemd[1]: Reached target Network.802machine # [ 12.970054] dhcpcd[655]: no valid interfaces found803machine # [ 12.987323] dhcpcd[655]: no valid interfaces found804machine # [ 12.999800] dhcpcd[655]: libudev: received NULL device805machine # [ 13.016118] systemd[1]: Starting Permit User Sessions...806machine # [ 13.032350] dhcpcd[655]: libudev: received NULL device807machine # [ 13.089437] systemd[1]: Starting Virtual Console Setup...808machine # [ 13.115295] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs809machine # [ 13.201553] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.810machine # [ 13.213611] systemd[1]: Stopped Virtual Console Setup.811machine # [ 13.214496] systemd[1]: Starting Virtual Console Setup...812machine # [ 13.250160] systemd[1]: Finished Permit User Sessions.813machine # [ 13.264930] systemd[1]: Started Getty on tty1.814machine # [ 13.283197] systemd[1]: Reached target Login Prompts.815machine # [ 13.308919] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.816machine # [ 13.371844] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.817machine # [ 13.385743] systemd[1]: Started backdoor.service.818machine # [ 13.449607] (udev-worker)[651]: Network interface NamePolicy= disabled on kernel command line.819machine # [ 13.490222] 8021q: 802.1Q VLAN Support v1.8820machine # [ 13.484419] (udev-worker)[640]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.821machine # [ 13.540224] (udev-worker)[640]: Network interface NamePolicy= disabled on kernel command line.822machine # [ 13.605575] cfg80211: Loading compiled-in X.509 certificates for regulatory database823machine # [ 13.648807] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'824machine # [ 13.649355] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'825machine # [ 13.656211] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2826machine # [ 13.656565] cfg80211: failed to load regulatory.db827machine # [ 13.751743] systemd[1]: Condition check resulted in Virtio network device being skipped.828machine # [ 13.776331] systemd[1]: Starting Address configuration of eth1...829machine # [ 13.869037] systemd-logind[497]: Watching system buttons on /dev/input/event0 (gpio-keys)830machine # connecting to host...831machine # [ 14.020895] mousedev: PS/2 mouse device common for all mice832machine: Guest shell says: b'Spawning backdoor root shell...\n'833machine: connected to guest root shell834machine: (connecting took 14.33 seconds)835machine: (finished: waiting for the VM to finish booting, in 14.96 seconds)836machine # [ 14.082531] 8021q: adding VLAN 0 to HW filter on device eth0837machine # [ 14.073612] dhcpcd[655]: eth0: waiting for carrier838machine # [ 14.082053] dhcpcd[655]: eth0: carrier acquired839machine # [ 14.112586] 8021q: adding VLAN 0 to HW filter on device eth1840machine # [ 14.127121] dhcpcd[655]: DUID 00:01:00:01:32:2c:ea:5e:52:54:00:12:34:56841machine # [ 14.141428] dhcpcd[655]: eth0: IAID 00:12:34:56842machine # [ 14.142155] dhcpcd[655]: eth0: adding address fe80::5054:ff:fe12:3456843machine # [ 14.180488] network-addresses-eth1-start[678]: adding address 192.168.1.1/24... done844machine # [ 14.267758] network-addresses-eth1-start[678]: adding address 2001:db8:1::1/64... done845machine # [ 14.289734] systemd-logind[497]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)846machine # [ 14.382979] systemd[1]: Finished Address configuration of eth1.847machine # [ 15.092800] dhcpcd[655]: eth0: soliciting a DHCP lease848machine # [ 15.107555] dhcpcd[655]: eth0: offered 10.0.2.15 from 10.0.2.2849machine # [ 15.120472] dhcpcd[655]: eth0: probing address 10.0.2.15/24850machine # [ 15.356382] systemd-vconsole-setup[662]: Configuration of first virtual console was skipped, ignoring remaining ones.851machine # [ 15.358133] systemd[1]: Finished Virtual Console Setup.852machine # [ 15.695605] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.853machine # [ 15.721943] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.854machine # [ 15.723082] systemd[1]: Stopped Virtual Console Setup.855machine # [ 15.723823] systemd[1]: Stopping Virtual Console Setup...856machine # [ 15.756302] systemd[1]: Starting Virtual Console Setup...857machine # [ 15.762128] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.858machine # [ 15.771082] systemd[1]: Stopped Virtual Console Setup.859machine # [ 15.776882] systemd-logind[497]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)860machine # [ 15.778171] systemd[1]: Starting Virtual Console Setup...861machine # [ 16.117225] systemd-vconsole-setup[730]: Configuration of first virtual console was skipped, ignoring remaining ones.862machine # [ 16.124346] systemd[1]: Finished Virtual Console Setup.863machine # [ 16.170313] dhcpcd[655]: eth0: soliciting an IPv6 router864machine # [ 16.172794] dhcpcd[655]: eth0: Router Advertisement from fe80::2865machine # [ 16.174008] dhcpcd[655]: eth0: adding address fec0::5054:ff:fe12:3456/64866machine # [ 16.175275] dhcpcd[655]: eth0: adding route to fec0::/64867machine # [ 16.176554] dhcpcd[655]: eth0: adding default route via fe80::2868machine # [ 19.469269] dhcpcd[655]: eth0: leased 10.0.2.15 for 86400 seconds869machine # [ 19.469638] dhcpcd[655]: eth0: adding route to 10.0.2.0/24870machine # [ 19.469795] dhcpcd[655]: eth0: adding default route via 10.0.2.2871machine # [ 19.634971] systemd[1]: Started DHCP Client.872machine # [ 19.637158] systemd[1]: Reached target Multi-User System.873machine # [ 19.638801] systemd[1]: Startup finished in 1.076s (kernel) + 4.714s (initrd) + 13.847s (userspace) = 19.638s.874machine: (finished: waiting for unit multi-user.target, in 21.25 seconds)875machine: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/bin/switch-to-configuration test876machine # Checking switch inhibitors... done877machine # [ 20.897969] nixos[833]: switching to system configuration /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test878machine # [ 20.900912] systemd[1]: Stopped target Local File Systems.879machine # activating the configuration...880machine # [ 20.903839] systemd[1]: Stopped target Remote File Systems.881machine # setting up /etc...882machine # [ 21.385814] systemd[1]: Reload requested from client PID 833 ('.switch-to-conf') (unit backdoor.service)...883machine # [ 21.387812] systemd[1]: Reloading...884machine # [ 22.205898] systemd[1]: Reloading finished in 813 ms.885machine # reloading user units for usertest...886machine # [ 22.261592] systemd[576]: Created slice User Core Session Slice.887machine # [ 22.265824] systemd[576]: Starting D-Bus User Message Bus...888machine # [ 22.338917] dbus-broker-launch[903]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/zihqny80khrxshjrz8dszaixmccx9dn8-system-path/share/dbus-1/services/org.freedesktop.import1.service'889machine # [ 22.342486] dbus-broker-launch[903]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/zihqny80khrxshjrz8dszaixmccx9dn8-system-path/share/dbus-1/services/org.freedesktop.machine1.service'890machine # [ 22.345914] dbus-broker-launch[903]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/zihqny80khrxshjrz8dszaixmccx9dn8-system-path/share/dbus-1/services/org.freedesktop.portable1.service'891machine # [ 22.349460] dbus-broker-launch[903]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/zihqny80khrxshjrz8dszaixmccx9dn8-system-path/share/dbus-1/services/org.freedesktop.systemd1.service'892machine # [ 22.353163] dbus-broker-launch[903]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored893machine # [ 22.356322] dbus-broker-launch[903]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored894machine # [ 22.358364] systemd[576]: Started D-Bus User Message Bus.895machine # [ 22.366874] dbus-broker-launch[903]: Ready896machine # [ 22.462805] systemd[576]: Reexecution requested from client PID 902 ('switch-to-confi')...897machine # [ 22.464952] systemd[576]: Reexecuting.898machine # [ 22.534754] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy899machine # [ 22.735861] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy900machine # [ 22.742878] systemd[576]: Reload requested from client PID 902 ('switch-to-confi')...901machine # [ 22.746878] systemd[576]: Reloading...902machine # [ 22.937944] systemd[576]: Reloading finished in 191 ms.903machine # [ 22.956173] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy904machine # restarting the following user units: nixos-activation.service905machine # [ 22.966184] systemd[576]: Stopped Run user-specific NixOS activation.906machine # [ 22.968574] systemd[576]: Stopping Run user-specific NixOS activation...907machine # [ 22.971458] systemd[576]: Starting Run user-specific NixOS activation...908machine # [ 23.018693] systemd[576]: Finished Run user-specific NixOS activation.909machine # restarting sysinit-reactivation.target910machine # [ 23.035810] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....911machine # [ 23.147711] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..912machine # [ 23.151745] systemd[1]: Reached target Reactivate sysinit units.913machine # [ 23.154342] systemd[1]: Reached target Local File Systems.914machine # [ 23.158075] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore915machine # [ 23.163002] systemd[1]: Starting Create SUID/SGID Wrappers...916machine # [ 23.165781] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.917machine # [ 23.168899] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67918machine # [ 23.171089] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore919machine # [ 23.182018] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os920machine # [ 23.184110] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os921machine # [ 23.185325] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os922machine # [ 23.186601] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki923machine # [ 23.187837] systemd[1]: Reached target Remote File Systems.924machine # [ 23.512497] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.925machine # [ 23.514567] systemd[1]: Finished Create SUID/SGID Wrappers.926machine # [ 23.515701] systemd[1]: Starting linger-users.service...927machine # [ 23.590588] systemd[1]: linger-users.service: Deactivated successfully.928machine # [ 23.594323] systemd[1]: Finished linger-users.service.929machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service930machine # [ 23.858499] nixos[833]: finished switching to system configuration /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test931machine: (finished: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/bin/switch-to-configuration test, in 3.53 seconds)932machine: must succeed: rm /etc/NIXOS933machine: (finished: must succeed: rm /etc/NIXOS, in 0.05 seconds)934machine: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/w8d6cl9adq53p90jbi5sf420kqnqk16c-nixos-system-other-test/bin/switch-to-configuration test935machine # this should succeed (config: /nix/store/w8d6cl9adq53p90jbi5sf420kqnqk16c-nixos-system-other-test, action: test)936machine # Checking switch inhibitors... done937machine # [ 24.572953] nixos[981]: switching to system configuration /nix/store/w8d6cl9adq53p90jbi5sf420kqnqk16c-nixos-system-other-test938machine # activating the configuration...939machine # [ 24.577492] systemd[1]: Stopped target Local File Systems.940machine # [ 24.578672] systemd[1]: Stopped target Remote File Systems.941machine # removing user ‘usertest’942machine # setting up /etc...943machine # [ 25.109026] systemd[1]: Reload requested from client PID 981 ('.switch-to-conf') (unit backdoor.service)...944machine # [ 25.111009] systemd[1]: Reloading...945machine # [ 25.991475] systemd[1]: Reloading finished in 877 ms.946machine # reloading user units for usertest...947machine # [ 26.169207] systemd[576]: Reexecution requested from client PID 1052 ('switch-to-confi')...948machine # [ 26.173063] systemd[576]: Reexecuting.949machine # [ 26.225726] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy950machine # [ 26.449585] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy951machine # [ 26.457718] systemd[576]: Reload requested from client PID 1052 ('switch-to-confi')...952machine # [ 26.459605] systemd[576]: Reloading...953machine # [ 26.669772] systemd[576]: Reloading finished in 209 ms.954machine # [ 26.684184] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy955machine # restarting the following user units: nixos-activation.service956machine # [ 26.697627] systemd[576]: Stopped Run user-specific NixOS activation.957machine # [ 26.698632] systemd[576]: Stopping Run user-specific NixOS activation...958machine # [ 26.701743] systemd[576]: Starting Run user-specific NixOS activation...959machine # [ 26.753490] systemd[576]: Finished Run user-specific NixOS activation.960machine # restarting sysinit-reactivation.target961machine # [ 26.760151] systemd[1]: Stopped target Reactivate sysinit units.962machine # reloading the following units: dbus-broker.service963machine # [ 26.763443] systemd[1]: Stopping Reactivate sysinit units...964machine # [ 26.766341] systemd[1]: Reached target Reactivate sysinit units.965machine # [ 26.767369] systemd[1]: Reloading D-Bus System Message Bus...966machine # [ 26.769557] dbus-broker-launch[478]: Caught SIGHUP, trigger reload.967machine # [ 26.790413] dbus-broker-launch[478]: Looking up NSS user entry for 'systemd-timesync'...968machine # [ 26.792979] dbus-broker-launch[478]: NSS returned no entry for 'systemd-timesync'969machine # [ 26.794205] dbus-broker-launch[478]: Invalid user-name in /nix/store/3rhwfjl7q5bcsy7jl3vz93dahhcdhpzi-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"970machine # [ 26.824800] systemd[1]: Reloaded D-Bus System Message Bus.971machine # restarting the following units: network-addresses-eth1.service972machine # [ 26.833041] systemd[1]: Stopping Address configuration of eth1...973machine # [ 26.910952] network-addresses-eth1-pre-stop[1064]: deleting address 192.168.1.1/24... done974machine # [ 26.926810] network-addresses-eth1-pre-stop[1064]: deleting address 2001:db8:1::1/64... done975machine # [ 26.940522] systemd[1]: network-addresses-eth1.service: Deactivated successfully.976machine # [ 26.944750] systemd[1]: Stopped Address configuration of eth1.977machine # [ 26.949246] systemd[1]: Starting Address configuration of eth1...978machine # [ 27.032897] network-addresses-eth1-start[1069]: adding address 192.168.1.2/24... done979machine # [ 27.045040] network-addresses-eth1-start[1069]: adding address 2001:db8:1::2/64... done980machine # [ 27.061820] systemd[1]: Finished Address configuration of eth1.981machine # [ 27.069935] systemd[1]: Reached target Remote File Systems.982machine # [ 27.076154] systemd[1]: Starting linger-users.service...983machine # [ 27.079563] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os984machine # [ 27.084268] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki985machine # [ 27.090153] systemd[1]: Reached target Local File Systems.986machine # [ 27.096353] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore987machine # [ 27.101352] systemd[1]: Starting Create SUID/SGID Wrappers...988machine # [ 27.103650] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.989machine # [ 27.109436] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67990machine # [ 27.111553] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore991machine # [ 27.115043] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os992machine # [ 27.117296] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os993machine # [ 27.159047] linger-users-start[1084]: id: ‘usertest’: no such user994machine # [ 27.163301] linger-users-start[1081]: Removing linger for missing user usertest995machine # [ 27.176176] systemd[1]: linger-users.service: Deactivated successfully.996machine # [ 27.179879] systemd[1]: Finished linger-users.service.997machine # [ 27.501535] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.998machine # [ 27.504929] systemd[1]: Finished Create SUID/SGID Wrappers.999machine # [ 27.762230] nixos[981]: finished switching to system configuration /nix/store/w8d6cl9adq53p90jbi5sf420kqnqk16c-nixos-system-other-test1000machine: (finished: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/w8d6cl9adq53p90jbi5sf420kqnqk16c-nixos-system-other-test/bin/switch-to-configuration test, in 3.85 seconds)1001subtest: services1002machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/bin/switch-to-configuration test 2>&11003machine # [ 28.354761] nixos[1148]: switching to system configuration /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test1004machine # [ 28.357824] systemd[1]: Stopped target Remote File Systems.1005machine # [ 28.360216] systemd[1]: Stopped target Local File Systems.1006machine # [ 28.851662] systemd[1]: Reload requested from client PID 1148 ('.switch-to-conf') (unit backdoor.service)...1007machine # [ 28.853951] systemd[1]: Reloading...1008machine # [ 29.845668] systemd[1]: Reloading finished in 989 ms.1009machine # [ 30.006231] systemd[576]: Reexecution requested from client PID 1217 ('switch-to-confi')...1010machine # [ 30.010586] systemd[576]: Reexecuting.1011machine # [ 30.070204] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1012machine # [ 30.305592] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1013machine # [ 30.313127] systemd[576]: Reload requested from client PID 1217 ('switch-to-confi')...1014machine # [ 30.315071] systemd[576]: Reloading...1015machine # [ 30.514494] systemd[576]: Reloading finished in 198 ms.1016machine # [ 30.529949] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1017machine # [ 30.540156] systemd[576]: Stopped Run user-specific NixOS activation.1018machine # [ 30.541324] systemd[576]: Stopping Run user-specific NixOS activation...1019machine # [ 30.545264] systemd[576]: Starting Run user-specific NixOS activation...1020machine # [ 30.598650] systemd[576]: Finished Run user-specific NixOS activation.1021machine # [ 30.603482] systemd[1]: Stopped target Reactivate sysinit units.1022machine # [ 30.609780] systemd[1]: Stopping Reactivate sysinit units...1023machine # [ 30.610939] systemd[1]: Reached target Reactivate sysinit units.1024machine # [ 30.612904] dbus-broker-launch[478]: Caught SIGHUP, trigger reload.1025machine # [ 30.614427] systemd[1]: Reloading D-Bus System Message Bus...1026machine # [ 30.624936] dbus-broker-launch[478]: Looking up NSS user entry for 'systemd-timesync'...1027machine # [ 30.627508] dbus-broker-launch[478]: NSS returned no entry for 'systemd-timesync'1028machine # [ 30.629001] dbus-broker-launch[478]: Invalid user-name in /nix/store/zihqny80khrxshjrz8dszaixmccx9dn8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1029machine # [ 30.658619] systemd[1]: Reloaded D-Bus System Message Bus.1030machine # [ 30.666793] systemd[1]: Stopping Address configuration of eth1...1031machine # [ 30.722350] network-addresses-eth1-pre-stop[1230]: deleting address 192.168.1.2/24... done1032machine # [ 30.735813] network-addresses-eth1-pre-stop[1230]: deleting address 2001:db8:1::2/64... done1033machine # [ 30.748263] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1034machine # [ 30.750308] systemd[1]: Stopped Address configuration of eth1.1035machine # [ 30.756739] systemd[1]: Starting Address configuration of eth1...1036machine # [ 30.839346] network-addresses-eth1-start[1235]: adding address 192.168.1.1/24... done1037machine # [ 30.854478] network-addresses-eth1-start[1235]: adding address 2001:db8:1::1/64... done1038machine # [ 30.871894] systemd[1]: Finished Address configuration of eth1.1039machine # [ 30.877399] systemd[1]: Reached target Local File Systems.1040machine # [ 30.881069] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1041machine # [ 30.882538] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1042machine # [ 30.886432] systemd[1]: Reached target Remote File Systems.1043machine # [ 30.894363] systemd[1]: Starting linger-users.service...1044machine # [ 30.898821] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1045machine # [ 30.909058] systemd[1]: Starting Create SUID/SGID Wrappers...1046machine # [ 30.913495] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1047machine # [ 30.918722] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671048machine # [ 30.924564] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1049machine # [ 30.926257] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1050machine # [ 30.927526] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1051machine # [ 30.983912] systemd[1]: linger-users.service: Deactivated successfully.1052machine # [ 30.987296] systemd[1]: Finished linger-users.service.1053machine # [ 31.327807] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1054machine # [ 31.331555] systemd[1]: Finished Create SUID/SGID Wrappers.1055machine # [ 31.592598] nixos[1148]: finished switching to system configuration /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test1056machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.83 seconds)1057machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/bin/switch-to-configuration test 2>&11058machine # [ 32.238645] nixos[1304]: switching to system configuration /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test1059machine # [ 32.241681] systemd[1]: Stopped target Remote File Systems.1060machine # [ 32.244284] systemd[1]: Stopped target Local File Systems.1061machine # [ 32.780143] systemd[1]: Reload requested from client PID 1304 ('.switch-to-conf') (unit backdoor.service)...1062machine # [ 32.782288] systemd[1]: Reloading...1063machine # [ 33.441707] systemd[1]: Reloading finished in 656 ms.1064machine # [ 33.637566] systemd[576]: Reexecution requested from client PID 1373 ('switch-to-confi')...1065machine # [ 33.641585] systemd[576]: Reexecuting.1066machine # [ 33.690798] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1067machine # [ 33.917838] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1068machine # [ 33.924876] systemd[576]: Reload requested from client PID 1373 ('switch-to-confi')...1069machine # [ 33.927476] systemd[576]: Reloading...1070machine # [ 34.144301] systemd[576]: Reloading finished in 215 ms.1071machine # [ 34.160234] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1072machine # [ 34.170562] systemd[576]: Stopped Run user-specific NixOS activation.1073machine # [ 34.173216] systemd[576]: Stopping Run user-specific NixOS activation...1074machine # [ 34.176522] systemd[576]: Starting Run user-specific NixOS activation...1075machine # [ 34.231169] systemd[576]: Finished Run user-specific NixOS activation.1076machine # [ 34.235813] systemd[1]: Stopped target Reactivate sysinit units.1077machine # [ 34.238517] systemd[1]: Stopping Reactivate sysinit units...1078machine # [ 34.239393] systemd[1]: Reached target Reactivate sysinit units.1079machine # [ 34.241901] systemd[1]: Reached target Remote File Systems.1080machine # [ 34.245044] systemd[1]: Reached target Local File Systems.1081machine # [ 34.248833] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1082machine # [ 34.253161] systemd[1]: Starting Create SUID/SGID Wrappers...1083machine # [ 34.257243] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1084machine # [ 34.258597] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671085machine # [ 34.268373] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1086machine # [ 34.270095] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1087machine # [ 34.271437] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1088machine # [ 34.274646] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1089machine # [ 34.277430] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1090machine # [ 34.645697] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1091machine # [ 34.650751] systemd[1]: Finished Create SUID/SGID Wrappers.1092machine # [ 34.653835] systemd[1]: Starting linger-users.service...1093machine # [ 34.721213] systemd[1]: linger-users.service: Deactivated successfully.1094machine # [ 34.724543] systemd[1]: Finished linger-users.service.1095machine # [ 34.982981] nixos[1304]: finished switching to system configuration /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test1096machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.39 seconds)1097machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11098machine # [ 35.672473] nixos[1445]: switching to system configuration /nix/store/p3fcif5mjimf1yzli0xiddmngr10pdq6-nixos-system-machine-test1099machine # [ 35.675858] systemd[1]: Stopped target Local File Systems.1100machine # [ 35.677417] systemd[1]: Stopped target Remote File Systems.1101machine # [ 36.261914] systemd[1]: Reload requested from client PID 1445 ('.switch-to-conf') (unit backdoor.service)...1102machine # [ 36.264151] systemd[1]: Reloading...1103machine # [ 37.323869] systemd[1]: Reloading finished in 1057 ms.1104machine # [ 37.518088] systemd[576]: Reexecution requested from client PID 1513 ('switch-to-confi')...1105machine # [ 37.519521] systemd[576]: Reexecuting.1106machine # [ 37.579309] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1107machine # [ 37.799785] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1108machine # [ 37.807873] systemd[576]: Reload requested from client PID 1513 ('switch-to-confi')...1109machine # [ 37.809953] systemd[576]: Reloading...1110machine # [ 38.031379] systemd[576]: Reloading finished in 220 ms.1111machine # [ 38.044219] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1112machine # [ 38.056558] systemd[576]: Stopped Run user-specific NixOS activation.1113machine # [ 38.059218] systemd[576]: Stopping Run user-specific NixOS activation...1114machine # [ 38.062858] systemd[576]: Starting Run user-specific NixOS activation...1115machine # [ 38.114635] systemd[576]: Finished Run user-specific NixOS activation.1116machine # [ 38.119462] systemd[1]: Stopped target Reactivate sysinit units.1117machine # [ 38.122547] systemd[1]: Stopping Reactivate sysinit units...1118machine # [ 38.124820] systemd[1]: Reached target Reactivate sysinit units.1119machine # [ 38.126891] systemd[1]: Reached target Remote File Systems.1120machine # [ 38.129152] systemd[1]: Reached target Local File Systems.1121machine # [ 38.133007] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1122machine # [ 38.139736] systemd[1]: Starting Create SUID/SGID Wrappers...1123machine # [ 38.142299] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1124machine # [ 38.144660] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671125machine # [ 38.146829] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1126machine # [ 38.156578] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1127machine # [ 38.160986] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1128machine # [ 38.162304] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1129machine # [ 38.163538] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1130machine # [ 38.560457] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1131machine # [ 38.565096] systemd[1]: Finished Create SUID/SGID Wrappers.1132machine # [ 38.571273] systemd[1]: Starting linger-users.service...1133machine # [ 38.575369] systemd[1]: Starting test.service...1134machine # [ 38.628839] systemd[1]: Finished test.service.1135machine # [ 38.660937] systemd[1]: linger-users.service: Deactivated successfully.1136machine # [ 38.663473] systemd[1]: Finished linger-users.service.1137machine # [ 38.922850] nixos[1445]: finished switching to system configuration /nix/store/p3fcif5mjimf1yzli0xiddmngr10pdq6-nixos-system-machine-test1138machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 3.94 seconds)1139machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11140machine # [ 39.653600] nixos[1588]: switching to system configuration /nix/store/p3fcif5mjimf1yzli0xiddmngr10pdq6-nixos-system-machine-test1141machine # [ 39.656919] systemd[1]: Stopped target Local File Systems.1142machine # [ 39.659882] systemd[1]: Stopped target Remote File Systems.1143machine # [ 40.318908] systemd[1]: Reload requested from client PID 1588 ('.switch-to-conf') (unit backdoor.service)...1144machine # [ 40.321311] systemd[1]: Reloading...1145machine # [ 41.105913] systemd[1]: Reloading finished in 780 ms.1146machine # [ 41.282620] systemd[576]: Reexecution requested from client PID 1657 ('switch-to-confi')...1147machine # [ 41.285825] systemd[576]: Reexecuting.1148machine # [ 41.359728] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1149machine # [ 41.605655] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1150machine # [ 41.612914] systemd[576]: Reload requested from client PID 1657 ('switch-to-confi')...1151machine # [ 41.615487] systemd[576]: Reloading...1152machine # [ 41.869271] systemd[576]: Reloading finished in 251 ms.1153machine # [ 41.884201] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1154machine # [ 41.894946] systemd[576]: Stopped Run user-specific NixOS activation.1155machine # [ 41.897755] systemd[576]: Stopping Run user-specific NixOS activation...1156machine # [ 41.900966] systemd[576]: Starting Run user-specific NixOS activation...1157machine # [ 41.965567] systemd[576]: Finished Run user-specific NixOS activation.1158machine # [ 41.971319] systemd[1]: Stopped target Reactivate sysinit units.1159machine # [ 41.974566] systemd[1]: Stopping Reactivate sysinit units...1160machine # [ 41.975503] systemd[1]: Reached target Reactivate sysinit units.1161machine # [ 41.980535] systemd[1]: Reached target Remote File Systems.1162machine # [ 41.989549] systemd[1]: Starting linger-users.service...1163machine # [ 41.995740] systemd[1]: Reached target Local File Systems.1164machine # [ 41.997837] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1165machine # [ 42.001922] systemd[1]: Starting Create SUID/SGID Wrappers...1166machine # [ 42.002958] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1167machine # [ 42.017537] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671168machine # [ 42.019997] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1169machine # [ 42.030246] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1170machine # [ 42.031576] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1171machine # [ 42.033261] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1172machine # [ 42.034581] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1173machine # [ 42.127610] systemd[1]: linger-users.service: Deactivated successfully.1174machine # [ 42.131127] systemd[1]: Finished linger-users.service.1175machine # [ 42.537255] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1176machine # [ 42.541339] systemd[1]: Finished Create SUID/SGID Wrappers.1177machine # [ 42.798763] nixos[1588]: finished switching to system configuration /nix/store/p3fcif5mjimf1yzli0xiddmngr10pdq6-nixos-system-machine-test1178machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 3.87 seconds)1179machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&11180machine # [ 43.584670] nixos[1729]: switching to system configuration /nix/store/a1s4vj6li6xk4nd7av95z7c7g1i0jqd7-nixos-system-machine-test1181machine # [ 43.589484] systemd[1]: Stopped target Remote File Systems.1182machine # [ 43.592283] systemd[1]: Stopped target Local File Systems.1183machine # [ 44.200490] systemd[1]: Reload requested from client PID 1729 ('.switch-to-conf') (unit backdoor.service)...1184machine # [ 44.202504] systemd[1]: Reloading...1185machine # [ 44.954195] systemd[1]: Reloading finished in 748 ms.1186machine # [ 45.131807] systemd[576]: Reexecution requested from client PID 1799 ('switch-to-confi')...1187machine # [ 45.134379] systemd[576]: Reexecuting.1188machine # [ 45.204095] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1189machine # [ 45.432778] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1190machine # [ 45.440808] systemd[576]: Reload requested from client PID 1799 ('switch-to-confi')...1191machine # [ 45.442960] systemd[576]: Reloading...1192machine # [ 45.674485] systemd[576]: Reloading finished in 230 ms.1193machine # [ 45.688283] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1194machine # [ 45.699367] systemd[576]: Stopped Run user-specific NixOS activation.1195machine # [ 45.702048] systemd[576]: Stopping Run user-specific NixOS activation...1196machine # [ 45.705559] systemd[576]: Starting Run user-specific NixOS activation...1197machine # [ 45.769410] systemd[576]: Finished Run user-specific NixOS activation.1198machine # [ 45.774484] systemd[1]: Stopped target Reactivate sysinit units.1199machine # [ 45.776962] systemd[1]: Stopping Reactivate sysinit units...1200machine # [ 45.778680] systemd[1]: Reached target Reactivate sysinit units.1201machine # [ 45.785674] systemd[1]: Reached target Remote File Systems.1202machine # [ 45.788987] systemd[1]: Reached target Local File Systems.1203machine # [ 45.791971] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1204machine # [ 45.800785] systemd[1]: Starting Create SUID/SGID Wrappers...1205machine # [ 45.801840] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1206machine # [ 45.803092] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671207machine # [ 45.808786] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1208machine # [ 45.820485] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1209machine # [ 45.821816] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1210machine # [ 45.823021] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1211machine # [ 45.825444] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1212machine # [ 46.283116] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1213machine # [ 46.288602] systemd[1]: Finished Create SUID/SGID Wrappers.1214machine # [ 46.291553] systemd[1]: Starting linger-users.service...1215machine # [ 46.363443] systemd[1]: linger-users.service: Deactivated successfully.1216machine # [ 46.366334] systemd[1]: Finished linger-users.service.1217machine # [ 46.625217] nixos[1729]: finished switching to system configuration /nix/store/a1s4vj6li6xk4nd7av95z7c7g1i0jqd7-nixos-system-machine-test1218machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 3.83 seconds)1219machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11220machine # [ 47.361853] nixos[1870]: switching to system configuration /nix/store/fc9vv51r37nmsfcdlr91j5hw1qh4ig2x-nixos-system-machine-test1221machine # [ 47.365980] systemd[1]: Stopped target Local File Systems.1222machine # [ 47.367776] systemd[1]: Stopped target Remote File Systems.1223machine # [ 47.369445] systemd[1]: test.service: Deactivated successfully.1224machine # [ 47.370296] systemd[1]: Stopped Test unit.1225machine # [ 47.946407] systemd[1]: Reload requested from client PID 1870 ('.switch-to-conf') (unit backdoor.service)...1226machine # [ 47.948634] systemd[1]: Reloading...1227machine # [ 48.674288] systemd[1]: Reloading finished in 721 ms.1228machine # [ 48.836488] systemd[576]: Reexecution requested from client PID 1940 ('switch-to-confi')...1229machine # [ 48.840342] systemd[576]: Reexecuting.1230machine # [ 48.907205] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1231machine # [ 49.112303] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1232machine # [ 49.118992] systemd[576]: Reload requested from client PID 1940 ('switch-to-confi')...1233machine # [ 49.121669] systemd[576]: Reloading...1234machine # [ 49.324524] systemd[576]: Reloading finished in 202 ms.1235machine # [ 49.340199] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1236machine # [ 49.350836] systemd[576]: Stopped Run user-specific NixOS activation.1237machine # [ 49.353437] systemd[576]: Stopping Run user-specific NixOS activation...1238machine # [ 49.356569] systemd[576]: Starting Run user-specific NixOS activation...1239machine # [ 49.409924] systemd[576]: Finished Run user-specific NixOS activation.1240machine # [ 49.414844] systemd[1]: Stopped target Reactivate sysinit units.1241machine # [ 49.417323] systemd[1]: Stopping Reactivate sysinit units...1242machine # [ 49.423053] systemd[1]: Reached target Reactivate sysinit units.1243machine # [ 49.424210] systemd[1]: Reached target Remote File Systems.1244machine # [ 49.428376] systemd[1]: Starting linger-users.service...1245machine # [ 49.432990] systemd[1]: Starting test.service...1246machine # [ 49.451470] systemd[1]: Reached target Local File Systems.1247machine # [ 49.455318] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1248machine # [ 49.459486] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1249machine # [ 49.468660] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1250machine # [ 49.478140] systemd[1]: Starting Create SUID/SGID Wrappers...1251machine # [ 49.480103] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1252machine # [ 49.481622] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671253machine # [ 49.488750] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1254machine # [ 49.490547] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1255machine # [ 49.491969] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1256machine # [ 49.521805] systemd[1]: Finished test.service.1257machine # [ 49.575425] systemd[1]: linger-users.service: Deactivated successfully.1258machine # [ 49.578164] systemd[1]: Finished linger-users.service.1259machine # [ 49.900003] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1260machine # [ 49.903588] systemd[1]: Finished Create SUID/SGID Wrappers.1261machine # [ 50.161186] nixos[1870]: finished switching to system configuration /nix/store/fc9vv51r37nmsfcdlr91j5hw1qh4ig2x-nixos-system-machine-test1262machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 3.54 seconds)1263machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&11264machine # [ 50.833143] nixos[2013]: switching to system configuration /nix/store/q4hqx9aiw9lpsqrdz9v39nigfilgnwpv-nixos-system-machine-test1265machine # [ 50.836488] systemd[1]: Stopped target Local File Systems.1266machine # [ 50.837913] systemd[1]: Stopped target Remote File Systems.1267machine # [ 51.407328] systemd[1]: Reload requested from client PID 2013 ('.switch-to-conf') (unit backdoor.service)...1268machine # [ 51.409771] systemd[1]: Reloading...1269machine # [ 52.087978] systemd[1]: Reloading finished in 676 ms.1270machine # [ 52.232924] systemd[576]: Reexecution requested from client PID 2082 ('switch-to-confi')...1271machine # [ 52.236677] systemd[576]: Reexecuting.1272machine # [ 52.285851] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1273machine # [ 52.481609] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1274machine # [ 52.488340] systemd[576]: Reload requested from client PID 2082 ('switch-to-confi')...1275machine # [ 52.490894] systemd[576]: Reloading...1276machine # [ 52.686675] systemd[576]: Reloading finished in 194 ms.1277machine # [ 52.700292] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1278machine # [ 52.710194] systemd[576]: Stopped Run user-specific NixOS activation.1279machine # [ 52.712664] systemd[576]: Stopping Run user-specific NixOS activation...1280machine # [ 52.715554] systemd[576]: Starting Run user-specific NixOS activation...1281machine # [ 52.762907] systemd[576]: Finished Run user-specific NixOS activation.1282machine # [ 52.767474] systemd[1]: Stopped target Reactivate sysinit units.1283machine # [ 52.769262] systemd[1]: Stopping Reactivate sysinit units...1284machine # [ 52.770091] systemd[1]: Reached target Reactivate sysinit units.1285machine # [ 52.772345] systemd[1]: test.service: Deactivated successfully.1286machine # [ 52.775326] systemd[1]: Stopped test.service.1287machine # [ 52.776351] systemd[1]: Stopping test.service...1288machine # [ 52.778569] systemd[1]: Starting test.service...1289machine # [ 52.816559] systemd[1]: Finished test.service.1290machine # [ 52.820351] systemd[1]: Reached target Remote File Systems.1291machine # [ 52.827014] systemd[1]: Starting linger-users.service...1292machine # [ 52.833142] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1293machine # [ 52.834492] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1294machine # [ 52.841371] systemd[1]: Reached target Local File Systems.1295machine # [ 52.843266] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1296machine # [ 52.852982] systemd[1]: Starting Create SUID/SGID Wrappers...1297machine # [ 52.853858] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1298machine # [ 52.855046] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671299machine # [ 52.859510] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1300machine # [ 52.868224] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1301machine # [ 52.871076] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1302machine # [ 52.938137] systemd[1]: linger-users.service: Deactivated successfully.1303machine # [ 52.941314] systemd[1]: Finished linger-users.service.1304machine # [ 53.238828] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1305machine # [ 53.242567] systemd[1]: Finished Create SUID/SGID Wrappers.1306machine # [ 53.499466] nixos[2013]: finished switching to system configuration /nix/store/q4hqx9aiw9lpsqrdz9v39nigfilgnwpv-nixos-system-machine-test1307machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.34 seconds)1308machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&11309machine # [ 54.160383] nixos[2155]: switching to system configuration /nix/store/klh49g58ayjnqpmd5qh5nqx9drvka1nj-nixos-system-machine-test1310machine # [ 54.163109] systemd[1]: Stopped target Local File Systems.1311machine # [ 54.165436] systemd[1]: Stopped target Remote File Systems.1312machine # [ 54.693253] systemd[1]: Reload requested from client PID 2155 ('.switch-to-conf') (unit backdoor.service)...1313machine # [ 54.695190] systemd[1]: Reloading...1314machine # [ 55.393780] systemd[1]: Reloading finished in 695 ms.1315machine # [ 55.544250] systemd[576]: Reexecution requested from client PID 2224 ('switch-to-confi')...1316machine # [ 55.546017] systemd[576]: Reexecuting.1317machine # [ 55.605510] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1318machine # [ 55.797876] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1319machine # [ 55.804643] systemd[576]: Reload requested from client PID 2224 ('switch-to-confi')...1320machine # [ 55.806844] systemd[576]: Reloading...1321machine # [ 56.002109] systemd[576]: Reloading finished in 193 ms.1322machine # [ 56.012180] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1323machine # [ 56.023282] systemd[576]: Stopped Run user-specific NixOS activation.1324machine # [ 56.025724] systemd[576]: Stopping Run user-specific NixOS activation...1325machine # [ 56.028551] systemd[576]: Starting Run user-specific NixOS activation...1326machine # [ 56.077726] systemd[576]: Finished Run user-specific NixOS activation.1327machine # [ 56.081860] systemd[1]: Stopped target Reactivate sysinit units.1328machine # [ 56.086109] systemd[1]: Stopping Reactivate sysinit units...1329machine # [ 56.087301] systemd[1]: Reached target Reactivate sysinit units.1330machine # [ 56.089983] systemd[1]: Reloading test.service...1331machine # [ 56.123986] systemd[1]: Reloaded test.service.1332machine # [ 56.127995] systemd[1]: Reached target Local File Systems.1333machine # [ 56.135066] systemd[1]: Reached target Remote File Systems.1334machine # [ 56.138301] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1335machine # [ 56.142779] systemd[1]: Starting Create SUID/SGID Wrappers...1336machine # [ 56.143697] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1337machine # [ 56.147225] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671338machine # [ 56.156569] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1339machine # [ 56.158285] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1340machine # [ 56.159531] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1341machine # [ 56.164700] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1342machine # [ 56.166055] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1343machine # [ 56.492826] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1344machine # [ 56.496709] systemd[1]: Finished Create SUID/SGID Wrappers.1345machine # [ 56.499812] systemd[1]: Starting linger-users.service...1346machine # [ 56.563142] systemd[1]: linger-users.service: Deactivated successfully.1347machine # [ 56.565871] systemd[1]: Finished linger-users.service.1348machine # [ 56.824598] nixos[2155]: finished switching to system configuration /nix/store/klh49g58ayjnqpmd5qh5nqx9drvka1nj-nixos-system-machine-test1349machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 3.32 seconds)1350machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&11351machine # [ 57.455271] nixos[2297]: switching to system configuration /nix/store/6cf4937d4majd9i2kzr31yq3vrqj0sid-nixos-system-machine-test1352machine # [ 57.458572] systemd[1]: Stopped target Local File Systems.1353machine # [ 57.459985] systemd[1]: Stopped target Remote File Systems.1354machine # [ 58.037628] systemd[1]: Reload requested from client PID 2297 ('.switch-to-conf') (unit backdoor.service)...1355machine # [ 58.039635] systemd[1]: Reloading...1356machine # [ 58.772693] systemd[1]: Reloading finished in 731 ms.1357machine # [ 58.936473] systemd[576]: Reexecution requested from client PID 2366 ('switch-to-confi')...1358machine # [ 58.940126] systemd[576]: Reexecuting.1359machine # [ 58.995559] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1360machine # [ 59.251889] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1361machine # [ 59.259641] systemd[576]: Reload requested from client PID 2366 ('switch-to-confi')...1362machine # [ 59.264176] systemd[576]: Reloading...1363machine # [ 59.473003] systemd[576]: Reloading finished in 210 ms.1364machine # [ 59.489753] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1365machine # [ 59.501198] systemd[576]: Stopped Run user-specific NixOS activation.1366machine # [ 59.504118] systemd[576]: Stopping Run user-specific NixOS activation...1367machine # [ 59.507828] systemd[576]: Starting Run user-specific NixOS activation...1368machine # [ 59.562876] systemd[576]: Finished Run user-specific NixOS activation.1369machine # [ 59.567614] systemd[1]: Stopped target Reactivate sysinit units.1370machine # [ 59.569871] systemd[1]: Stopping Reactivate sysinit units...1371machine # [ 59.574784] systemd[1]: Reached target Reactivate sysinit units.1372machine # [ 59.576197] systemd[1]: Reached target Remote File Systems.1373machine # [ 59.578998] systemd[1]: Starting linger-users.service...1374machine # [ 59.581981] systemd[1]: Reached target Local File Systems.1375machine # [ 59.586011] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1376machine # [ 59.592813] systemd[1]: Starting Create SUID/SGID Wrappers...1377machine # [ 59.594933] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1378machine # [ 59.602361] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671379machine # [ 59.609002] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1380machine # [ 59.614639] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1381machine # [ 59.620420] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1382machine # [ 59.622213] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1383machine # [ 59.624653] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1384machine # [ 59.693890] systemd[1]: linger-users.service: Deactivated successfully.1385machine # [ 59.697683] systemd[1]: Finished linger-users.service.1386machine # [ 60.019646] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1387machine # [ 60.023457] systemd[1]: Finished Create SUID/SGID Wrappers.1388machine # [ 60.280485] nixos[2297]: finished switching to system configuration /nix/store/6cf4937d4majd9i2kzr31yq3vrqj0sid-nixos-system-machine-test1389machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 3.46 seconds)1390machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&11391machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.79 seconds)1392machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/bin/switch-to-configuration test 2>&11393machine # [ 61.716691] nixos[2447]: switching to system configuration /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test1394machine # [ 61.721389] systemd[1]: Stopped target Local File Systems.1395machine # [ 61.723610] systemd[1]: Stopped target Remote File Systems.1396machine # [ 61.725409] systemd[1]: test.service: Deactivated successfully.1397machine # [ 61.726530] systemd[1]: Stopped test.service.1398machine # [ 62.262929] systemd[1]: Reload requested from client PID 2447 ('.switch-to-conf') (unit backdoor.service)...1399machine # [ 62.265272] systemd[1]: Reloading...1400machine # [ 62.965393] systemd[1]: Reloading finished in 697 ms.1401machine # [ 63.142157] systemd[576]: Reexecution requested from client PID 2516 ('switch-to-confi')...1402machine # [ 63.143852] systemd[576]: Reexecuting.1403machine # [ 63.214848] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1404machine # [ 63.426337] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1405machine # [ 63.432934] systemd[576]: Reload requested from client PID 2516 ('switch-to-confi')...1406machine # [ 63.435390] systemd[576]: Reloading...1407machine # [ 63.639127] systemd[576]: Reloading finished in 202 ms.1408machine # [ 63.652172] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1409machine # [ 63.662085] systemd[576]: Stopped Run user-specific NixOS activation.1410machine # [ 63.664639] systemd[576]: Stopping Run user-specific NixOS activation...1411machine # [ 63.667781] systemd[576]: Starting Run user-specific NixOS activation...1412machine # [ 63.717796] systemd[576]: Finished Run user-specific NixOS activation.1413machine # [ 63.722165] systemd[1]: Stopped target Reactivate sysinit units.1414machine # [ 63.724396] systemd[1]: Stopping Reactivate sysinit units...1415machine # [ 63.725337] systemd[1]: Reached target Reactivate sysinit units.1416machine # [ 63.727565] systemd[1]: Reached target Remote File Systems.1417machine # [ 63.729568] systemd[1]: Reached target Local File Systems.1418machine # [ 63.737546] systemd[1]: Starting linger-users.service...1419machine # [ 63.747355] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1420machine # [ 63.750393] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1421machine # [ 63.755712] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1422machine # [ 63.763005] systemd[1]: Starting Create SUID/SGID Wrappers...1423machine # [ 63.763911] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1424machine # [ 63.766254] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671425machine # [ 63.769226] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1426machine # [ 63.771426] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1427machine # [ 63.773668] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1428machine # [ 63.835074] systemd[1]: linger-users.service: Deactivated successfully.1429machine # [ 63.837777] systemd[1]: Finished linger-users.service.1430machine # [ 64.141921] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1431machine # [ 64.145375] systemd[1]: Finished Create SUID/SGID Wrappers.1432machine # [ 64.402273] nixos[2447]: finished switching to system configuration /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test1433machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.34 seconds)1434machine: must succeed: /nix/store/rkj73kh2sz4jv6nhdk6fkf0j6zm71y3w-separate-activation-script/bin/switch-to-configuration test 2>&11435machine # [ 65.039502] nixos[2587]: switching to system configuration /nix/store/1ag5piy16h3v1f78wcck9whd2vfxir6x-nixos-system-machine-test1436machine # [ 65.042683] systemd[1]: Stopped target Local File Systems.1437machine # [ 65.044070] systemd[1]: Stopped target Remote File Systems.1438machine # [ 65.586092] systemd[1]: Reload requested from client PID 2587 ('.switch-to-conf') (unit backdoor.service)...1439machine # [ 65.588539] systemd[1]: Reloading...1440machine # [ 66.232973] systemd[1]: Reloading finished in 642 ms.1441machine # [ 66.399253] systemd[576]: Stopped Run user-specific NixOS activation.1442machine # [ 66.402666] systemd[576]: Reexecution requested from client PID 2656 ('switch-to-confi')...1443machine # [ 66.404985] systemd[576]: Reexecuting.1444machine # [ 66.470116] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1445machine # [ 66.668806] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1446machine # [ 66.675009] systemd[576]: Reload requested from client PID 2656 ('switch-to-confi')...1447machine # [ 66.678890] systemd[576]: Reloading...1448machine # [ 66.865644] systemd[576]: Reloading finished in 187 ms.1449machine # [ 66.880190] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1450machine # [ 66.891877] systemd[1]: Stopped target Reactivate sysinit units.1451machine # [ 66.895559] systemd[1]: Stopping Reactivate sysinit units...1452machine # [ 66.896744] systemd[1]: Reached target Reactivate sysinit units.1453machine # [ 66.898125] systemd[1]: Reached target Remote File Systems.1454machine # [ 66.904240] systemd[1]: Starting linger-users.service...1455machine # [ 66.907773] systemd[1]: Starting test.service...1456machine # [ 66.914434] systemd[1]: Reached target Local File Systems.1457machine # [ 66.920596] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1458machine # [ 66.926644] systemd[1]: Starting Create SUID/SGID Wrappers...1459machine # [ 66.936776] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1460machine # [ 66.938100] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671461machine # [ 66.948438] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1462machine # [ 66.950634] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1463machine # [ 66.953497] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1464machine # [ 66.955768] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1465machine # [ 66.958778] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1466machine # [ 66.994387] systemd[1]: Finished test.service.1467machine # [ 67.029781] systemd[1]: linger-users.service: Deactivated successfully.1468machine # [ 67.032262] systemd[1]: Finished linger-users.service.1469machine # [ 67.298149] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1470machine # [ 67.301739] systemd[1]: Finished Create SUID/SGID Wrappers.1471machine # [ 67.560848] nixos[2587]: finished switching to system configuration /nix/store/1ag5piy16h3v1f78wcck9whd2vfxir6x-nixos-system-machine-test1472machine: (finished: must succeed: /nix/store/rkj73kh2sz4jv6nhdk6fkf0j6zm71y3w-separate-activation-script/bin/switch-to-configuration test 2>&1, in 3.16 seconds)1473machine: must succeed: ! test -e /run/current-system/activate1474machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.04 seconds)1475machine: must succeed: ! test -e /run/current-system/dry-activate1476machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.03 seconds)1477machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration1478machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.03 seconds)1479machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&11480machine # [ 68.287180] nixos[2735]: switching to system configuration /nix/store/xkkwaz9sh11f70kmm4f33xhny4iaaq0j-nixos-system-machine-test1481machine # [ 68.291278] systemd[1]: Stopped target Local File Systems.1482machine # [ 68.293267] systemd[1]: Stopped target Remote File Systems.1483machine # [ 68.294096] systemd[1]: test.service: Deactivated successfully.1484machine # [ 68.294890] systemd[1]: Stopped test.service.1485machine # [ 68.822430] systemd[1]: Reload requested from client PID 2735 ('.switch-to-conf') (unit backdoor.service)...1486machine # [ 68.824572] systemd[1]: Reloading...1487machine # [ 69.478181] systemd[1]: Reloading finished in 651 ms.1488machine # [ 69.620143] systemd[576]: Reexecution requested from client PID 2804 ('switch-to-confi')...1489machine # [ 69.621565] systemd[576]: Reexecuting.1490machine # [ 69.678123] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1491machine # [ 69.865932] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1492machine # [ 69.872268] systemd[576]: Reload requested from client PID 2804 ('switch-to-confi')...1493machine # [ 69.874580] systemd[576]: Reloading...1494machine # [ 70.063495] systemd[576]: Reloading finished in 187 ms.1495machine # [ 70.076155] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1496machine # [ 70.086018] systemd[576]: Starting Run user-specific NixOS activation...1497machine # [ 70.129807] systemd[576]: Finished Run user-specific NixOS activation.1498machine # [ 70.132970] systemd[576]: Stopped Run user-specific NixOS activation.1499machine # [ 70.135325] systemd[576]: Stopping Run user-specific NixOS activation...1500machine # [ 70.139119] systemd[576]: Starting Run user-specific NixOS activation...1501machine # [ 70.141286] systemd[1]: Stopped target Reactivate sysinit units.1502machine # [ 70.143285] systemd[1]: Stopping Reactivate sysinit units...1503machine # [ 70.148182] systemd[1]: Reached target Reactivate sysinit units.1504machine # [ 70.151855] systemd[1]: Reached target Remote File Systems.1505machine # [ 70.156374] systemd[1]: Starting linger-users.service...1506machine # [ 70.168331] systemd[1]: Reached target Local File Systems.1507machine # [ 70.171739] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1508machine # [ 70.177585] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1509machine # [ 70.194231] systemd[1]: Started test.service.1510machine # [ 70.201199] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1511machine # [ 70.212327] systemd[1]: Starting Create SUID/SGID Wrappers...1512machine # [ 70.225863] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1513machine # [ 70.227231] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671514machine # [ 70.231016] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1515machine # [ 70.235951] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1516machine # [ 70.238294] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1517machine # [ 70.241715] systemd[576]: Finished Run user-specific NixOS activation.1518machine # [ 70.276566] systemd[1]: test.service: Deactivated successfully.1519machine # [ 70.294610] systemd[1]: linger-users.service: Deactivated successfully.1520machine # [ 70.295623] systemd[1]: Finished linger-users.service.1521machine # [ 70.591969] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1522machine # [ 70.595439] systemd[1]: Finished Create SUID/SGID Wrappers.1523machine # [ 70.852365] nixos[2735]: finished switching to system configuration /nix/store/xkkwaz9sh11f70kmm4f33xhny4iaaq0j-nixos-system-machine-test1524machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 3.19 seconds)1525machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&11526machine # [ 71.474815] nixos[2880]: switching to system configuration /nix/store/yq7jh353wgyf6x9plx098k6di6j13nw5-nixos-system-machine-test1527machine # [ 71.477400] systemd[1]: Stopped target Local File Systems.1528machine # [ 71.479718] systemd[1]: Stopped target Remote File Systems.1529machine # [ 71.983322] systemd[1]: Reload requested from client PID 2880 ('.switch-to-conf') (unit backdoor.service)...1530machine # [ 71.985582] systemd[1]: Reloading...1531machine # [ 72.631428] systemd[1]: Reloading finished in 643 ms.1532machine # [ 72.774206] systemd[576]: Reexecution requested from client PID 2949 ('switch-to-confi')...1533machine # [ 72.775576] systemd[576]: Reexecuting.1534machine # [ 72.838003] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1535machine # [ 73.027147] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1536machine # [ 73.033393] systemd[576]: Reload requested from client PID 2949 ('switch-to-confi')...1537machine # [ 73.035526] systemd[576]: Reloading...1538machine # [ 73.224654] systemd[576]: Reloading finished in 187 ms.1539machine # [ 73.240159] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1540machine # [ 73.250878] systemd[576]: Stopped Run user-specific NixOS activation.1541machine # [ 73.253248] systemd[576]: Stopping Run user-specific NixOS activation...1542machine # [ 73.256070] systemd[576]: Starting Run user-specific NixOS activation...1543machine # [ 73.299585] systemd[576]: Finished Run user-specific NixOS activation.1544machine # [ 73.304707] systemd[1]: Stopped target Reactivate sysinit units.1545machine # [ 73.305710] systemd[1]: Stopping Reactivate sysinit units...1546machine # [ 73.306504] systemd[1]: Reached target Reactivate sysinit units.1547machine # [ 73.309655] systemd[1]: Reached target Remote File Systems.1548machine # [ 73.315327] systemd[1]: Starting escaped\x2ddash.service...1549machine # [ 73.318227] systemd[1]: Starting linger-users.service...1550machine # [ 73.328961] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1551machine # [ 73.330337] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1552machine # [ 73.337180] systemd[1]: Reached target Local File Systems.1553machine # [ 73.340675] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1554machine # [ 73.349927] systemd[1]: Starting Create SUID/SGID Wrappers...1555machine # [ 73.354623] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1556machine # [ 73.360272] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671557machine # [ 73.362927] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1558machine # [ 73.365872] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1559machine # [ 73.367302] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1560machine # [ 73.400977] systemd[1]: Finished escaped\x2ddash.service.1561machine # [ 73.437037] systemd[1]: linger-users.service: Deactivated successfully.1562machine # [ 73.440115] systemd[1]: Finished linger-users.service.1563machine # [ 73.706924] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1564machine # [ 73.710084] systemd[1]: Finished Create SUID/SGID Wrappers.1565machine # [ 73.968550] nixos[2880]: finished switching to system configuration /nix/store/yq7jh353wgyf6x9plx098k6di6j13nw5-nixos-system-machine-test1566machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 3.11 seconds)1567machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&11568machine # [ 74.598307] nixos[3022]: switching to system configuration /nix/store/5vypnhgbbm0icnwd4av51v79hnafgds4-nixos-system-machine-test1569machine # [ 74.602173] systemd[1]: Stopped target Local File Systems.1570machine # [ 74.603966] systemd[1]: Stopped target Remote File Systems.1571machine # [ 74.605505] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1572machine # [ 74.606613] systemd[1]: Stopped escaped\x2ddash.service.1573machine # [ 75.132127] systemd[1]: Reload requested from client PID 3022 ('.switch-to-conf') (unit backdoor.service)...1574machine # [ 75.134110] systemd[1]: Reloading...1575machine # [ 75.820384] systemd[1]: Reloading finished in 683 ms.1576machine # [ 75.975045] systemd[576]: Reexecution requested from client PID 3091 ('switch-to-confi')...1577machine # [ 75.977504] systemd[576]: Reexecuting.1578machine # [ 76.042260] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1579machine # [ 76.253845] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1580machine # [ 76.261160] systemd[576]: Reload requested from client PID 3091 ('switch-to-confi')...1581machine # [ 76.264163] systemd[576]: Reloading...1582machine # [ 76.470650] systemd[576]: Reloading finished in 205 ms.1583machine # [ 76.488194] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1584machine # [ 76.499463] systemd[576]: Stopped Run user-specific NixOS activation.1585machine # [ 76.500698] systemd[576]: Stopping Run user-specific NixOS activation...1586machine # [ 76.503773] systemd[576]: Starting Run user-specific NixOS activation...1587machine # [ 76.552828] systemd[576]: Finished Run user-specific NixOS activation.1588machine # [ 76.557122] systemd[1]: Stopped target Reactivate sysinit units.1589machine # [ 76.559138] systemd[1]: Stopping Reactivate sysinit units...1590machine # [ 76.561999] systemd[1]: Reached target Reactivate sysinit units.1591machine # [ 76.566269] systemd[1]: Reached target Remote File Systems.1592machine # [ 76.570267] systemd[1]: Starting escaped\x2ddash.service...1593machine # [ 76.573474] systemd[1]: Starting linger-users.service...1594machine # [ 76.581474] systemd[1]: Reached target Local File Systems.1595machine # [ 76.589251] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1596machine # [ 76.594112] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1597machine # [ 76.596587] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1598machine # [ 76.606547] systemd[1]: Starting Create SUID/SGID Wrappers...1599machine # [ 76.607481] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1600machine # [ 76.612648] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671601machine # [ 76.615604] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1602machine # [ 76.618254] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1603machine # [ 76.624075] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1604machine # [ 76.653333] systemd[1]: Finished escaped\x2ddash.service.1605machine # [ 76.691153] systemd[1]: linger-users.service: Deactivated successfully.1606machine # [ 76.694863] systemd[1]: Finished linger-users.service.1607machine # [ 76.989291] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1608machine # [ 76.992679] systemd[1]: Finished Create SUID/SGID Wrappers.1609machine # [ 77.247455] nixos[3022]: finished switching to system configuration /nix/store/5vypnhgbbm0icnwd4av51v79hnafgds4-nixos-system-machine-test1610machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 3.28 seconds)1611machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&11612machine # [ 77.910769] nixos[3164]: switching to system configuration /nix/store/1z9xdh290ypsvn0xkc8sjh10agx4znwa-nixos-system-machine-test1613machine # [ 77.914775] systemd[1]: Stopped target Local File Systems.1614machine # [ 77.916907] systemd[1]: Stopped target Remote File Systems.1615machine # [ 77.917760] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1616machine # [ 77.918677] systemd[1]: Stopped escaped\x2ddash.service.1617machine # [ 78.465430] systemd[1]: Reload requested from client PID 3164 ('.switch-to-conf') (unit backdoor.service)...1618machine # [ 78.467407] systemd[1]: Reloading...1619machine # [ 79.137846] systemd[1]: Reloading finished in 668 ms.1620machine # [ 79.287215] systemd[576]: Reexecution requested from client PID 3233 ('switch-to-confi')...1621machine # [ 79.291561] systemd[576]: Reexecuting.1622machine # [ 79.354163] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1623machine # [ 79.549600] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1624machine # [ 79.556382] systemd[576]: Reload requested from client PID 3233 ('switch-to-confi')...1625machine # [ 79.558983] systemd[576]: Reloading...1626machine # [ 79.748354] systemd[576]: Reloading finished in 188 ms.1627machine # [ 79.764233] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1628machine # [ 79.774529] systemd[576]: Stopped Run user-specific NixOS activation.1629machine # [ 79.777073] systemd[576]: Stopping Run user-specific NixOS activation...1630machine # [ 79.780100] systemd[576]: Starting Run user-specific NixOS activation...1631machine # [ 79.828824] systemd[576]: Finished Run user-specific NixOS activation.1632machine # [ 79.833453] systemd[1]: Stopped target Reactivate sysinit units.1633machine # [ 79.837221] systemd[1]: Stopping Reactivate sysinit units...1634machine # [ 79.839198] systemd[1]: Reached target Reactivate sysinit units.1635machine # [ 79.840778] systemd[1]: Reached target Remote File Systems.1636machine # [ 79.842310] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1637machine # [ 79.843584] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1638machine # [ 79.847537] systemd[1]: Reached target Local File Systems.1639machine # [ 79.850971] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1640machine # [ 79.855110] systemd[1]: Starting Create SUID/SGID Wrappers...1641machine # [ 79.860406] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1642machine # [ 79.864443] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671643machine # [ 79.866626] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1644machine # [ 79.873418] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1645machine # [ 79.875269] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1646machine # [ 80.185994] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1647machine # [ 80.190341] systemd[1]: Finished Create SUID/SGID Wrappers.1648machine # [ 80.194129] systemd[1]: Starting -.service...1649machine # [ 80.197074] systemd[1]: Starting linger-users.service...1650machine # [ 80.240897] systemd[1]: Finished -.service.1651machine # [ 80.271156] systemd[1]: linger-users.service: Deactivated successfully.1652machine # [ 80.273638] systemd[1]: Finished linger-users.service.1653machine # [ 80.531822] nixos[3164]: finished switching to system configuration /nix/store/1z9xdh290ypsvn0xkc8sjh10agx4znwa-nixos-system-machine-test1654machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 3.29 seconds)1655machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&11656machine # [ 81.163079] nixos[3306]: switching to system configuration /nix/store/vv33jhqzcnwazch710hagg7vjakb9bwl-nixos-system-machine-test1657machine # [ 81.166007] systemd[1]: Stopped target Local File Systems.1658machine # [ 81.168419] systemd[1]: Stopped target Remote File Systems.1659machine # [ 81.688572] systemd[1]: Reload requested from client PID 3306 ('.switch-to-conf') (unit backdoor.service)...1660machine # [ 81.690525] systemd[1]: Reloading...1661machine # [ 82.335028] systemd[1]: Reloading finished in 642 ms.1662machine # [ 82.480580] systemd[576]: Reexecution requested from client PID 3375 ('switch-to-confi')...1663machine # [ 82.484296] systemd[576]: Reexecuting.1664machine # [ 82.537949] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1665machine # [ 82.725714] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1666machine # [ 82.733217] systemd[576]: Reload requested from client PID 3375 ('switch-to-confi')...1667machine # [ 82.735643] systemd[576]: Reloading...1668machine # [ 82.925837] systemd[576]: Reloading finished in 189 ms.1669machine # [ 82.940191] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1670machine # [ 82.951252] systemd[576]: Stopped Run user-specific NixOS activation.1671machine # [ 82.953673] systemd[576]: Stopping Run user-specific NixOS activation...1672machine # [ 82.956504] systemd[576]: Starting Run user-specific NixOS activation...1673machine # [ 83.002477] systemd[576]: Finished Run user-specific NixOS activation.1674machine # [ 83.006629] systemd[1]: Stopped target Reactivate sysinit units.1675machine # [ 83.011024] systemd[1]: Stopping Reactivate sysinit units...1676machine # [ 83.012278] systemd[1]: Reached target Reactivate sysinit units.1677machine # [ 83.014410] systemd[1]: Reloading -.service...1678machine # [ 83.047075] systemd[1]: Reloaded -.service.1679machine # [ 83.050676] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1680machine # [ 83.053192] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1681machine # [ 83.056445] systemd[1]: Reached target Local File Systems.1682machine # [ 83.059452] systemd[1]: Reached target Remote File Systems.1683machine # [ 83.063782] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1684machine # [ 83.070938] systemd[1]: Starting Create SUID/SGID Wrappers...1685machine # [ 83.072907] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1686machine # [ 83.076337] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671687machine # [ 83.079326] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1688machine # [ 83.084398] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1689machine # [ 83.085647] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1690machine # [ 83.406678] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1691machine # [ 83.411302] systemd[1]: Finished Create SUID/SGID Wrappers.1692machine # [ 83.414321] systemd[1]: Starting linger-users.service...1693machine # [ 83.476779] systemd[1]: linger-users.service: Deactivated successfully.1694machine # [ 83.479191] systemd[1]: Finished linger-users.service.1695machine # [ 83.737079] nixos[3306]: finished switching to system configuration /nix/store/vv33jhqzcnwazch710hagg7vjakb9bwl-nixos-system-machine-test1696machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 3.21 seconds)1697machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&11698machine # [ 84.370077] nixos[3448]: switching to system configuration /nix/store/bkbiqsmzsx6h2b6jygf0my2v3hq0kq92-nixos-system-machine-test1699machine # [ 84.373878] systemd[1]: Stopped target Local File Systems.1700machine # [ 84.375836] systemd[1]: Stopped target Remote File Systems.1701machine # [ 84.377305] systemd[1]: -.service: Deactivated successfully.1702machine # [ 84.378345] systemd[1]: Stopped -.service.1703machine # [ 84.948420] systemd[1]: Reload requested from client PID 3448 ('.switch-to-conf') (unit backdoor.service)...1704machine # [ 84.950524] systemd[1]: Reloading...1705machine # [ 85.677685] systemd[1]: Reloading finished in 724 ms.1706machine # [ 85.836843] systemd[576]: Reexecution requested from client PID 3517 ('switch-to-confi')...1707machine # [ 85.840468] systemd[576]: Reexecuting.1708machine # [ 85.899296] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1709machine # [ 86.106735] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1710machine # [ 86.114832] systemd[576]: Reload requested from client PID 3517 ('switch-to-confi')...1711machine # [ 86.118582] systemd[576]: Reloading...1712machine # [ 86.318650] systemd[576]: Reloading finished in 201 ms.1713machine # [ 86.332323] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1714machine # [ 86.344366] systemd[576]: Stopped Run user-specific NixOS activation.1715machine # [ 86.346800] systemd[576]: Stopping Run user-specific NixOS activation...1716machine # [ 86.350095] systemd[576]: Starting Run user-specific NixOS activation...1717machine # [ 86.403635] systemd[576]: Finished Run user-specific NixOS activation.1718machine # [ 86.409739] systemd[1]: Stopped target Reactivate sysinit units.1719machine # [ 86.410773] systemd[1]: Stopping Reactivate sysinit units...1720machine # [ 86.411667] systemd[1]: Reached target Reactivate sysinit units.1721machine # [ 86.414458] systemd[1]: Reached target Remote File Systems.1722machine # [ 86.423913] systemd[1]: Starting linger-users.service...1723machine # [ 86.428661] systemd[1]: Starting required-service.service...1724machine # [ 86.432997] systemd[1]: Starting test-service.service...1725machine # [ 86.444951] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1726machine # [ 86.446476] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1727machine # [ 86.461812] systemd[1]: Reached target Local File Systems.1728machine # [ 86.468135] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1729machine # [ 86.480226] systemd[1]: Starting Create SUID/SGID Wrappers...1730machine # [ 86.481192] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1731machine # [ 86.482472] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671732machine # [ 86.496169] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1733machine # [ 86.502103] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1734machine # [ 86.505692] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1735machine # [ 86.544998] systemd[1]: Finished test-service.service.1736machine # [ 86.552810] systemd[1]: Finished required-service.service.1737machine # [ 86.598626] systemd[1]: linger-users.service: Deactivated successfully.1738machine # [ 86.603440] systemd[1]: Finished linger-users.service.1739machine # [ 86.911156] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1740machine # [ 86.914599] systemd[1]: Finished Create SUID/SGID Wrappers.1741machine # [ 87.174470] nixos[3448]: finished switching to system configuration /nix/store/bkbiqsmzsx6h2b6jygf0my2v3hq0kq92-nixos-system-machine-test1742machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 3.44 seconds)1743machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&11744machine # [ 87.883809] nixos[3592]: switching to system configuration /nix/store/913iag4853b91jy3w35yvzmb7nx6dysb-nixos-system-machine-test1745machine # [ 87.888628] systemd[1]: Stopped target Local File Systems.1746machine # [ 87.890966] systemd[1]: Stopped target Remote File Systems.1747machine # [ 87.891946] systemd[1]: required-service.service: Deactivated successfully.1748machine # [ 87.894027] systemd[1]: Stopped required-service.service.1749machine # [ 87.895020] systemd[1]: test-service.service: Deactivated successfully.1750machine # [ 87.896358] systemd[1]: Stopped test-service.service.1751machine # [ 88.446121] systemd[1]: Reload requested from client PID 3592 ('.switch-to-conf') (unit backdoor.service)...1752machine # [ 88.448252] systemd[1]: Reloading...1753machine # [ 89.151240] systemd[1]: Reloading finished in 700 ms.1754machine # [ 89.294755] systemd[576]: Reexecution requested from client PID 3661 ('switch-to-confi')...1755machine # [ 89.298935] systemd[576]: Reexecuting.1756machine # [ 89.357998] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1757machine # [ 89.555963] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1758machine # [ 89.562599] systemd[576]: Reload requested from client PID 3661 ('switch-to-confi')...1759machine # [ 89.565247] systemd[576]: Reloading...1760machine # [ 89.759103] systemd[576]: Reloading finished in 192 ms.1761machine # [ 89.772187] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1762machine # [ 89.782678] systemd[576]: Stopped Run user-specific NixOS activation.1763machine # [ 89.785246] systemd[576]: Stopping Run user-specific NixOS activation...1764machine # [ 89.788309] systemd[576]: Starting Run user-specific NixOS activation...1765machine # [ 89.834408] systemd[576]: Finished Run user-specific NixOS activation.1766machine # [ 89.838716] systemd[1]: Stopped target Reactivate sysinit units.1767machine # [ 89.840705] systemd[1]: Stopping Reactivate sysinit units...1768machine # [ 89.841697] systemd[1]: Reached target Reactivate sysinit units.1769machine # [ 89.848373] systemd[1]: Reached target Remote File Systems.1770machine # [ 89.851943] systemd[1]: Reached target Local File Systems.1771machine # [ 89.855242] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1772machine # [ 89.859413] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1773machine # [ 89.863857] systemd[1]: Starting linger-users.service...1774machine # [ 89.867752] systemd[1]: Starting required-service.service...1775machine # [ 89.872864] systemd[1]: Starting test-service.service...1776machine # [ 89.881137] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1777machine # [ 89.892691] systemd[1]: Starting Create SUID/SGID Wrappers...1778machine # [ 89.895234] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1779machine # [ 89.902321] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671780machine # [ 89.907403] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1781machine # [ 89.912558] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1782machine # [ 89.914639] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1783machine # [ 89.956511] systemd[1]: Finished required-service.service.1784machine # [ 89.960628] systemd[1]: Finished test-service.service.1785machine # [ 89.994767] systemd[1]: linger-users.service: Deactivated successfully.1786machine # [ 89.997885] systemd[1]: Finished linger-users.service.1787machine # [ 90.278501] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1788machine # [ 90.281768] systemd[1]: Finished Create SUID/SGID Wrappers.1789machine # [ 90.538591] nixos[3592]: finished switching to system configuration /nix/store/913iag4853b91jy3w35yvzmb7nx6dysb-nixos-system-machine-test1790machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 3.37 seconds)1791machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&11792machine # [ 91.186545] nixos[3736]: switching to system configuration /nix/store/gfzxmp4fljp663i5pjiy51k6j7j2jxjy-nixos-system-machine-test1793machine # [ 91.190408] systemd[1]: Stopped target Local File Systems.1794machine # [ 91.192555] systemd[1]: Stopped target Remote File Systems.1795machine # [ 91.193381] systemd[1]: required-service.service: Deactivated successfully.1796machine # [ 91.194295] systemd[1]: Stopped required-service.service.1797machine # [ 91.195028] systemd[1]: test-service.service: Deactivated successfully.1798machine # [ 91.195895] systemd[1]: Stopped test-service.service.1799machine # [ 91.702632] systemd[1]: Reload requested from client PID 3736 ('.switch-to-conf') (unit backdoor.service)...1800machine # [ 91.704718] systemd[1]: Reloading...1801machine # [ 92.357817] systemd[1]: Reloading finished in 651 ms.1802machine # [ 92.503012] systemd[576]: Reexecution requested from client PID 3805 ('switch-to-confi')...1803machine # [ 92.506605] systemd[576]: Reexecuting.1804machine # [ 92.545567] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1805machine # [ 92.744853] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1806machine # [ 92.751672] systemd[576]: Reload requested from client PID 3805 ('switch-to-confi')...1807machine # [ 92.756045] systemd[576]: Reloading...1808machine # [ 92.960075] systemd[576]: Reloading finished in 205 ms.1809machine # [ 92.972190] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1810machine # [ 92.983724] systemd[576]: Stopped Run user-specific NixOS activation.1811machine # [ 92.986349] systemd[576]: Stopping Run user-specific NixOS activation...1812machine # [ 92.989574] systemd[576]: Starting Run user-specific NixOS activation...1813machine # [ 93.040376] systemd[576]: Finished Run user-specific NixOS activation.1814machine # [ 93.045015] systemd[1]: Stopped target Reactivate sysinit units.1815machine # [ 93.047131] systemd[1]: Stopping Reactivate sysinit units...1816machine # [ 93.048971] systemd[1]: Reached target Reactivate sysinit units.1817machine # [ 93.052382] systemd[1]: Reached target Remote File Systems.1818machine # [ 93.057550] systemd[1]: Starting linger-users.service...1819machine # [ 93.063460] systemd[1]: Starting required-service.service...1820machine # [ 93.069741] systemd[1]: Starting test-service.service...1821machine # [ 93.083778] systemd[1]: Reached target Local File Systems.1822machine # [ 93.088815] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1823machine # [ 93.091780] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1824machine # [ 93.104185] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1825machine # [ 93.111632] systemd[1]: Starting Create SUID/SGID Wrappers...1826machine # [ 93.117374] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1827machine # [ 93.120370] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671828machine # [ 93.128130] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1829machine # [ 93.132107] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1830machine # [ 93.135565] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1831machine # [ 93.163803] systemd[1]: Finished required-service.service.1832machine # [ 93.168884] systemd[1]: Finished test-service.service.1833machine # [ 93.208092] systemd[1]: linger-users.service: Deactivated successfully.1834machine # [ 93.212151] systemd[1]: Finished linger-users.service.1835machine # [ 93.499703] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1836machine # [ 93.503109] systemd[1]: Finished Create SUID/SGID Wrappers.1837machine # [ 93.762245] nixos[3736]: finished switching to system configuration /nix/store/gfzxmp4fljp663i5pjiy51k6j7j2jxjy-nixos-system-machine-test1838machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 3.22 seconds)1839machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&11840machine # [ 94.427922] nixos[3880]: switching to system configuration /nix/store/ybgcrhrcg06mb3ayhnk6syr865c70hv5-nixos-system-machine-test1841machine # [ 94.432783] systemd[1]: Stopped target Local File Systems.1842machine # [ 94.435729] systemd[1]: Stopped target Remote File Systems.1843machine # [ 94.437002] systemd[1]: required-service.service: Deactivated successfully.1844machine # [ 94.438297] systemd[1]: Stopped required-service.service.1845machine # [ 94.439263] systemd[1]: test-service.service: Deactivated successfully.1846machine # [ 94.440296] systemd[1]: Stopped test-service.service.1847machine # [ 94.972213] systemd[1]: Reload requested from client PID 3880 ('.switch-to-conf') (unit backdoor.service)...1848machine # [ 94.974183] systemd[1]: Reloading...1849machine # [ 95.678577] systemd[1]: Reloading finished in 702 ms.1850machine # [ 95.835623] systemd[576]: Reexecution requested from client PID 3949 ('switch-to-confi')...1851machine # [ 95.840675] systemd[576]: Reexecuting.1852machine # [ 95.898564] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1853machine # [ 96.098699] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1854machine # [ 96.105668] systemd[576]: Reload requested from client PID 3949 ('switch-to-confi')...1855machine # [ 96.108476] systemd[576]: Reloading...1856machine # [ 96.309798] systemd[576]: Reloading finished in 200 ms.1857machine # [ 96.324189] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1858machine # [ 96.335676] systemd[576]: Stopped Run user-specific NixOS activation.1859machine # [ 96.338102] systemd[576]: Stopping Run user-specific NixOS activation...1860machine # [ 96.341045] systemd[576]: Starting Run user-specific NixOS activation...1861machine # [ 96.391956] systemd[576]: Finished Run user-specific NixOS activation.1862machine # [ 96.396624] systemd[1]: Stopped target Reactivate sysinit units.1863machine # [ 96.397621] systemd[1]: Stopping Reactivate sysinit units...1864machine # [ 96.398405] systemd[1]: Reached target Reactivate sysinit units.1865machine # [ 96.402133] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1866machine # [ 96.406568] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1867machine # [ 96.408692] systemd[1]: Reached target Remote File Systems.1868machine # [ 96.411530] systemd[1]: Reached target Local File Systems.1869machine # [ 96.415294] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1870machine # [ 96.419574] systemd[1]: Starting Create SUID/SGID Wrappers...1871machine # [ 96.421623] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1872machine # [ 96.424892] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671873machine # [ 96.436322] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1874machine # [ 96.437968] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1875machine # [ 96.439183] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1876machine # [ 96.442580] systemd[1]: Created slice Slice /system/instantiated.1877machine # [ 96.769228] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1878machine # [ 96.772821] systemd[1]: Finished Create SUID/SGID Wrappers.1879machine # [ 96.777861] systemd[1]: Starting instantiated@one.service...1880machine # [ 96.781944] systemd[1]: Starting instantiated@two.service...1881machine # [ 96.785121] systemd[1]: Starting linger-users.service...1882machine # [ 96.842797] systemd[1]: Finished instantiated@one.service.1883machine # [ 96.843779] systemd[1]: Finished instantiated@two.service.1884machine # [ 96.869495] systemd[1]: linger-users.service: Deactivated successfully.1885machine # [ 96.872501] systemd[1]: Finished linger-users.service.1886machine # [ 97.130841] nixos[3880]: finished switching to system configuration /nix/store/ybgcrhrcg06mb3ayhnk6syr865c70hv5-nixos-system-machine-test1887machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 3.37 seconds)1888machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&11889machine # [ 97.831528] nixos[4024]: switching to system configuration /nix/store/fn47b9f78fk8lr36d2pg5ibc495r8ryr-nixos-system-machine-test1890machine # [ 97.837413] systemd[1]: Stopped target Local File Systems.1891machine # [ 97.838284] systemd[1]: Stopped target Remote File Systems.1892machine # [ 97.839105] systemd[1]: instantiated@one.service: Deactivated successfully.1893machine # [ 97.840801] systemd[1]: Stopped instantiated@one.service.1894machine # [ 97.841702] systemd[1]: instantiated@two.service: Deactivated successfully.1895machine # [ 97.842766] systemd[1]: Stopped instantiated@two.service.1896machine # [ 98.364460] systemd[1]: Reload requested from client PID 4024 ('.switch-to-conf') (unit backdoor.service)...1897machine # [ 98.366430] systemd[1]: Reloading...1898machine # [ 99.043166] systemd[1]: Reloading finished in 674 ms.1899machine # [ 99.199466] systemd[576]: Reexecution requested from client PID 4093 ('switch-to-confi')...1900machine # [ 99.203766] systemd[576]: Reexecuting.1901machine # [ 99.266546] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1902machine # [ 99.467867] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1903machine # [ 99.475901] systemd[576]: Reload requested from client PID 4093 ('switch-to-confi')...1904machine # [ 99.477907] systemd[576]: Reloading...1905machine # [ 99.673536] systemd[576]: Reloading finished in 194 ms.1906machine # [ 99.684184] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1907machine # [ 99.694026] systemd[576]: Stopped Run user-specific NixOS activation.1908machine # [ 99.696433] systemd[576]: Stopping Run user-specific NixOS activation...1909machine # [ 99.699361] systemd[576]: Starting Run user-specific NixOS activation...1910machine # [ 99.745801] systemd[576]: Finished Run user-specific NixOS activation.1911machine # [ 99.749942] systemd[1]: Stopped target Reactivate sysinit units.1912machine # [ 99.751991] systemd[1]: Stopping Reactivate sysinit units...1913machine # [ 99.754437] systemd[1]: Reached target Reactivate sysinit units.1914machine # [ 99.755298] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1915machine # [ 99.757836] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1916machine # [ 99.760646] systemd[1]: Reached target Remote File Systems.1917machine # [ 99.766865] systemd[1]: Starting instantiated@one.service...1918machine # [ 99.770597] systemd[1]: Starting instantiated@two.service...1919machine # [ 99.774062] systemd[1]: Starting linger-users.service...1920machine # [ 99.779649] systemd[1]: Reached target Local File Systems.1921machine # [ 99.795928] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1922machine # [ 99.802273] systemd[1]: Starting Create SUID/SGID Wrappers...1923machine # [ 99.808084] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1924machine # [ 99.816321] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671925machine # [ 99.819644] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1926machine # [ 99.825810] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1927machine # [ 99.829828] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1928machine # [ 99.865189] systemd[1]: Finished instantiated@one.service.1929machine # [ 99.868436] systemd[1]: Finished instantiated@two.service.1930machine # [ 99.904685] systemd[1]: linger-users.service: Deactivated successfully.1931machine # [ 99.908238] systemd[1]: Finished linger-users.service.1932machine # [ 100.173237] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1933machine # [ 100.176875] systemd[1]: Finished Create SUID/SGID Wrappers.1934machine # [ 100.435853] nixos[4024]: finished switching to system configuration /nix/store/fn47b9f78fk8lr36d2pg5ibc495r8ryr-nixos-system-machine-test1935machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 3.30 seconds)1936(finished: subtest: services, in 72.67 seconds)1937subtest: failing units1938machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11939machine # [ 101.059263] nixos[4168]: switching to system configuration /nix/store/fc9vv51r37nmsfcdlr91j5hw1qh4ig2x-nixos-system-machine-test1940machine # [ 101.061878] systemd[1]: Stopped target Remote File Systems.1941machine # [ 101.065840] systemd[1]: instantiated@one.service: Deactivated successfully.1942machine # [ 101.066875] systemd[1]: Stopped instantiated@one.service.1943machine # [ 101.067635] systemd[1]: instantiated@two.service: Deactivated successfully.1944machine # [ 101.069061] systemd[1]: Stopped instantiated@two.service.1945machine # [ 101.070010] systemd[1]: Stopped target Local File Systems.1946machine # [ 101.533036] systemd[1]: Reload requested from client PID 4168 ('.switch-to-conf') (unit backdoor.service)...1947machine # [ 101.535111] systemd[1]: Reloading...1948machine # [ 102.155688] systemd[1]: Reloading finished in 618 ms.1949machine # [ 102.302443] systemd[576]: Reexecution requested from client PID 4237 ('switch-to-confi')...1950machine # [ 102.306526] systemd[576]: Reexecuting.1951machine # [ 102.362006] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1952machine # [ 102.554984] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1953machine # [ 102.562589] systemd[576]: Reload requested from client PID 4237 ('switch-to-confi')...1954machine # [ 102.563916] systemd[576]: Reloading...1955machine # [ 102.757197] systemd[576]: Reloading finished in 191 ms.1956machine # [ 102.772169] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1957machine # [ 102.783208] systemd[576]: Stopped Run user-specific NixOS activation.1958machine # [ 102.784356] systemd[576]: Stopping Run user-specific NixOS activation...1959machine # [ 102.787386] systemd[576]: Starting Run user-specific NixOS activation...1960machine # [ 102.834861] systemd[576]: Finished Run user-specific NixOS activation.1961machine # [ 102.839433] systemd[1]: Stopped target Reactivate sysinit units.1962machine # [ 102.842223] systemd[1]: Stopping Reactivate sysinit units...1963machine # [ 102.843088] systemd[1]: Reached target Reactivate sysinit units.1964machine # [ 102.845486] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1965machine # [ 102.846829] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1966machine # [ 102.851035] systemd[1]: Reached target Remote File Systems.1967machine # [ 102.857513] systemd[1]: Starting linger-users.service...1968machine # [ 102.860869] systemd[1]: Starting test.service...1969machine # [ 102.865960] systemd[1]: Reached target Local File Systems.1970machine # [ 102.866864] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1971machine # [ 102.880462] systemd[1]: Starting Create SUID/SGID Wrappers...1972machine # [ 102.881367] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1973machine # [ 102.882562] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671974machine # [ 102.899288] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1975machine # [ 102.902253] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1976machine # [ 102.904508] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1977machine # [ 102.938757] systemd[1]: Finished test.service.1978machine # [ 102.973305] systemd[1]: linger-users.service: Deactivated successfully.1979machine # [ 102.975145] systemd[1]: Finished linger-users.service.1980machine # [ 103.247737] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1981machine # [ 103.250560] systemd[1]: Finished Create SUID/SGID Wrappers.1982machine # [ 103.511334] nixos[4168]: finished switching to system configuration /nix/store/fc9vv51r37nmsfcdlr91j5hw1qh4ig2x-nixos-system-machine-test1983machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 3.07 seconds)1984machine: must fail: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&11985machine # [ 104.189860] nixos[4310]: switching to system configuration /nix/store/m7fz9b68jpla2xygg7329vc7c1bxakcv-nixos-system-machine-test1986machine # [ 104.194248] systemd[1]: Stopped target Local File Systems.1987machine # [ 104.196760] systemd[1]: Stopped target Remote File Systems.1988machine # [ 104.197759] systemd[1]: test.service: Deactivated successfully.1989machine # [ 104.198751] systemd[1]: Stopped test.service.1990machine # [ 104.706413] systemd[1]: Reload requested from client PID 4310 ('.switch-to-conf') (unit backdoor.service)...1991machine # [ 104.708469] systemd[1]: Reloading...1992machine # [ 105.362553] systemd[1]: Reloading finished in 651 ms.1993machine # [ 105.509581] systemd[576]: Reexecution requested from client PID 4379 ('switch-to-confi')...1994machine # [ 105.514476] systemd[576]: Reexecuting.1995machine # [ 105.574000] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1996machine # [ 105.767205] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1997machine # [ 105.774796] systemd[576]: Reload requested from client PID 4379 ('switch-to-confi')...1998machine # [ 105.776435] systemd[576]: Reloading...1999machine # [ 105.964795] systemd[576]: Reloading finished in 186 ms.2000machine # [ 105.980160] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2001machine # [ 105.990329] systemd[576]: Stopped Run user-specific NixOS activation.2002machine # [ 105.991330] systemd[576]: Stopping Run user-specific NixOS activation...2003machine # [ 105.994136] systemd[576]: Starting Run user-specific NixOS activation...2004machine # [ 106.040972] systemd[576]: Finished Run user-specific NixOS activation.2005machine # [ 106.045144] systemd[1]: Stopped target Reactivate sysinit units.2006machine # [ 106.046069] systemd[1]: Stopping Reactivate sysinit units...2007machine # [ 106.046868] systemd[1]: Reached target Reactivate sysinit units.2008machine # [ 106.054587] systemd[1]: Starting test.service...2009machine # [ 106.056203] systemd[1]: Reached target Remote File Systems.2010machine # [ 106.065123] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2011machine # [ 106.066493] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2012machine # [ 106.080157] systemd[1]: Starting linger-users.service...2013machine # [ 106.088335] systemd[1]: Reached target Local File Systems.2014machine # [ 106.095202] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2015machine # [ 106.100358] systemd[1]: Starting Create SUID/SGID Wrappers...2016machine # [ 106.101299] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2017machine # [ 106.102514] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672018machine # [ 106.105175] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2019machine # [ 106.106971] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2020machine # [ 106.110574] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2021machine # [ 106.135091] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE2022machine # [ 106.137970] systemd[1]: test.service: Failed with result 'exit-code'.2023machine # [ 106.140187] systemd[1]: Failed to start test.service.2024machine # [ 106.187038] systemd[1]: linger-users.service: Deactivated successfully.2025machine # [ 106.190217] systemd[1]: Finished linger-users.service.2026machine # [ 106.455619] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2027machine # [ 106.458857] systemd[1]: Finished Create SUID/SGID Wrappers.2028machine # [ 106.780505] nixos[4310]: switching to system configuration /nix/store/m7fz9b68jpla2xygg7329vc7c1bxakcv-nixos-system-machine-test failed (status 4)2029machine: (finished: must fail: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 3.27 seconds)2030machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12031machine # [ 107.411735] nixos[4453]: switching to system configuration /nix/store/w7kj494w1bgh073cizrkbgirrx7jns3m-nixos-system-machine-test2032machine # [ 107.414287] systemd[1]: Stopped target Local File Systems.2033machine # [ 107.416593] systemd[1]: Stopped target Remote File Systems.2034machine # [ 107.919771] systemd[1]: Reload requested from client PID 4453 ('.switch-to-conf') (unit backdoor.service)...2035machine # [ 107.921837] systemd[1]: Reloading...2036machine # [ 108.526132] systemd[1]: Reloading finished in 602 ms.2037machine # [ 108.673852] systemd[576]: Reexecution requested from client PID 4522 ('switch-to-confi')...2038machine # [ 108.678116] systemd[576]: Reexecuting.2039machine # [ 108.743632] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2040machine # [ 108.951927] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2041machine # [ 108.960216] systemd[576]: Reload requested from client PID 4522 ('switch-to-confi')...2042machine # [ 108.961716] systemd[576]: Reloading...2043machine # [ 109.159124] systemd[576]: Reloading finished in 195 ms.2044machine # [ 109.173730] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2045machine # [ 109.182863] systemd[576]: Stopped Run user-specific NixOS activation.2046machine # [ 109.185593] systemd[576]: Stopping Run user-specific NixOS activation...2047machine # [ 109.189104] systemd[576]: Starting Run user-specific NixOS activation...2048machine # [ 109.238822] systemd[576]: Finished Run user-specific NixOS activation.2049machine # [ 109.243395] systemd[1]: Stopped target Reactivate sysinit units.2050machine # [ 109.245897] systemd[1]: Stopping Reactivate sysinit units...2051machine # [ 109.246733] systemd[1]: Reached target Reactivate sysinit units.2052machine # [ 109.249598] systemd[1]: Reached target Remote File Systems.2053machine # [ 109.253689] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2054machine # [ 109.256759] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2055machine # [ 109.261068] systemd[1]: Reached target Local File Systems.2056machine # [ 109.261902] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2057machine # [ 109.267842] systemd[1]: Starting Create SUID/SGID Wrappers...2058machine # [ 109.271488] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2059machine # [ 109.275102] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672060machine # [ 109.281114] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2061machine # [ 109.282792] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2062machine # [ 109.286066] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2063machine # [ 109.603254] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2064machine # [ 109.605559] systemd[1]: Finished Create SUID/SGID Wrappers.2065machine # [ 109.612539] systemd[1]: Started autorestart.service.2066machine # [ 109.615211] systemd[1]: Starting linger-users.service...2067machine # [ 109.663169] systemd[1]: autorestart.service: Deactivated successfully.2068machine # [ 109.690180] systemd[1]: linger-users.service: Deactivated successfully.2069machine # [ 109.693281] systemd[1]: Finished linger-users.service.2070machine # [ 109.952583] nixos[4453]: finished switching to system configuration /nix/store/w7kj494w1bgh073cizrkbgirrx7jns3m-nixos-system-machine-test2071machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 3.17 seconds)2072machine # [ 110.034587] systemd[1]: Stopped autorestart.service.2073machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12074machine # [ 110.634651] nixos[4600]: switching to system configuration /nix/store/w7kj494w1bgh073cizrkbgirrx7jns3m-nixos-system-machine-test2075machine # [ 110.637496] systemd[1]: Stopped target Local File Systems.2076machine # [ 110.639847] systemd[1]: Stopped target Remote File Systems.2077machine # [ 111.115640] systemd[1]: Reload requested from client PID 4600 ('.switch-to-conf') (unit backdoor.service)...2078machine # [ 111.117991] systemd[1]: Reloading...2079machine # [ 111.732261] systemd[1]: Reloading finished in 611 ms.2080machine # [ 111.878778] systemd[576]: Reexecution requested from client PID 4669 ('switch-to-confi')...2081machine # [ 111.883153] systemd[576]: Reexecuting.2082machine # [ 111.942072] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2083machine # [ 112.142181] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2084machine # [ 112.149495] systemd[576]: Reload requested from client PID 4669 ('switch-to-confi')...2085machine # [ 112.151989] systemd[576]: Reloading...2086machine # [ 112.347227] systemd[576]: Reloading finished in 193 ms.2087machine # [ 112.360168] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2088machine # [ 112.371464] systemd[576]: Stopped Run user-specific NixOS activation.2089machine # [ 112.373980] systemd[576]: Stopping Run user-specific NixOS activation...2090machine # [ 112.377085] systemd[576]: Starting Run user-specific NixOS activation...2091machine # [ 112.425233] systemd[576]: Finished Run user-specific NixOS activation.2092machine # [ 112.429360] systemd[1]: Stopped target Reactivate sysinit units.2093machine # [ 112.430610] systemd[1]: Stopping Reactivate sysinit units...2094machine # [ 112.431445] systemd[1]: Reached target Reactivate sysinit units.2095machine # [ 112.434030] systemd[1]: Reached target Remote File Systems.2096machine # [ 112.438816] systemd[1]: Reached target Local File Systems.2097machine # [ 112.442280] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2098machine # [ 112.446628] systemd[1]: Starting Create SUID/SGID Wrappers...2099machine # [ 112.447537] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2100machine # [ 112.456543] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672101machine # [ 112.459152] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2102machine # [ 112.462920] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2103machine # [ 112.466915] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2104machine # [ 112.470127] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2105machine # [ 112.471571] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2106machine # [ 112.779433] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2107machine # [ 112.781926] systemd[1]: Finished Create SUID/SGID Wrappers.2108machine # [ 112.788539] systemd[1]: Started autorestart.service.2109machine # [ 112.792743] systemd[1]: Starting linger-users.service...2110machine # [ 112.835852] systemd[1]: autorestart.service: Deactivated successfully.2111machine # [ 112.863914] systemd[1]: linger-users.service: Deactivated successfully.2112machine # [ 112.866419] systemd[1]: Finished linger-users.service.2113machine # [ 113.127060] nixos[4600]: finished switching to system configuration /nix/store/w7kj494w1bgh073cizrkbgirrx7jns3m-nixos-system-machine-test2114machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 3.09 seconds)2115machine # [ 113.209574] systemd[1]: Stopped autorestart.service.2116machine: must fail: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&12117machine # [ 113.767293] nixos[4747]: switching to system configuration /nix/store/dwigrjch6aw43yb0pvg8wzj0sicjhzmn-nixos-system-machine-test2118machine # [ 113.769871] systemd[1]: Stopped target Remote File Systems.2119machine # [ 113.772256] systemd[1]: Stopped target Local File Systems.2120machine # [ 114.269091] systemd[1]: Reload requested from client PID 4747 ('.switch-to-conf') (unit backdoor.service)...2121machine # [ 114.271081] systemd[1]: Reloading...2122machine # [ 114.934239] systemd[1]: Reloading finished in 659 ms.2123machine # [ 115.083387] systemd[576]: Reexecution requested from client PID 4816 ('switch-to-confi')...2124machine # [ 115.086993] systemd[576]: Reexecuting.2125machine # [ 115.149947] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2126machine # [ 115.343080] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2127machine # [ 115.350278] systemd[576]: Reload requested from client PID 4816 ('switch-to-confi')...2128machine # [ 115.352062] systemd[576]: Reloading...2129machine # [ 115.532679] systemd[576]: Reloading finished in 179 ms.2130machine # [ 115.548153] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2131machine # [ 115.558115] systemd[576]: Stopped Run user-specific NixOS activation.2132machine # [ 115.560474] systemd[576]: Stopping Run user-specific NixOS activation...2133machine # [ 115.563253] systemd[576]: Starting Run user-specific NixOS activation...2134machine # [ 115.608684] systemd[576]: Finished Run user-specific NixOS activation.2135machine # [ 115.613010] systemd[1]: Stopped target Reactivate sysinit units.2136machine # [ 115.615440] systemd[1]: Stopping Reactivate sysinit units...2137machine # [ 115.617158] systemd[1]: Reached target Reactivate sysinit units.2138machine # [ 115.620399] systemd[1]: Reached target Local File Systems.2139machine # [ 115.621278] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2140machine # [ 115.627076] systemd[1]: Starting Create SUID/SGID Wrappers...2141machine # [ 115.630586] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2142machine # [ 115.631912] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672143machine # [ 115.641375] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2144machine # [ 115.647166] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2145machine # [ 115.648915] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2146machine # [ 115.650319] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2147machine # [ 115.651584] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2148machine # [ 115.653313] systemd[1]: Reached target Remote File Systems.2149machine # [ 115.973077] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2150machine # [ 115.976699] systemd[1]: Finished Create SUID/SGID Wrappers.2151machine # [ 115.982255] systemd[1]: Started autorestart.service.2152machine # [ 115.985359] systemd[1]: Starting linger-users.service...2153machine # [ 116.024133] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE2154machine # [ 116.028256] systemd[1]: autorestart.service: Failed with result 'exit-code'.2155machine # [ 116.053527] systemd[1]: linger-users.service: Deactivated successfully.2156machine # [ 116.056414] systemd[1]: Finished linger-users.service.2157machine # [ 116.382803] nixos[4747]: switching to system configuration /nix/store/dwigrjch6aw43yb0pvg8wzj0sicjhzmn-nixos-system-machine-test failed (status 4)2158machine: (finished: must fail: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 3.18 seconds)2159(finished: subtest: failing units, in 15.95 seconds)2160subtest: unit file parser2161machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12162machine # [ 116.980068] nixos[4890]: switching to system configuration /nix/store/q4hqx9aiw9lpsqrdz9v39nigfilgnwpv-nixos-system-machine-test2163machine # [ 116.983094] systemd[1]: Stopped autorestart.service.2164machine # [ 116.985168] systemd[1]: Stopped target Remote File Systems.2165machine # [ 116.987600] systemd[1]: Stopped target Local File Systems.2166machine # [ 117.429148] systemd[1]: Reload requested from client PID 4890 ('.switch-to-conf') (unit backdoor.service)...2167machine # [ 117.431099] systemd[1]: Reloading...2168machine # [ 118.005937] systemd[1]: Reloading finished in 572 ms.2169machine # [ 118.141895] systemd[576]: Reexecution requested from client PID 4959 ('switch-to-confi')...2170machine # [ 118.145691] systemd[576]: Reexecuting.2171machine # [ 118.201360] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2172machine # [ 118.384907] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2173machine # [ 118.391646] systemd[576]: Reload requested from client PID 4959 ('switch-to-confi')...2174machine # [ 118.393947] systemd[576]: Reloading...2175machine # [ 118.576193] systemd[576]: Reloading finished in 181 ms.2176machine # [ 118.592139] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2177machine # [ 118.600589] systemd[576]: Stopped Run user-specific NixOS activation.2178machine # [ 118.602614] systemd[576]: Stopping Run user-specific NixOS activation...2179machine # [ 118.605313] systemd[576]: Starting Run user-specific NixOS activation...2180machine # [ 118.646850] systemd[576]: Finished Run user-specific NixOS activation.2181machine # [ 118.650597] systemd[1]: Stopped target Reactivate sysinit units.2182machine # [ 118.653767] systemd[1]: Stopping Reactivate sysinit units...2183machine # [ 118.654612] systemd[1]: Reached target Reactivate sysinit units.2184machine # [ 118.656898] systemd[1]: Reached target Local File Systems.2185machine # [ 118.659663] systemd[1]: Reached target Remote File Systems.2186machine # [ 118.661518] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2187machine # [ 118.666786] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2188machine # [ 118.668331] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2189machine # [ 118.671696] systemd[1]: Starting Create SUID/SGID Wrappers...2190machine # [ 118.674441] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2191machine # [ 118.680556] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672192machine # [ 118.682714] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2193machine # [ 118.686285] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2194machine # [ 118.687564] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2195machine # [ 118.992953] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2196machine # [ 118.996610] systemd[1]: Finished Create SUID/SGID Wrappers.2197machine # [ 119.000346] systemd[1]: Starting linger-users.service...2198machine # [ 119.003933] systemd[1]: Starting test.service...2199machine # [ 119.047619] systemd[1]: Finished test.service.2200machine # [ 119.073570] systemd[1]: linger-users.service: Deactivated successfully.2201machine # [ 119.075772] systemd[1]: Finished linger-users.service.2202machine # [ 119.333958] nixos[4890]: finished switching to system configuration /nix/store/q4hqx9aiw9lpsqrdz9v39nigfilgnwpv-nixos-system-machine-test2203machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.95 seconds)2204machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&12205machine # [ 119.977222] nixos[5032]: switching to system configuration /nix/store/p8vchhc5sm8k0hkq5x3l5wp0v8c4sn2f-nixos-system-machine-test2206machine # [ 119.979703] systemd[1]: Stopped target Local File Systems.2207machine # [ 119.981945] systemd[1]: Stopped target Remote File Systems.2208machine # [ 120.484071] systemd[1]: Reload requested from client PID 5032 ('.switch-to-conf') (unit backdoor.service)...2209machine # [ 120.485991] systemd[1]: Reloading...2210machine # [ 121.122334] systemd[1]: Reloading finished in 634 ms.2211machine # [ 121.280281] systemd[576]: Reexecution requested from client PID 5101 ('switch-to-confi')...2212machine # [ 121.284178] systemd[576]: Reexecuting.2213machine # [ 121.329298] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2214machine # [ 121.523299] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2215machine # [ 121.530012] systemd[576]: Reload requested from client PID 5101 ('switch-to-confi')...2216machine # [ 121.532458] systemd[576]: Reloading...2217machine # [ 121.720284] systemd[576]: Reloading finished in 186 ms.2218machine # [ 121.737563] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2219machine # [ 121.745269] systemd[576]: Stopped Run user-specific NixOS activation.2220machine # [ 121.747638] systemd[576]: Stopping Run user-specific NixOS activation...2221machine # [ 121.750494] systemd[576]: Starting Run user-specific NixOS activation...2222machine # [ 121.794861] systemd[576]: Finished Run user-specific NixOS activation.2223machine # [ 121.799006] systemd[1]: Stopped target Reactivate sysinit units.2224machine # [ 121.800999] systemd[1]: Stopping Reactivate sysinit units...2225machine # [ 121.804789] systemd[1]: Reached target Reactivate sysinit units.2226machine # [ 121.805975] systemd[1]: test.service: Deactivated successfully.2227machine # [ 121.808287] systemd[1]: Stopped test.service.2228machine # [ 121.808967] systemd[1]: Stopping test.service...2229machine # [ 121.809599] systemd[1]: Starting test.service...2230machine # [ 121.843640] systemd[1]: Finished test.service.2231machine # [ 121.851466] systemd[1]: Reached target Local File Systems.2232machine # [ 121.854760] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2233machine # [ 121.858604] systemd[1]: Starting Create SUID/SGID Wrappers...2234machine # [ 121.859475] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2235machine # [ 121.862484] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672236machine # [ 121.872559] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2237machine # [ 121.874093] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2238machine # [ 121.875303] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2239machine # [ 121.878258] systemd[1]: Reached target Remote File Systems.2240machine # [ 121.879032] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2241machine # [ 121.880334] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2242machine # [ 122.181015] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2243machine # [ 122.184641] systemd[1]: Finished Create SUID/SGID Wrappers.2244machine # [ 122.187584] systemd[1]: Starting linger-users.service...2245machine # [ 122.246418] systemd[1]: linger-users.service: Deactivated successfully.2246machine # [ 122.248188] systemd[1]: Finished linger-users.service.2247machine # [ 122.507074] nixos[5032]: finished switching to system configuration /nix/store/p8vchhc5sm8k0hkq5x3l5wp0v8c4sn2f-nixos-system-machine-test2248machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 3.18 seconds)2249machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&12250machine # [ 123.175076] nixos[5174]: switching to system configuration /nix/store/jlwbh1q28i9w1g8jal9c6mlvwy5r3hhs-nixos-system-machine-test2251machine # [ 123.178437] systemd[1]: Stopped target Local File Systems.2252machine # [ 123.179777] systemd[1]: Stopped target Remote File Systems.2253machine # [ 123.714553] systemd[1]: Reload requested from client PID 5174 ('.switch-to-conf') (unit backdoor.service)...2254machine # [ 123.716762] systemd[1]: Reloading...2255machine # [ 124.381694] systemd[1]: Reloading finished in 662 ms.2256machine # [ 124.544293] systemd[576]: Reexecution requested from client PID 5243 ('switch-to-confi')...2257machine # [ 124.545694] systemd[576]: Reexecuting.2258machine # [ 124.606038] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2259machine # [ 124.804968] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2260machine # [ 124.811612] systemd[576]: Reload requested from client PID 5243 ('switch-to-confi')...2261machine # [ 124.813780] systemd[576]: Reloading...2262machine # [ 125.007820] systemd[576]: Reloading finished in 193 ms.2263machine # [ 125.024144] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2264machine # [ 125.034561] systemd[576]: Stopped Run user-specific NixOS activation.2265machine # [ 125.035584] systemd[576]: Stopping Run user-specific NixOS activation...2266machine # [ 125.038426] systemd[576]: Starting Run user-specific NixOS activation...2267machine # [ 125.087282] systemd[576]: Finished Run user-specific NixOS activation.2268machine # [ 125.091548] systemd[1]: Stopped target Reactivate sysinit units.2269machine # [ 125.093474] systemd[1]: Stopping Reactivate sysinit units...2270machine # [ 125.094274] systemd[1]: Reached target Reactivate sysinit units.2271machine # [ 125.097996] systemd[1]: test.service: Deactivated successfully.2272machine # [ 125.098865] systemd[1]: Stopped test.service.2273machine # [ 125.099497] systemd[1]: Stopping test.service...2274machine # [ 125.101986] systemd[1]: Starting test.service...2275machine # [ 125.138704] systemd[1]: Finished test.service.2276machine # [ 125.145158] systemd[1]: Reached target Local File Systems.2277machine # [ 125.149037] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2278machine # [ 125.153095] systemd[1]: Starting Create SUID/SGID Wrappers...2279machine # [ 125.153959] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2280machine # [ 125.155168] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672281machine # [ 125.159559] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2282machine # [ 125.170822] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2283machine # [ 125.173041] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2284machine # [ 125.174212] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2285machine # [ 125.175475] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2286machine # [ 125.176855] systemd[1]: Reached target Remote File Systems.2287machine # [ 125.504556] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2288machine # [ 125.508151] systemd[1]: Finished Create SUID/SGID Wrappers.2289machine # [ 125.512470] systemd[1]: Starting linger-users.service...2290machine # [ 125.576258] systemd[1]: linger-users.service: Deactivated successfully.2291machine # [ 125.579087] systemd[1]: Finished linger-users.service.2292machine # [ 125.838276] nixos[5174]: finished switching to system configuration /nix/store/jlwbh1q28i9w1g8jal9c6mlvwy5r3hhs-nixos-system-machine-test2293machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 3.33 seconds)2294machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12295machine # [ 126.511302] nixos[5316]: switching to system configuration /nix/store/q4hqx9aiw9lpsqrdz9v39nigfilgnwpv-nixos-system-machine-test2296machine # [ 126.515269] systemd[1]: Stopped target Local File Systems.2297machine # [ 126.517806] systemd[1]: Stopped target Remote File Systems.2298machine # [ 126.988941] systemd[1]: Reload requested from client PID 5316 ('.switch-to-conf') (unit backdoor.service)...2299machine # [ 126.991058] systemd[1]: Reloading...2300machine # [ 127.581605] systemd[1]: Reloading finished in 586 ms.2301machine # [ 127.718419] systemd[576]: Reexecution requested from client PID 5385 ('switch-to-confi')...2302machine # [ 127.721935] systemd[576]: Reexecuting.2303machine # [ 127.765326] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2304machine # [ 127.950230] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2305machine # [ 127.956668] systemd[576]: Reload requested from client PID 5385 ('switch-to-confi')...2306machine # [ 127.958951] systemd[576]: Reloading...2307machine # [ 128.141842] systemd[576]: Reloading finished in 181 ms.2308machine # [ 128.156135] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2309machine # [ 128.166098] systemd[576]: Stopped Run user-specific NixOS activation.2310machine # [ 128.167042] systemd[576]: Stopping Run user-specific NixOS activation...2311machine # [ 128.169764] systemd[576]: Starting Run user-specific NixOS activation...2312machine # [ 128.214640] systemd[576]: Finished Run user-specific NixOS activation.2313machine # [ 128.218352] systemd[1]: Stopped target Reactivate sysinit units.2314machine # [ 128.220275] systemd[1]: Stopping Reactivate sysinit units...2315machine # [ 128.221083] systemd[1]: Reached target Reactivate sysinit units.2316machine # [ 128.224420] systemd[1]: test.service: Deactivated successfully.2317machine # [ 128.225266] systemd[1]: Stopped test.service.2318machine # [ 128.225874] systemd[1]: Stopping test.service...2319machine # [ 128.228164] systemd[1]: Starting test.service...2320machine # [ 128.261812] systemd[1]: Finished test.service.2321machine # [ 128.265691] systemd[1]: Reached target Remote File Systems.2322machine # [ 128.270262] systemd[1]: Starting linger-users.service...2323machine # [ 128.280388] systemd[1]: Reached target Local File Systems.2324machine # [ 128.283465] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2325machine # [ 128.289297] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2326machine # [ 128.290591] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2327machine # [ 128.295213] systemd[1]: Starting Create SUID/SGID Wrappers...2328machine # [ 128.296798] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2329machine # [ 128.298455] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672330machine # [ 128.301403] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2331machine # [ 128.303389] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2332machine # [ 128.308343] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2333machine # [ 128.361991] systemd[1]: linger-users.service: Deactivated successfully.2334machine # [ 128.364746] systemd[1]: Finished linger-users.service.2335machine # [ 128.630552] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2336machine # [ 128.633457] systemd[1]: Finished Create SUID/SGID Wrappers.2337machine # [ 128.891153] nixos[5316]: finished switching to system configuration /nix/store/q4hqx9aiw9lpsqrdz9v39nigfilgnwpv-nixos-system-machine-test2338machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.05 seconds)2339machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&12340machine # [ 129.521296] nixos[5458]: switching to system configuration /nix/store/xmiivwwdzvgc3vjvg5baidgrj4v9y3cl-nixos-system-machine-test2341machine # [ 129.523693] systemd[1]: Stopped target Remote File Systems.2342machine # [ 129.525949] systemd[1]: Stopped target Local File Systems.2343machine # [ 130.016421] systemd[1]: Reload requested from client PID 5458 ('.switch-to-conf') (unit backdoor.service)...2344machine # [ 130.018294] systemd[1]: Reloading...2345machine # [ 130.653867] systemd[1]: Reloading finished in 633 ms.2346machine # [ 130.808513] systemd[576]: Reexecution requested from client PID 5527 ('switch-to-confi')...2347machine # [ 130.812288] systemd[576]: Reexecuting.2348machine # [ 130.865488] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2349machine # [ 131.056708] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2350machine # [ 131.062571] systemd[576]: Reload requested from client PID 5527 ('switch-to-confi')...2351machine # [ 131.064634] systemd[576]: Reloading...2352machine # [ 131.246721] systemd[576]: Reloading finished in 180 ms.2353machine # [ 131.260128] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2354machine # [ 131.268640] systemd[576]: Stopped Run user-specific NixOS activation.2355machine # [ 131.270749] systemd[576]: Stopping Run user-specific NixOS activation...2356machine # [ 131.273363] systemd[576]: Starting Run user-specific NixOS activation...2357machine # [ 131.314339] systemd[576]: Finished Run user-specific NixOS activation.2358machine # [ 131.318324] systemd[1]: Stopped target Reactivate sysinit units.2359machine # [ 131.320602] systemd[1]: Stopping Reactivate sysinit units...2360machine # [ 131.321419] systemd[1]: Reached target Reactivate sysinit units.2361machine # [ 131.322221] systemd[1]: Reached target Remote File Systems.2362machine # [ 131.329284] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2363machine # [ 131.332598] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2364machine # [ 131.334731] systemd[1]: Reached target Local File Systems.2365machine # [ 131.339888] systemd[1]: Starting linger-users.service...2366machine # [ 131.344231] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2367machine # [ 131.350340] systemd[1]: Starting Create SUID/SGID Wrappers...2368machine # [ 131.352212] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2369machine # [ 131.355673] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672370machine # [ 131.358624] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2371machine # [ 131.363415] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2372machine # [ 131.365635] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2373machine # [ 131.425487] systemd[1]: linger-users.service: Deactivated successfully.2374machine # [ 131.428888] systemd[1]: Finished linger-users.service.2375machine # [ 131.685141] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2376machine # [ 131.688606] systemd[1]: Finished Create SUID/SGID Wrappers.2377machine # [ 131.946749] nixos[5458]: finished switching to system configuration /nix/store/xmiivwwdzvgc3vjvg5baidgrj4v9y3cl-nixos-system-machine-test2378machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 3.05 seconds)2379machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&12380machine # [ 132.585832] nixos[5598]: switching to system configuration /nix/store/ghg7nkcd44aijwcffaqaqaq5aiwz8is4-nixos-system-machine-test2381machine # [ 132.588553] systemd[1]: Stopped target Remote File Systems.2382machine # [ 132.590764] systemd[1]: Stopped target Local File Systems.2383machine # [ 133.082887] systemd[1]: Reload requested from client PID 5598 ('.switch-to-conf') (unit backdoor.service)...2384machine # [ 133.085049] systemd[1]: Reloading...2385machine # [ 133.718161] systemd[1]: Reloading finished in 631 ms.2386machine # [ 133.856937] systemd[576]: Reexecution requested from client PID 5667 ('switch-to-confi')...2387machine # [ 133.861188] systemd[576]: Reexecuting.2388machine # [ 133.917523] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2389machine # [ 134.108658] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2390machine # [ 134.115080] systemd[576]: Reload requested from client PID 5667 ('switch-to-confi')...2391machine # [ 134.117134] systemd[576]: Reloading...2392machine # [ 134.302024] systemd[576]: Reloading finished in 183 ms.2393machine # [ 134.316130] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2394machine # [ 134.326715] systemd[576]: Stopped Run user-specific NixOS activation.2395machine # [ 134.327678] systemd[576]: Stopping Run user-specific NixOS activation...2396machine # [ 134.330431] systemd[576]: Starting Run user-specific NixOS activation...2397machine # [ 134.374468] systemd[576]: Finished Run user-specific NixOS activation.2398machine # [ 134.378131] systemd[1]: Stopped target Reactivate sysinit units.2399machine # [ 134.380173] systemd[1]: Stopping Reactivate sysinit units...2400machine # [ 134.383493] systemd[1]: Reached target Reactivate sysinit units.2401machine # [ 134.384958] systemd[1]: test.service: Deactivated successfully.2402machine # [ 134.386800] systemd[1]: Stopped test.service.2403machine # [ 134.387476] systemd[1]: Stopping test.service...2404machine # [ 134.388287] systemd[1]: Starting test.service...2405machine # [ 134.421243] systemd[1]: Finished test.service.2406machine # [ 134.425247] systemd[1]: Reached target Local File Systems.2407machine # [ 134.428174] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2408machine # [ 134.432968] systemd[1]: Starting Create SUID/SGID Wrappers...2409machine # [ 134.433836] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2410machine # [ 134.435021] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672411machine # [ 134.438231] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2412machine # [ 134.441218] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2413machine # [ 134.445304] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2414machine # [ 134.452500] systemd[1]: Reached target Remote File Systems.2415machine # [ 134.455158] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2416machine # [ 134.457118] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2417machine # [ 134.765782] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2418machine # [ 134.770117] systemd[1]: Finished Create SUID/SGID Wrappers.2419machine # [ 134.772604] systemd[1]: Starting linger-users.service...2420machine # [ 134.827868] systemd[1]: linger-users.service: Deactivated successfully.2421machine # [ 134.829731] systemd[1]: Finished linger-users.service.2422machine # [ 135.089892] nixos[5598]: finished switching to system configuration /nix/store/ghg7nkcd44aijwcffaqaqaq5aiwz8is4-nixos-system-machine-test2423machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 3.14 seconds)2424machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&12425machine # [ 135.711016] nixos[5740]: switching to system configuration /nix/store/anyz7qbxhz1nav91wxbf9fjkb84lawn7-nixos-system-machine-test2426machine # [ 135.714770] systemd[1]: Stopped target Local File Systems.2427machine # [ 135.716108] systemd[1]: Stopped target Remote File Systems.2428machine # [ 136.222564] systemd[1]: Reload requested from client PID 5740 ('.switch-to-conf') (unit backdoor.service)...2429machine # [ 136.224701] systemd[1]: Reloading...2430machine # [ 136.885495] systemd[1]: Reloading finished in 658 ms.2431machine # [ 137.032386] systemd[576]: Reexecution requested from client PID 5809 ('switch-to-confi')...2432machine # [ 137.035132] systemd[576]: Reexecuting.2433machine # [ 137.097950] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2434machine # [ 137.293221] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2435machine # [ 137.299525] systemd[576]: Reload requested from client PID 5809 ('switch-to-confi')...2436machine # [ 137.302069] systemd[576]: Reloading...2437machine # [ 137.494359] systemd[576]: Reloading finished in 191 ms.2438machine # [ 137.508147] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2439machine # [ 137.518802] systemd[576]: Stopped Run user-specific NixOS activation.2440machine # [ 137.521140] systemd[576]: Stopping Run user-specific NixOS activation...2441machine # [ 137.524076] systemd[576]: Starting Run user-specific NixOS activation...2442machine # [ 137.569493] systemd[576]: Finished Run user-specific NixOS activation.2443machine # [ 137.574097] systemd[1]: Stopped target Reactivate sysinit units.2444machine # [ 137.578876] systemd[1]: Stopping Reactivate sysinit units...2445machine # [ 137.580268] systemd[1]: Reached target Reactivate sysinit units.2446machine # [ 137.582704] systemd[1]: test.service: Deactivated successfully.2447machine # [ 137.583700] systemd[1]: Stopped test.service.2448machine # [ 137.584563] systemd[1]: Stopping test.service...2449machine # [ 137.587404] systemd[1]: Starting test.service...2450machine # [ 137.624730] systemd[1]: Finished test.service.2451machine # [ 137.628061] systemd[1]: Reached target Local File Systems.2452machine # [ 137.631526] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2453machine # [ 137.636245] systemd[1]: Starting Create SUID/SGID Wrappers...2454machine # [ 137.637190] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2455machine # [ 137.638397] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672456machine # [ 137.642976] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2457machine # [ 137.649738] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2458machine # [ 137.657895] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2459machine # [ 137.659205] systemd[1]: Reached target Remote File Systems.2460machine # [ 137.659998] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2461machine # [ 137.661964] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2462machine # [ 137.984735] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2463machine # [ 137.986969] systemd[1]: Finished Create SUID/SGID Wrappers.2464machine # [ 137.992341] systemd[1]: Starting linger-users.service...2465machine # [ 138.052145] systemd[1]: linger-users.service: Deactivated successfully.2466machine # [ 138.054947] systemd[1]: Finished linger-users.service.2467machine # [ 138.311860] nixos[5740]: finished switching to system configuration /nix/store/anyz7qbxhz1nav91wxbf9fjkb84lawn7-nixos-system-machine-test2468machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 3.22 seconds)2469machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&12470machine # [ 138.944527] nixos[5882]: switching to system configuration /nix/store/zj3p1m40i29n585c5xycpg24zkhllf3k-nixos-system-machine-test2471machine # [ 138.948170] systemd[1]: Stopped target Local File Systems.2472machine # [ 138.949643] systemd[1]: Stopped target Remote File Systems.2473machine # [ 139.492961] systemd[1]: Reload requested from client PID 5882 ('.switch-to-conf') (unit backdoor.service)...2474machine # [ 139.495006] systemd[1]: Reloading...2475machine # [ 140.174551] systemd[1]: Reloading finished in 676 ms.2476machine # [ 140.315323] systemd[576]: Reexecution requested from client PID 5951 ('switch-to-confi')...2477machine # [ 140.317569] systemd[576]: Reexecuting.2478machine # [ 140.373901] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2479machine # [ 140.570971] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2480machine # [ 140.577738] systemd[576]: Reload requested from client PID 5951 ('switch-to-confi')...2481machine # [ 140.580178] systemd[576]: Reloading...2482machine # [ 140.775237] systemd[576]: Reloading finished in 193 ms.2483machine # [ 140.792163] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2484machine # [ 140.801550] systemd[576]: Stopped Run user-specific NixOS activation.2485machine # [ 140.803878] systemd[576]: Stopping Run user-specific NixOS activation...2486machine # [ 140.806806] systemd[576]: Starting Run user-specific NixOS activation...2487machine # [ 140.854245] systemd[576]: Finished Run user-specific NixOS activation.2488machine # [ 140.858206] systemd[1]: Stopped target Reactivate sysinit units.2489machine # [ 140.859991] systemd[1]: Stopping Reactivate sysinit units...2490machine # [ 140.864357] systemd[1]: Reached target Reactivate sysinit units.2491machine # [ 140.866282] systemd[1]: test.service: Deactivated successfully.2492machine # [ 140.867155] systemd[1]: Stopped test.service.2493machine # [ 140.867779] systemd[1]: Stopping test.service...2494machine # [ 140.868722] systemd[1]: Starting test.service...2495machine # [ 140.903264] systemd[1]: Finished test.service.2496machine # [ 140.908792] systemd[1]: Reached target Local File Systems.2497machine # [ 140.911545] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2498machine # [ 140.916751] systemd[1]: Starting Create SUID/SGID Wrappers...2499machine # [ 140.917648] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2500machine # [ 140.918868] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672501machine # [ 140.922750] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2502machine # [ 140.933401] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2503machine # [ 140.934719] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2504machine # [ 140.935937] systemd[1]: Reached target Remote File Systems.2505machine # [ 140.939235] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2506machine # [ 140.940595] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2507machine # [ 141.258885] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2508machine # [ 141.263354] systemd[1]: Finished Create SUID/SGID Wrappers.2509machine # [ 141.266384] systemd[1]: Starting linger-users.service...2510machine # [ 141.328553] systemd[1]: linger-users.service: Deactivated successfully.2511machine # [ 141.330954] systemd[1]: Finished linger-users.service.2512machine # [ 141.585594] nixos[5882]: finished switching to system configuration /nix/store/zj3p1m40i29n585c5xycpg24zkhllf3k-nixos-system-machine-test2513machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 3.27 seconds)2514machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12515machine # [ 142.193820] nixos[6024]: switching to system configuration /nix/store/q4hqx9aiw9lpsqrdz9v39nigfilgnwpv-nixos-system-machine-test2516machine # [ 142.196392] systemd[1]: Stopped target Local File Systems.2517machine # [ 142.198654] systemd[1]: Stopped target Remote File Systems.2518machine # [ 142.658050] systemd[1]: Reload requested from client PID 6024 ('.switch-to-conf') (unit backdoor.service)...2519machine # [ 142.660098] systemd[1]: Reloading...2520machine # [ 143.270550] systemd[1]: Reloading finished in 608 ms.2521machine # [ 143.419551] systemd[576]: Reexecution requested from client PID 6093 ('switch-to-confi')...2522machine # [ 143.423130] systemd[576]: Reexecuting.2523machine # [ 143.478029] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2524machine # [ 143.672180] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2525machine # [ 143.678618] systemd[576]: Reload requested from client PID 6093 ('switch-to-confi')...2526machine # [ 143.680916] systemd[576]: Reloading...2527machine # [ 143.873199] systemd[576]: Reloading finished in 191 ms.2528machine # [ 143.888153] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2529machine # [ 143.896726] systemd[576]: Stopped Run user-specific NixOS activation.2530machine # [ 143.898931] systemd[576]: Stopping Run user-specific NixOS activation...2531machine # [ 143.901784] systemd[576]: Starting Run user-specific NixOS activation...2532machine # [ 143.947868] systemd[576]: Finished Run user-specific NixOS activation.2533machine # [ 143.952488] systemd[1]: Stopped target Reactivate sysinit units.2534machine # [ 143.953410] systemd[1]: Stopping Reactivate sysinit units...2535machine # [ 143.954851] systemd[1]: Reached target Reactivate sysinit units.2536machine # [ 143.958813] systemd[1]: test.service: Deactivated successfully.2537machine # [ 143.959959] systemd[1]: Stopped test.service.2538machine # [ 143.961752] systemd[1]: Stopping test.service...2539machine # [ 143.962431] systemd[1]: Starting test.service...2540machine # [ 143.998559] systemd[1]: Finished test.service.2541machine # [ 144.002126] systemd[1]: Reached target Local File Systems.2542machine # [ 144.005409] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2543machine # [ 144.009905] systemd[1]: Starting Create SUID/SGID Wrappers...2544machine # [ 144.010749] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2545machine # [ 144.011991] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672546machine # [ 144.016126] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2547machine # [ 144.023703] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2548machine # [ 144.026701] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2549machine # [ 144.030858] systemd[1]: Reached target Remote File Systems.2550machine # [ 144.033755] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2551machine # [ 144.035232] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2552machine # [ 144.349678] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2553machine # [ 144.354355] systemd[1]: Finished Create SUID/SGID Wrappers.2554machine # [ 144.356973] systemd[1]: Starting linger-users.service...2555machine # [ 144.413257] systemd[1]: linger-users.service: Deactivated successfully.2556machine # [ 144.416089] systemd[1]: Finished linger-users.service.2557machine # [ 144.674449] nixos[6024]: finished switching to system configuration /nix/store/q4hqx9aiw9lpsqrdz9v39nigfilgnwpv-nixos-system-machine-test2558machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.09 seconds)2559machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&12560machine # [ 145.293805] nixos[6166]: switching to system configuration /nix/store/iz4smcalzbvm98k9c0vqgswhq7ls88d2-nixos-system-machine-test2561machine # [ 145.296487] systemd[1]: Stopped target Remote File Systems.2562machine # [ 145.298778] systemd[1]: Stopped target Local File Systems.2563machine # [ 145.788328] systemd[1]: Reload requested from client PID 6166 ('.switch-to-conf') (unit backdoor.service)...2564machine # [ 145.790253] systemd[1]: Reloading...2565machine # [ 146.433264] systemd[1]: Reloading finished in 639 ms.2566machine # [ 146.575817] systemd[576]: Reexecution requested from client PID 6235 ('switch-to-confi')...2567machine # [ 146.579918] systemd[576]: Reexecuting.2568machine # [ 146.637677] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2569machine # [ 146.821714] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2570machine # [ 146.827734] systemd[576]: Reload requested from client PID 6235 ('switch-to-confi')...2571machine # [ 146.830292] systemd[576]: Reloading...2572machine # [ 147.013362] systemd[576]: Reloading finished in 181 ms.2573machine # [ 147.028144] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2574machine # [ 147.038573] systemd[576]: Stopped Run user-specific NixOS activation.2575machine # [ 147.040913] systemd[576]: Stopping Run user-specific NixOS activation...2576machine # [ 147.043680] systemd[576]: Starting Run user-specific NixOS activation...2577machine # [ 147.087859] systemd[576]: Finished Run user-specific NixOS activation.2578machine # [ 147.092100] systemd[1]: Stopped target Reactivate sysinit units.2579machine # [ 147.095993] systemd[1]: Stopping Reactivate sysinit units...2580machine # [ 147.097117] systemd[1]: Reached target Reactivate sysinit units.2581machine # [ 147.099739] systemd[1]: Reloading test.service...2582machine # [ 147.135478] systemd[1]: Reloaded test.service.2583machine # [ 147.139148] systemd[1]: Reached target Local File Systems.2584machine # [ 147.142542] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2585machine # [ 147.146738] systemd[1]: Starting Create SUID/SGID Wrappers...2586machine # [ 147.147665] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2587machine # [ 147.150667] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672588machine # [ 147.160320] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2589machine # [ 147.161907] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2590machine # [ 147.163166] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2591machine # [ 147.170228] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2592machine # [ 147.171547] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2593machine # [ 147.173507] systemd[1]: Reached target Remote File Systems.2594machine # [ 147.476248] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2595machine # [ 147.480388] systemd[1]: Finished Create SUID/SGID Wrappers.2596machine # [ 147.482902] systemd[1]: Starting linger-users.service...2597machine # [ 147.544865] systemd[1]: linger-users.service: Deactivated successfully.2598machine # [ 147.546492] systemd[1]: Finished linger-users.service.2599machine # [ 147.805959] nixos[6166]: finished switching to system configuration /nix/store/iz4smcalzbvm98k9c0vqgswhq7ls88d2-nixos-system-machine-test2600machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 3.13 seconds)2601machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&12602machine # [ 148.457510] nixos[6308]: switching to system configuration /nix/store/a7d2zcma8diy5nzydfg1xmn83zzz7wzd-nixos-system-machine-test2603machine # [ 148.460692] systemd[1]: Stopped target Local File Systems.2604machine # [ 148.462091] systemd[1]: Stopped target Remote File Systems.2605machine # [ 148.968437] systemd[1]: Reload requested from client PID 6308 ('.switch-to-conf') (unit backdoor.service)...2606machine # [ 148.970336] systemd[1]: Reloading...2607machine # [ 149.621415] systemd[1]: Reloading finished in 648 ms.2608machine # [ 149.762530] systemd[576]: Reexecution requested from client PID 6377 ('switch-to-confi')...2609machine # [ 149.763960] systemd[576]: Reexecuting.2610machine # [ 149.830191] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2611machine # [ 150.018530] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2612machine # [ 150.024919] systemd[576]: Reload requested from client PID 6377 ('switch-to-confi')...2613machine # [ 150.027462] systemd[576]: Reloading...2614machine # [ 150.213324] systemd[576]: Reloading finished in 184 ms.2615machine # [ 150.228136] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2616machine # [ 150.238605] systemd[576]: Stopped Run user-specific NixOS activation.2617machine # [ 150.239553] systemd[576]: Stopping Run user-specific NixOS activation...2618machine # [ 150.242376] systemd[576]: Starting Run user-specific NixOS activation...2619machine # [ 150.287353] systemd[576]: Finished Run user-specific NixOS activation.2620machine # [ 150.291588] systemd[1]: Stopped target Reactivate sysinit units.2621machine # [ 150.293217] systemd[1]: Stopping Reactivate sysinit units...2622machine # [ 150.294017] systemd[1]: Reached target Reactivate sysinit units.2623machine # [ 150.299070] systemd[1]: Reloading test.service...2624machine # [ 150.333414] systemd[1]: Reloaded test.service.2625machine # [ 150.336716] systemd[1]: Reached target Local File Systems.2626machine # [ 150.340101] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2627machine # [ 150.343692] systemd[1]: Starting Create SUID/SGID Wrappers...2628machine # [ 150.347775] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2629machine # [ 150.353226] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672630machine # [ 150.355600] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2631machine # [ 150.361444] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2632machine # [ 150.362840] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2633machine # [ 150.367014] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2634machine # [ 150.370429] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2635machine # [ 150.371908] systemd[1]: Reached target Remote File Systems.2636machine # [ 150.674836] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2637machine # [ 150.679382] systemd[1]: Finished Create SUID/SGID Wrappers.2638machine # [ 150.682746] systemd[1]: Starting linger-users.service...2639machine # [ 150.742693] systemd[1]: linger-users.service: Deactivated successfully.2640machine # [ 150.745385] systemd[1]: Finished linger-users.service.2641machine # [ 151.003551] nixos[6308]: finished switching to system configuration /nix/store/a7d2zcma8diy5nzydfg1xmn83zzz7wzd-nixos-system-machine-test2642machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 3.20 seconds)2643machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&12644machine # [ 151.632562] nixos[6450]: switching to system configuration /nix/store/69m73park9za1prxrvjykbfq9k2r8qq0-nixos-system-machine-test2645machine # [ 151.635253] systemd[1]: Stopped target Local File Systems.2646machine # [ 151.637641] systemd[1]: Stopped target Remote File Systems.2647machine # [ 152.140892] systemd[1]: Reload requested from client PID 6450 ('.switch-to-conf') (unit backdoor.service)...2648machine # [ 152.142844] systemd[1]: Reloading...2649machine # [ 152.814376] systemd[1]: Reloading finished in 669 ms.2650machine # [ 152.966621] systemd[576]: Reexecution requested from client PID 6519 ('switch-to-confi')...2651machine # [ 152.969560] systemd[576]: Reexecuting.2652machine # [ 153.026353] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2653machine # [ 153.220622] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2654machine # [ 153.227022] systemd[576]: Reload requested from client PID 6519 ('switch-to-confi')...2655machine # [ 153.229198] systemd[576]: Reloading...2656machine # [ 153.419826] systemd[576]: Reloading finished in 189 ms.2657machine # [ 153.432143] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2658machine # [ 153.443129] systemd[576]: Stopped Run user-specific NixOS activation.2659machine # [ 153.444134] systemd[576]: Stopping Run user-specific NixOS activation...2660machine # [ 153.447001] systemd[576]: Starting Run user-specific NixOS activation...2661machine # [ 153.492523] systemd[576]: Finished Run user-specific NixOS activation.2662machine # [ 153.496505] systemd[1]: Stopped target Reactivate sysinit units.2663machine # [ 153.498424] systemd[1]: Stopping Reactivate sysinit units...2664machine # [ 153.502313] systemd[1]: Reached target Reactivate sysinit units.2665machine # [ 153.503201] systemd[1]: test.service: Deactivated successfully.2666machine # [ 153.503981] systemd[1]: Stopped test.service.2667machine # [ 153.504918] systemd[1]: Stopping test.service...2668machine # [ 153.507027] systemd[1]: Starting test.service...2669machine # [ 153.542812] systemd[1]: Finished test.service.2670machine # [ 153.546288] systemd[1]: Reached target Local File Systems.2671machine # [ 153.552437] systemd[1]: Reached target Remote File Systems.2672machine # [ 153.554740] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2673machine # [ 153.557392] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2674machine # [ 153.563758] systemd[1]: Starting linger-users.service...2675machine # [ 153.568798] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2676machine # [ 153.573135] systemd[1]: Starting Create SUID/SGID Wrappers...2677machine # [ 153.573987] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2678machine # [ 153.575267] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672679machine # [ 153.581969] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2680machine # [ 153.583913] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2681machine # [ 153.585482] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2682machine # [ 153.652360] systemd[1]: linger-users.service: Deactivated successfully.2683machine # [ 153.655112] systemd[1]: Finished linger-users.service.2684machine # [ 153.920772] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2685machine # [ 153.923836] systemd[1]: Finished Create SUID/SGID Wrappers.2686machine # [ 154.180503] nixos[6450]: finished switching to system configuration /nix/store/69m73park9za1prxrvjykbfq9k2r8qq0-nixos-system-machine-test2687machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 3.18 seconds)2688machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&12689machine # [ 154.769876] nixos[6592]: switching to system configuration /nix/store/ghg7nkcd44aijwcffaqaqaq5aiwz8is4-nixos-system-machine-test2690machine # [ 154.772319] systemd[1]: Stopped target Remote File Systems.2691machine # [ 154.774417] systemd[1]: Stopped target Local File Systems.2692machine # [ 155.198661] systemd[1]: Reload requested from client PID 6592 ('.switch-to-conf') (unit backdoor.service)...2693machine # [ 155.200690] systemd[1]: Reloading...2694machine # [ 155.771625] systemd[1]: Reloading finished in 569 ms.2695machine # [ 155.907841] systemd[576]: Reexecution requested from client PID 6661 ('switch-to-confi')...2696machine # [ 155.911375] systemd[576]: Reexecuting.2697machine # [ 155.965529] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2698machine # [ 156.148091] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2699machine # [ 156.154386] systemd[576]: Reload requested from client PID 6661 ('switch-to-confi')...2700machine # [ 156.156694] systemd[576]: Reloading...2701machine # [ 156.339458] systemd[576]: Reloading finished in 181 ms.2702machine # [ 156.356190] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2703machine # [ 156.368041] systemd[576]: Stopped Run user-specific NixOS activation.2704machine # [ 156.369052] systemd[576]: Stopping Run user-specific NixOS activation...2705machine # [ 156.371892] systemd[576]: Starting Run user-specific NixOS activation...2706machine # [ 156.415259] systemd[576]: Finished Run user-specific NixOS activation.2707machine # [ 156.419486] systemd[1]: Stopped target Reactivate sysinit units.2708machine # [ 156.421135] systemd[1]: Stopping Reactivate sysinit units...2709machine # [ 156.421992] systemd[1]: Reached target Reactivate sysinit units.2710machine # [ 156.425202] systemd[1]: Reached target Local File Systems.2711machine # [ 156.428630] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2712machine # [ 156.432369] systemd[1]: Starting Create SUID/SGID Wrappers...2713machine # [ 156.433202] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2714machine # [ 156.434384] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672715machine # [ 156.450345] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2716machine # [ 156.451984] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2717machine # [ 156.454734] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2718machine # [ 156.456002] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2719machine # [ 156.457269] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2720machine # [ 156.458472] systemd[1]: Reached target Remote File Systems.2721machine # [ 156.774109] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2722machine # [ 156.778798] systemd[1]: Finished Create SUID/SGID Wrappers.2723machine # [ 156.781552] systemd[1]: Starting linger-users.service...2724machine # [ 156.843915] systemd[1]: linger-users.service: Deactivated successfully.2725machine # [ 156.846805] systemd[1]: Finished linger-users.service.2726machine # [ 157.104953] nixos[6592]: finished switching to system configuration /nix/store/ghg7nkcd44aijwcffaqaqaq5aiwz8is4-nixos-system-machine-test2727machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 2.93 seconds)2728(finished: subtest: unit file parser, in 40.73 seconds)2729subtest: restart and reload by activation script2730machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&12731machine # [ 157.716391] nixos[6732]: switching to system configuration /nix/store/6cf4937d4majd9i2kzr31yq3vrqj0sid-nixos-system-machine-test2732machine # [ 157.719664] systemd[1]: Stopped target Remote File Systems.2733machine # [ 157.722568] systemd[1]: Stopped target Local File Systems.2734machine # [ 158.210204] systemd[1]: Reload requested from client PID 6732 ('.switch-to-conf') (unit backdoor.service)...2735machine # [ 158.212341] systemd[1]: Reloading...2736machine # [ 158.813775] systemd[1]: Reloading finished in 598 ms.2737machine # [ 158.975666] systemd[576]: Reexecution requested from client PID 6801 ('switch-to-confi')...2738machine # [ 158.978477] systemd[576]: Reexecuting.2739machine # [ 159.054183] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2740machine # [ 159.254272] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2741machine # [ 159.262773] systemd[576]: Reload requested from client PID 6801 ('switch-to-confi')...2742machine # [ 159.265732] systemd[576]: Reloading...2743machine # [ 159.471717] systemd[576]: Reloading finished in 204 ms.2744machine # [ 159.488197] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2745machine # [ 159.501578] systemd[576]: Stopped Run user-specific NixOS activation.2746machine # [ 159.502698] systemd[576]: Stopping Run user-specific NixOS activation...2747machine # [ 159.506302] systemd[576]: Starting Run user-specific NixOS activation...2748machine # [ 159.556564] systemd[576]: Finished Run user-specific NixOS activation.2749machine # [ 159.561891] systemd[1]: Stopped target Reactivate sysinit units.2750machine # [ 159.562859] systemd[1]: Stopping Reactivate sysinit units...2751machine # [ 159.563676] systemd[1]: Reached target Reactivate sysinit units.2752machine # [ 159.568556] systemd[1]: Reached target Local File Systems.2753machine # [ 159.575178] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2754machine # [ 159.579783] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2755machine # [ 159.581654] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2756machine # [ 159.587149] systemd[1]: Starting Create SUID/SGID Wrappers...2757machine # [ 159.589633] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2758machine # [ 159.593433] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672759machine # [ 159.596524] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2760machine # [ 159.600277] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2761machine # [ 159.601645] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2762machine # [ 159.602828] systemd[1]: Reached target Remote File Systems.2763machine # [ 159.943614] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2764machine # [ 159.948694] systemd[1]: Finished Create SUID/SGID Wrappers.2765machine # [ 159.951246] systemd[1]: Starting linger-users.service...2766machine # [ 160.016673] systemd[1]: linger-users.service: Deactivated successfully.2767machine # [ 160.019781] systemd[1]: Finished linger-users.service.2768machine # [ 160.277139] nixos[6732]: finished switching to system configuration /nix/store/6cf4937d4majd9i2kzr31yq3vrqj0sid-nixos-system-machine-test2769machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 3.17 seconds)2770machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12771machine # [ 160.956137] nixos[6872]: switching to system configuration /nix/store/y1lnrngxcm8670zrs8pi1yg0dc1r70iz-nixos-system-machine-test2772machine # [ 160.960290] systemd[1]: Stopped target Local File Systems.2773machine # [ 160.962037] systemd[1]: Stopped target Remote File Systems.2774machine # [ 160.962955] systemd[1]: test.service: Deactivated successfully.2775machine # [ 160.963771] systemd[1]: Stopped test.service.2776machine # [ 161.519185] systemd[1]: Reload requested from client PID 6872 ('.switch-to-conf') (unit backdoor.service)...2777machine # [ 161.521490] systemd[1]: Reloading...2778machine # [ 162.209904] systemd[1]: Reloading finished in 685 ms.2779machine # [ 162.367662] systemd[576]: Reexecution requested from client PID 6943 ('switch-to-confi')...2780machine # [ 162.369901] systemd[576]: Reexecuting.2781machine # [ 162.442988] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2782machine # [ 162.645324] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2783machine # [ 162.651840] systemd[576]: Reload requested from client PID 6943 ('switch-to-confi')...2784machine # [ 162.655877] systemd[576]: Reloading...2785machine # [ 162.843965] systemd[576]: Reloading finished in 189 ms.2786machine # [ 162.856172] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2787machine # [ 162.865949] systemd[576]: Stopped Run user-specific NixOS activation.2788machine # [ 162.868491] systemd[576]: Stopping Run user-specific NixOS activation...2789machine # [ 162.871547] systemd[576]: Starting Run user-specific NixOS activation...2790machine # [ 162.919162] systemd[576]: Finished Run user-specific NixOS activation.2791machine # [ 162.923820] systemd[1]: Stopped target Reactivate sysinit units.2792machine # [ 162.925320] systemd[1]: Stopping Reactivate sysinit units...2793machine # [ 162.926167] systemd[1]: Reached target Reactivate sysinit units.2794machine # [ 162.933607] systemd[1]: Starting simple-restart-service.service...2795machine # [ 162.951452] systemd[1]: Created slice Slice /system/templated-no-restart-service.2796machine # [ 162.954572] systemd[1]: Starting templated-no-restart-service@instance.service...2797machine # [ 162.962091] systemd[1]: Reached target Remote File Systems.2798machine # [ 162.970361] systemd[1]: Reached target Local File Systems.2799machine # [ 162.973602] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2800machine # [ 162.981017] systemd[1]: Starting Create SUID/SGID Wrappers...2801machine # [ 162.989240] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2802machine # [ 162.990589] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672803machine # [ 163.002344] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2804machine # [ 163.007711] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2805machine # [ 163.014637] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2806machine # [ 163.022692] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2807machine # [ 163.028790] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2808machine # [ 163.032360] systemd[1]: Created slice Slice /system/templated-reload-triggers.2809machine # [ 163.035372] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart.2810machine # [ 163.039681] systemd[1]: Created slice Slice /system/templated-simple-service.2811machine # [ 163.048792] systemd[1]: Created slice Slice /system/templated-simple-restart-service.2812machine # [ 163.052857] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as.2813machine # [ 163.057505] systemd[1]: Finished simple-restart-service.service.2814machine # [ 163.067912] systemd[1]: Finished templated-no-restart-service@instance.service.2815machine # [ 163.077232] systemd[1]: Created slice Slice /system/templated-simple-reload-service.2816machine # [ 163.372344] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2817machine # [ 163.376218] systemd[1]: Finished Create SUID/SGID Wrappers.2818machine # [ 163.380498] systemd[1]: Starting linger-users.service...2819machine # [ 163.384527] systemd[1]: Starting no-restart-service.service...2820machine # [ 163.388131] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2821machine # [ 163.398658] systemd[1]: Starting reload-triggers-and-restart.service...2822machine # [ 163.409918] systemd[1]: Starting reload-triggers.service...2823machine # [ 163.416594] systemd[1]: Starting simple-reload-service.service...2824machine # [ 163.428420] systemd[1]: Starting simple-service.service...2825machine # [ 163.434084] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2826machine # [ 163.439025] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2827machine # [ 163.463435] systemd[1]: Starting templated-reload-triggers@instance.service...2828machine # [ 163.476488] systemd[1]: Starting templated-simple-reload-service@instance.service...2829machine # [ 163.495231] systemd[1]: Starting templated-simple-restart-service@instance.service...2830machine # [ 163.511236] systemd[1]: Starting templated-simple-service@instance.service...2831machine # [ 163.560191] systemd[1]: Finished reload-triggers.service.2832machine # [ 163.573122] systemd[1]: Finished no-restart-service.service.2833machine # [ 163.583894] systemd[1]: Finished reload-triggers-and-restart.service.2834machine # [ 163.587131] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2835machine # [ 163.599715] systemd[1]: Finished simple-reload-service.service.2836machine # [ 163.615602] systemd[1]: Finished simple-service.service.2837machine # [ 163.622645] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2838machine # [ 163.633905] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2839machine # [ 163.635143] systemd[1]: Finished templated-reload-triggers@instance.service.2840machine # [ 163.638984] systemd[1]: Finished templated-simple-reload-service@instance.service.2841machine # [ 163.651017] systemd[1]: Finished templated-simple-restart-service@instance.service.2842machine # [ 163.656003] systemd[1]: Finished templated-simple-service@instance.service.2843machine # [ 163.662894] systemd[1]: linger-users.service: Deactivated successfully.2844machine # [ 163.665182] systemd[1]: Finished linger-users.service.2845machine # [ 163.925221] nixos[6872]: finished switching to system configuration /nix/store/y1lnrngxcm8670zrs8pi1yg0dc1r70iz-nixos-system-machine-test2846machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.65 seconds)2847machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12848machine # [ 164.653171] nixos[7042]: switching to system configuration /nix/store/y1lnrngxcm8670zrs8pi1yg0dc1r70iz-nixos-system-machine-test2849machine # [ 164.655928] systemd[1]: Stopped target Local File Systems.2850machine # [ 164.658219] systemd[1]: Stopped target Remote File Systems.2851machine # [ 165.142620] systemd[1]: Reload requested from client PID 7042 ('.switch-to-conf') (unit backdoor.service)...2852machine # [ 165.144815] systemd[1]: Reloading...2853machine # [ 165.780374] systemd[1]: Reloading finished in 633 ms.2854machine # [ 165.928428] systemd[576]: Reexecution requested from client PID 7113 ('switch-to-confi')...2855machine # [ 165.931718] systemd[576]: Reexecuting.2856machine # [ 165.985873] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2857machine # [ 166.165892] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2858machine # [ 166.172366] systemd[576]: Reload requested from client PID 7113 ('switch-to-confi')...2859machine # [ 166.174849] systemd[576]: Reloading...2860machine # [ 166.358712] systemd[576]: Reloading finished in 182 ms.2861machine # [ 166.372161] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2862machine # [ 166.382533] systemd[576]: Stopped Run user-specific NixOS activation.2863machine # [ 166.383526] systemd[576]: Stopping Run user-specific NixOS activation...2864machine # [ 166.386386] systemd[576]: Starting Run user-specific NixOS activation...2865machine # [ 166.432329] systemd[576]: Finished Run user-specific NixOS activation.2866machine # [ 166.436363] systemd[1]: Stopped target Reactivate sysinit units.2867machine # [ 166.438835] systemd[1]: Stopping Reactivate sysinit units...2868machine # [ 166.439720] systemd[1]: Reached target Reactivate sysinit units.2869machine # [ 166.445029] systemd[1]: Reloading reload-triggers-and-restart.service...2870machine # [ 166.450705] systemd[1]: Reloading reload-triggers.service...2871machine # [ 166.459933] systemd[1]: Reloading simple-reload-service.service...2872machine # [ 166.469924] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service...2873machine # [ 166.481960] systemd[1]: Reloading templated-reload-triggers@instance.service...2874machine # [ 166.489266] systemd[1]: Reloading templated-simple-reload-service@instance.service...2875machine # [ 166.555362] systemd[1]: Reloaded reload-triggers.service.2876machine # [ 166.558475] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service.2877machine # [ 166.559596] systemd[1]: Reloaded simple-reload-service.service.2878machine # [ 166.562102] systemd[1]: Reloaded reload-triggers-and-restart.service.2879machine # [ 166.563212] systemd[1]: Reloaded templated-reload-triggers@instance.service.2880machine # [ 166.571017] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2881machine # [ 166.576139] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2882machine # [ 166.577309] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2883machine # [ 166.578236] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2884machine # [ 166.581894] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2885machine # [ 166.585525] systemd[1]: simple-restart-service.service: Deactivated successfully.2886machine # [ 166.586603] systemd[1]: Stopped simple-restart-service.service.2887machine # [ 166.587416] systemd[1]: Stopping simple-restart-service.service...2888machine # [ 166.590583] systemd[1]: Starting simple-restart-service.service...2889machine # [ 166.594690] systemd[1]: simple-service.service: Deactivated successfully.2890machine # [ 166.597294] systemd[1]: Stopped simple-service.service.2891machine # [ 166.604778] systemd[1]: Stopping simple-service.service...2892machine # [ 166.605949] systemd[1]: Starting simple-service.service...2893machine # [ 166.607052] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2894machine # [ 166.620297] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2895machine # [ 166.633109] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2896machine # [ 166.642385] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2897machine # [ 166.647407] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2898machine # [ 166.654745] systemd[1]: Stopped templated-simple-restart-service@instance.service.2899machine # [ 166.659875] systemd[1]: Stopping templated-simple-restart-service@instance.service...2900machine # [ 166.664753] systemd[1]: Starting templated-simple-restart-service@instance.service...2901machine # [ 166.671795] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2902machine # [ 166.681102] systemd[1]: Stopped templated-simple-service@instance.service.2903machine # [ 166.686263] systemd[1]: Stopping templated-simple-service@instance.service...2904machine # [ 166.692334] systemd[1]: Starting templated-simple-service@instance.service...2905machine # [ 166.704215] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2906machine # [ 166.712142] systemd[1]: Finished simple-service.service.2907machine # [ 166.722831] systemd[1]: Finished simple-restart-service.service.2908machine # [ 166.726163] systemd[1]: Finished templated-simple-restart-service@instance.service.2909machine # [ 166.729978] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2910machine # [ 166.731174] systemd[1]: Finished templated-simple-service@instance.service.2911machine # [ 166.734363] systemd[1]: Reached target Local File Systems.2912machine # [ 166.736528] systemd[1]: Reached target Remote File Systems.2913machine # [ 166.738814] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2914machine # [ 166.741426] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2915machine # [ 166.748130] systemd[1]: Starting linger-users.service...2916machine # [ 166.759625] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2917machine # [ 166.769417] systemd[1]: Starting Create SUID/SGID Wrappers...2918machine # [ 166.770342] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2919machine # [ 166.771553] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672920machine # [ 166.774634] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2921machine # [ 166.776975] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2922machine # [ 166.778640] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2923machine # [ 166.838284] systemd[1]: linger-users.service: Deactivated successfully.2924machine # [ 166.841154] systemd[1]: Finished linger-users.service.2925machine # [ 167.112170] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2926machine # [ 167.115382] systemd[1]: Finished Create SUID/SGID Wrappers.2927machine # [ 167.372621] nixos[7042]: finished switching to system configuration /nix/store/y1lnrngxcm8670zrs8pi1yg0dc1r70iz-nixos-system-machine-test2928machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.45 seconds)2929machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&12930machine # [ 168.142068] nixos[7208]: switching to system configuration /nix/store/l9rdf41n3rf0dw7qm32jxcw451v3nlww-nixos-system-machine-test2931machine # [ 168.145078] systemd[1]: Stopped target Local File Systems.2932machine # [ 168.147363] systemd[1]: Stopped target Remote File Systems.2933machine # [ 168.709494] systemd[1]: Reload requested from client PID 7208 ('.switch-to-conf') (unit backdoor.service)...2934machine # [ 168.711407] systemd[1]: Reloading...2935machine # [ 169.385255] systemd[1]: Reloading finished in 671 ms.2936machine # [ 169.529856] systemd[576]: Reexecution requested from client PID 7279 ('switch-to-confi')...2937machine # [ 169.531291] systemd[576]: Reexecuting.2938machine # [ 169.597639] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2939machine # [ 169.784126] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2940machine # [ 169.790028] systemd[576]: Reload requested from client PID 7279 ('switch-to-confi')...2941machine # [ 169.792077] systemd[576]: Reloading...2942machine # [ 169.974268] systemd[576]: Reloading finished in 180 ms.2943machine # [ 169.988134] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2944machine # [ 169.996679] systemd[576]: Stopped Run user-specific NixOS activation.2945machine # [ 169.998813] systemd[576]: Stopping Run user-specific NixOS activation...2946machine # [ 170.001442] systemd[576]: Starting Run user-specific NixOS activation...2947machine # [ 170.042485] systemd[576]: Finished Run user-specific NixOS activation.2948machine # [ 170.046124] systemd[1]: Stopped target Reactivate sysinit units.2949machine # [ 170.050569] systemd[1]: Stopping Reactivate sysinit units...2950machine # [ 170.051720] systemd[1]: Reached target Reactivate sysinit units.2951machine # [ 170.054170] systemd[1]: Reloading reload-triggers.service...2952machine # [ 170.061035] systemd[1]: Reloading simple-reload-service.service...2953machine # [ 170.071694] systemd[1]: Reloading templated-reload-triggers@instance.service...2954machine # [ 170.077186] systemd[1]: Reloading templated-simple-reload-service@instance.service...2955machine # [ 170.124888] systemd[1]: Reloaded reload-triggers.service.2956machine # [ 170.128192] systemd[1]: Reloaded simple-reload-service.service.2957machine # [ 170.129041] systemd[1]: Reloaded templated-reload-triggers@instance.service.2958machine # [ 170.129950] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2959machine # [ 170.132002] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2960machine # [ 170.135150] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2961machine # [ 170.136355] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2962machine # [ 170.138715] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2963machine # [ 170.142828] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully.2964machine # [ 170.147331] systemd[1]: Stopped reload-triggers-and-restart.service.2965machine # [ 170.148306] systemd[1]: Stopping reload-triggers-and-restart.service...2966machine # [ 170.152639] systemd[1]: Starting reload-triggers-and-restart.service...2967machine # [ 170.156660] systemd[1]: simple-restart-service.service: Deactivated successfully.2968machine # [ 170.157675] systemd[1]: Stopped simple-restart-service.service.2969machine # [ 170.158465] systemd[1]: Stopping simple-restart-service.service...2970machine # [ 170.163052] systemd[1]: Starting simple-restart-service.service...2971machine # [ 170.166934] systemd[1]: simple-service.service: Deactivated successfully.2972machine # [ 170.179386] systemd[1]: Stopped simple-service.service.2973machine # [ 170.180439] systemd[1]: Stopping simple-service.service...2974machine # [ 170.181562] systemd[1]: Starting simple-service.service...2975machine # [ 170.187011] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2976machine # [ 170.191730] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2977machine # [ 170.212495] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2978machine # [ 170.213697] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2979machine # [ 170.214973] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully.2980machine # [ 170.240505] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service.2981machine # [ 170.245241] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service...2982machine # [ 170.258027] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2983machine # [ 170.265660] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2984machine # [ 170.278102] systemd[1]: Stopped templated-simple-restart-service@instance.service.2985machine # [ 170.280581] systemd[1]: Stopping templated-simple-restart-service@instance.service...2986machine # [ 170.282555] systemd[1]: Starting templated-simple-restart-service@instance.service...2987machine # [ 170.290313] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2988machine # [ 170.297882] systemd[1]: Stopped templated-simple-service@instance.service.2989machine # [ 170.299149] systemd[1]: Stopping templated-simple-service@instance.service...2990machine # [ 170.303210] systemd[1]: Starting templated-simple-service@instance.service...2991machine # [ 170.306780] systemd[1]: Finished reload-triggers-and-restart.service.2992machine # [ 170.308456] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2993machine # [ 170.310415] systemd[1]: Finished simple-service.service.2994machine # [ 170.311955] systemd[1]: Finished simple-restart-service.service.2995machine # [ 170.313960] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2996machine # [ 170.315951] systemd[1]: Finished templated-simple-restart-service@instance.service.2997machine # [ 170.317521] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2998machine # [ 170.323539] systemd[1]: Finished templated-simple-service@instance.service.2999machine # [ 170.326266] systemd[1]: Reached target Remote File Systems.3000machine # [ 170.331117] systemd[1]: Starting linger-users.service...3001machine # [ 170.333599] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os3002machine # [ 170.335999] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki3003machine # [ 170.344152] systemd[1]: Reached target Local File Systems.3004machine # [ 170.344962] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore3005machine # [ 170.353720] systemd[1]: Starting Create SUID/SGID Wrappers...3006machine # [ 170.354573] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.3007machine # [ 170.355764] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc673008machine # [ 170.364399] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore3009machine # [ 170.366411] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3010machine # [ 170.368648] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3011machine # [ 170.422425] systemd[1]: linger-users.service: Deactivated successfully.3012machine # [ 170.424970] systemd[1]: Finished linger-users.service.3013machine # [ 170.678412] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.3014machine # [ 170.681677] systemd[1]: Finished Create SUID/SGID Wrappers.3015machine # [ 170.938595] nixos[7208]: finished switching to system configuration /nix/store/l9rdf41n3rf0dw7qm32jxcw451v3nlww-nixos-system-machine-test3016machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 3.57 seconds)3017machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&13018machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.86 seconds)3019(finished: subtest: restart and reload by activation script, in 14.69 seconds)3020(finished: run the VM test script, in 172.72 seconds)3021test script finished in 172.77s3022cleanup3023kill QemuMachine (pid 45)3024machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)3025(finished: cleanup, in 0.19 seconds)3026additionally exposed symbols:3027 machine, other,3028 vlan1,3029 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh