vm-test-run-switch-test-services
checks.aarch64-linux.switchTest
· build #38
· raw
1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7machine: waiting for unit multi-user.target8machine: waiting for the VM to finish booting9machine: starting vm10machine # Disk image does not exist, creating the virtualisation disk image...11machine: QEMU running (pid 45)12machine # Formatting '/build/vm-state-machine/tmp.IgaPDF3uVS', 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: 5b4d64e5-434a-471e-934f-146c0ad6b8ef17machine # 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 # Starting virtiofs daemons...27machine # [2026-09-16T02:57:32Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)28machine # [2026-09-16T02:57:32Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether29machine # [2026-09-16T02:57:32Z INFO virtiofsd] Waiting for vhost-user socket connection...30machine # [2026-09-16T02:57:32Z INFO virtiofsd] Client connected, servicing requests31machine # [2026-09-16T02:57:32Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)32machine # [2026-09-16T02:57:32Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether33machine # [2026-09-16T02:57:32Z INFO virtiofsd] Waiting for vhost-user socket connection...34machine # [2026-09-16T02:57:32Z INFO virtiofsd] Client connected, servicing requests35machine # [2026-09-16T02:57:32Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)36machine # [2026-09-16T02:57:32Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether37machine # [2026-09-16T02:57:32Z INFO virtiofsd] Waiting for vhost-user socket connection...38machine # [2026-09-16T02:57:32Z INFO virtiofsd] Client connected, servicing requests39machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]40machine # [ 0.000000] Linux version 6.18.51 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 11 09:49:46 UTC 202641machine # [ 0.000000] KASLR enabled42machine # [ 0.000000] random: crng init done43machine # [ 0.000000] Machine model: linux,dummy-virt44machine # [ 0.000000] efi: UEFI not found.45machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT46machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]47machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f]48machine # [ 0.000000] Zone ranges:49machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]50machine # [ 0.000000] DMA32 empty51machine # [ 0.000000] Normal empty52machine # [ 0.000000] Device empty53machine # [ 0.000000] Movable zone start for each node54machine # [ 0.000000] Early memory node ranges55machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]56machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]57machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc0000058machine # [ 0.000000] psci: probing for conduit method from DT.59machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.60machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs61machine # [ 0.000000] psci: Trusted OS migration not required62machine # [ 0.000000] psci: SMC Calling Convention v1.163machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)64machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u31129665machine # [ 0.000000] Detected PIPT I-cache on CPU066machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)67machine # [ 0.000000] CPU features: detected: GICv3 CPU interface68machine # [ 0.000000] CPU features: detected: Spectre-v469machine # [ 0.000000] CPU features: detected: Spectre-BHB70machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_3871machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_2372machine # [ 0.000000] alternatives: applying boot alternatives73machine # [ 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/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/init regInfo=/nix/store/p6w8qvkayr27sk5lz18bq4ss8n2xalz3-closure-info/registration console=ttyAMA0,115200n8 console=tty074machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/p6w8qvkayr27sk5lz18bq4ss8n2xalz3-closure-info/registration", will be passed to user space.75machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes76machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)77machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)78machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB79machine # [ 0.000000] software IO TLB: area num 1.80machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)81machine # [ 0.000000] Fallback order for Node 0: 082machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 26214483machine # [ 0.000000] Policy zone: DMA84machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off85machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=186machine # [ 0.000000] allocated 2097152 bytes of page_ext87machine # [ 0.000000] ftrace: allocating 74894 entries in 294 pages88machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups89machine # [ 0.000000] rcu: Hierarchical RCU implementation.90machine # [ 0.000000] rcu: RCU event tracing is enabled.91machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.92machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.93machine # [ 0.000000] Rude variant of Tasks RCU enabled.94machine # [ 0.000000] Tracing variant of Tasks RCU enabled.95machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.96machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=197machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.98machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.99machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.100machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0101machine # [ 0.000000] GICv3: 256 SPIs implemented102machine # [ 0.000000] GICv3: 0 Extended SPIs implemented103machine # [ 0.000000] Root IRQ handler: gic_handle_irq104machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI105machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0106machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000107machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]108machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)109machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)110machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000111machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000112machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.113machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns114machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).115machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns116machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns117machine # [ 0.000031] arm-pv: using stolen time PV118machine # [ 0.000400] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)119machine # [ 0.000586] Console: colour dummy device 80x25120machine # [ 0.000594] printk: legacy console [tty0] enabled121machine # [ 0.000807] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)122machine # [ 0.000814] pid_max: default: 32768 minimum: 301123machine # [ 0.000897] LSM: initializing lsm=capability,landlock,yama,bpf,ima124machine # [ 0.001053] landlock: Up and running.125machine # [ 0.001056] Yama: becoming mindful.126machine # [ 0.001495] LSM support for eBPF active127machine # [ 0.001641] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)128machine # [ 0.001661] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)129machine # [ 0.002794] cacheinfo: Unable to detect cache hierarchy for CPU 0130machine # [ 0.003517] rcu: Hierarchical SRCU implementation.131machine # [ 0.003521] rcu: Max phase no-delay instances is 1000.132machine # [ 0.004836] fsl-mc MSI: its@8080000 domain created133machine # [ 0.004929] EFI services will not be available.134machine # [ 0.005001] smp: Bringing up secondary CPUs ...135machine # [ 0.005009] smp: Brought up 1 node, 1 CPU136machine # [ 0.005013] SMP: Total of 1 processors activated.137machine # [ 0.005015] CPU: All CPU(s) started at EL1138machine # [ 0.005030] CPU features: detected: Branch Target Identification139machine # [ 0.005036] CPU features: detected: ARMv8.4 Translation Table Level140machine # [ 0.005039] CPU features: detected: Instruction cache invalidation not required for I/D coherence141machine # [ 0.005042] CPU features: detected: Data cache clean to the PoU not required for I/D coherence142machine # [ 0.005046] CPU features: detected: Common not Private translations143machine # [ 0.005049] CPU features: detected: CRC32 instructions144machine # [ 0.005052] CPU features: detected: Data cache clean to Point of Deep Persistence145machine # [ 0.005056] CPU features: detected: Data cache clean to Point of Persistence146machine # [ 0.005059] CPU features: detected: Data independent timing control (DIT)147machine # [ 0.005062] CPU features: detected: E0PD148machine # [ 0.005065] CPU features: detected: Enhanced Counter Virtualization149machine # [ 0.005068] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)150machine # [ 0.005072] CPU features: detected: Enhanced Virtualization Traps151machine # [ 0.005075] CPU features: detected: Fine Grained Traps152machine # [ 0.005078] CPU features: detected: Generic authentication (architected QARMA5 algorithm)153machine # [ 0.005083] CPU features: detected: RCpc load-acquire (LDAPR)154machine # [ 0.005087] CPU features: detected: LSE atomic instructions155machine # [ 0.005090] CPU features: detected: Privileged Access Never156machine # [ 0.005092] CPU features: detected: PMUv3157machine # [ 0.005095] CPU features: detected: RAS Extension Support158machine # [ 0.005098] CPU features: detected: RASv1p1 Extension Support159machine # [ 0.005100] CPU features: detected: Random Number Generator160machine # [ 0.005103] CPU features: detected: Speculation barrier (SB)161machine # [ 0.005106] CPU features: detected: Stage-2 Force Write-Back162machine # [ 0.005109] CPU features: detected: TLB range maintenance instructions163machine # [ 0.005114] CPU features: detected: Speculative Store Bypassing Safe (SSBS)164machine # [ 0.005152] alternatives: applying system-wide alternatives165machine # [ 0.008285] CPU features: detected: BBM Level 2 without TLB conflict abort166machine # [ 0.008473] Memory: 893976K/1048576K available (24448K kernel code, 7090K rwdata, 26360K rodata, 4736K init, 1107K bss, 113284K reserved, 32768K cma-reserved)167machine # [ 0.008851] devtmpfs: initialized168machine # [ 0.010612] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)169machine # [ 0.010635] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).170machine # [ 0.010821] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL171machine # [ 0.010826] 0 pages in range for non-PLT usage172machine # [ 0.010827] 508288 pages in range for PLT usage173machine # [ 0.010927] pinctrl core: initialized pinctrl subsystem174machine # [ 0.011798] DMI not present or invalid.175machine # [ 0.014823] NET: Registered PF_NETLINK/PF_ROUTE protocol family176machine # [ 0.017320] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations177machine # [ 0.017478] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations178machine # [ 0.017640] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations179machine # [ 0.017668] audit: initializing netlink subsys (disabled)180machine # [ 0.018253] thermal_sys: Registered thermal governor 'fair_share'181machine # [ 0.018255] thermal_sys: Registered thermal governor 'bang_bang'182machine # [ 0.018259] thermal_sys: Registered thermal governor 'step_wise'183machine # [ 0.018262] thermal_sys: Registered thermal governor 'user_space'184machine # [ 0.018267] thermal_sys: Registered thermal governor 'power_allocator'185machine # [ 0.018293] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1186machine # [ 0.018302] cpuidle: using governor ladder187machine # [ 0.018308] cpuidle: using governor menu188machine # [ 0.018519] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.189machine # [ 0.018537] ASID allocator initialised with 65536 entries190machine # [ 0.019752] Serial: AMBA PL011 UART driver191machine # [ 0.025008] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1192machine # [ 0.025146] printk: console [ttyAMA0] enabled193machine # [ 0.153319] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages194machine # [ 0.153345] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page195machine # [ 0.153351] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages196machine # [ 0.153356] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page197machine # [ 0.153360] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages198machine # [ 0.153364] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page199machine # [ 0.153369] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages200machine # [ 0.153373] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page201machine # [ 0.161085] fbcon: Taking over console202machine # [ 0.161108] ACPI: Interpreter disabled.203machine # [ 0.167216] iommu: Default domain type: Translated204machine # [ 0.167229] iommu: DMA domain TLB invalidation policy: strict mode205machine # [ 0.168968] SCSI subsystem initialized206machine # [ 0.169696] usbcore: registered new interface driver usbfs207machine # [ 0.169734] usbcore: registered new interface driver hub208machine # [ 0.169753] usbcore: registered new device driver usb209machine # [ 0.170041] pps_core: LinuxPPS API ver. 1 registered210machine # [ 0.170047] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>211machine # [ 0.170057] PTP clock support registered212machine # [ 0.170105] EDAC MC: Ver: 3.0.0213machine # [ 0.174838] scmi_core: SCMI protocol bus registered214machine # [ 0.175923] FPGA manager framework215machine # [ 0.176933] vgaarb: loaded216machine # [ 0.180371] clocksource: Switched to clocksource arch_sys_counter217machine # [ 0.181082] VFS: Disk quotas dquot_6.6.0218machine # [ 0.181111] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)219machine # [ 0.183443] netfs: FS-Cache loaded220machine # [ 0.183573] pnp: PnP ACPI: disabled221machine # [ 0.189796] NET: Registered PF_INET protocol family222machine # [ 0.189970] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)223machine # [ 0.221455] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)224machine # [ 0.221514] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)225machine # [ 0.221543] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)226machine # [ 0.224791] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)227machine # [ 0.224873] TCP: Hash tables configured (established 8192 bind 8192)228machine # [ 0.224966] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)229machine # [ 0.225000] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)230machine # [ 0.225025] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)231machine # [ 0.225120] NET: Registered PF_UNIX/PF_LOCAL protocol family232machine # [ 0.225140] NET: Registered PF_XDP protocol family233machine # [ 0.225161] PCI: CLS 0 bytes, default 64234machine # [ 0.225399] Trying to unpack rootfs image as initramfs...235machine # [ 0.240432] kvm [1]: HYP mode not available236machine # [ 0.362235] Initialise system trusted keyrings237machine # [ 0.363027] workingset: timestamp_bits=42 max_order=18 bucket_order=0238machine # [ 0.364373] squashfs: version 4.0 (2009/01/31) Phillip Lougher239machine # [ 0.365154] 9p: Installing v9fs 9p2000 file system support240machine # [ 0.394142] Key type asymmetric registered241machine # [ 0.394178] Asymmetric key parser 'x509' registered242machine # [ 0.394262] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)243machine # [ 0.396522] io scheduler mq-deadline registered244machine # [ 0.396534] io scheduler kyber registered245machine # [ 0.405775] pl061_gpio 9030000.pl061: PL061 GPIO chip registered246machine # [ 0.407331] ledtrig-cpu: registered to indicate activity on CPUs247machine # [ 0.407783] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:248machine # [ 0.407802] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000249machine # [ 0.407814] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000250machine # [ 0.407836] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000251machine # [ 0.407860] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits252machine # [ 0.407888] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]253machine # [ 0.407967] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00254machine # [ 0.407976] pci_bus 0000:00: root bus resource [bus 00-ff]255machine # [ 0.407982] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]256machine # [ 0.407988] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]257machine # [ 0.407993] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]258machine # [ 0.408049] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint259machine # [ 0.408495] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint260machine # [ 0.408689] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]261machine # [ 0.408706] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]262machine # [ 0.408735] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]263machine # [ 0.408751] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]264machine # [ 0.409204] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint265machine # [ 0.409388] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]266machine # [ 0.409404] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]267machine # [ 0.409433] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]268machine # [ 0.409912] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint269machine # [ 0.410096] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]270machine # [ 0.410112] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]271machine # [ 0.410142] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]272machine # [ 0.410585] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint273machine # [ 0.410766] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]274machine # [ 0.410782] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]275machine # [ 0.410811] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]276machine # [ 0.410830] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]277machine # [ 0.411278] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint278machine # [ 0.411463] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]279machine # [ 0.411493] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]280machine # [ 0.411957] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint281machine # [ 0.412141] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]282machine # [ 0.412171] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]283machine # [ 0.412580] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint284machine # [ 0.412757] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]285machine # [ 0.413010] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint286machine # [ 0.413196] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]287machine # [ 0.413226] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]288machine # [ 0.461786] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint289machine # [ 0.462010] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]290machine # [ 0.462042] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]291machine # [ 0.462576] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint292machine # [ 0.462764] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]293machine # [ 0.462794] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]294machine # [ 0.463263] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint295machine # [ 0.463611] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]296machine # [ 0.463630] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]297machine # [ 0.463659] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]298machine # [ 0.464118] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint299machine # [ 0.464298] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]300machine # [ 0.464314] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]301machine # [ 0.464343] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]302machine # [ 0.464933] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned303machine # [ 0.464944] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned304machine # [ 0.464950] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned305machine # [ 0.464997] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned306machine # [ 0.465044] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned307machine # [ 0.465091] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned308machine # [ 0.465138] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned309machine # [ 0.465185] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned310machine # [ 0.465233] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned311machine # [ 0.465280] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned312machine # [ 0.465326] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned313machine # [ 0.465371] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned314machine # [ 0.465449] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned315machine # [ 0.465494] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned316machine # [ 0.465516] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned317machine # [ 0.465541] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned318machine # [ 0.465562] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned319machine # [ 0.465585] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned320machine # [ 0.465633] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned321machine # [ 0.465655] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned322machine # [ 0.465678] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned323machine # [ 0.465704] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned324machine # [ 0.465726] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned325machine # [ 0.465748] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned326machine # [ 0.465770] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned327machine # [ 0.465792] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned328machine # [ 0.465813] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned329machine # [ 0.465833] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned330machine # [ 0.465855] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned331machine # [ 0.465876] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned332machine # [ 0.465897] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned333machine # [ 0.465923] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]334machine # [ 0.465933] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]335machine # [ 0.465937] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]336machine # [ 0.466748] pci 0000:00:07.0: enabling device (0000 -> 0002)337machine # [ 0.528790] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)338machine # [ 0.539176] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)339machine # [ 0.542821] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)340machine # [ 0.544829] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)341machine # [ 0.559298] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)342machine # [ 0.561415] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)343machine # [ 0.564850] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)344machine # [ 0.567614] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)345machine # [ 0.577704] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)346machine # [ 0.579993] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)347machine # [ 0.583902] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)348machine # [ 0.598991] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled349machine # [ 0.601774] msm_serial: driver initialized350machine # [ 0.601927] SuperH (H)SCI(F) driver initialized351machine # [ 0.601982] STM32 USART driver initialized352machine # [ 0.635466] loop: module loaded353machine # [ 0.635702] virtio_blk virtio2: 1/0/0 default/read/poll queues354machine # [ 0.636533] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)355machine # [ 0.642318] megasas: 07.734.00.00-rc1356machine # [ 0.643043] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]357machine # [ 0.645048] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000358machine # [ 0.645107] Intel/Sharp Extended Query Table at 0x0031359machine # [ 0.655884] Using buffer write method360machine # [ 0.656005] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]361machine # [ 0.665668] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000362machine # [ 0.665723] Intel/Sharp Extended Query Table at 0x0031363machine # [ 0.669378] Using buffer write method364machine # [ 0.669418] Concatenating MTD devices:365machine # [ 0.669422] (0): "0.flash"366machine # [ 0.669426] (1): "0.flash"367machine # [ 0.669430] into device "0.flash"368machine # [ 0.967096] Freeing initrd memory: 26424K369machine # [ 0.973500] tun: Universal TUN/TAP device driver, 1.6370machine # [ 0.977761] thunder_xcv, ver 1.0371machine # [ 0.977806] thunder_bgx, ver 1.0372machine # [ 0.977829] nicpf, ver 1.0373machine # [ 0.978398] e1000: Intel(R) PRO/1000 Network Driver374machine # [ 0.978405] e1000: Copyright (c) 1999-2006 Intel Corporation.375machine # [ 0.978437] e1000e: Intel(R) PRO/1000 Network Driver376machine # [ 0.978447] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.377machine # [ 0.978476] igb: Intel(R) Gigabit Ethernet Network Driver378machine # [ 0.978482] igb: Copyright (c) 2007-2014 Intel Corporation.379machine # [ 0.978504] igbvf: Intel(R) Gigabit Virtual Function Network Driver380machine # [ 0.978510] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.381machine # [ 0.978651] sky2: driver version 1.30382machine # [ 0.980349] usbcore: registered new interface driver usb-storage383machine # [ 0.980471] usbcore: registered new interface driver usbserial_generic384machine # [ 0.980488] usbserial: USB Serial support registered for generic385machine # [ 0.981099] hv_vmbus: registering driver hyperv_keyboard386machine # [ 0.982417] ehci-pci 0000:00:07.0: EHCI Host Controller387machine # [ 0.982464] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1388machine # [ 0.982698] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000389machine # [ 0.995316] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00390machine # [ 0.995717] hub 1-0:1.0: USB hub found391machine # [ 0.995739] hub 1-0:1.0: 6 ports detected392machine # [ 0.998306] rtc-pl031 9010000.pl031: registered as rtc0393machine # [ 0.998340] rtc-pl031 9010000.pl031: setting system clock to 2026-09-16T02:57:33 UTC (1789527453)394machine # [ 0.998755] i2c_dev: i2c /dev entries driver395machine # [ 1.004294] sdhci: Secure Digital Host Controller Interface driver396machine # [ 1.004309] sdhci: Copyright(c) Pierre Ossman397machine # [ 1.004574] Synopsys Designware Multimedia Card Interface Driver398machine # [ 1.004943] sdhci-pltfm: SDHCI platform and OF driver helper399machine # [ 1.009242] hid: raw HID events driver (C) Jiri Kosina400machine # [ 1.009501] usbcore: registered new interface driver usbhid401machine # [ 1.009509] usbhid: USB HID core driver402machine # [ 1.012478] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available403machine # [ 1.015116] drop_monitor: Initializing network drop monitor service404machine # [ 1.015278] NET: Registered PF_INET6 protocol family405machine # [ 1.017278] Segment Routing with IPv6406machine # [ 1.017299] In-situ OAM (IOAM) with IPv6407machine # [ 1.017328] NET: Registered PF_PACKET protocol family408machine # [ 1.019194] 9pnet: Installing 9P2000 support409machine # [ 1.019248] Key type dns_resolver registered410machine # [ 1.026239] registered taskstats version 1411machine # [ 1.026389] Loading compiled-in X.509 certificates412machine # [ 1.035099] Demotion targets for Node 0: null413machine # [ 1.035232] Key type .fscrypt registered414machine # [ 1.035242] Key type fscrypt-provisioning registered415machine # [ 1.035339] ima: No TPM chip found, activating TPM-bypass!416machine # [ 1.035358] ima: Allocated hash algorithm: sha1417machine # [ 1.035380] ima: No architecture policies found418machine # [ 1.039887] input: gpio-keys as /devices/platform/gpio-keys/input/input0419machine # [ 1.058793] clk: Disabling unused clocks420machine # [ 1.058832] PM: genpd: Disabling unused power domains421machine # [ 1.063226] Freeing unused kernel memory: 4736K422machine # [ 1.063440] Run /init as init process423machine # [ 1.079993] systemd[1]: Successfully made /usr/ read-only.424machine # [ 1.241694] usb 1-1: new high-speed USB device number 2 using ehci-pci425machine # [ 1.394352] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1426machine # [ 1.415021] systemd[1]: systemd 262-f3880de 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)427machine # [ 1.427506] systemd[1]: Detected virtualization qemu.428machine # [ 1.429842] systemd[1]: Detected architecture arm64.429machine # [ 1.431820] systemd[1]: Running in initrd.430machine # [ 1.434611] systemd[1]: Initializing machine ID from random generator.431machine # [ 1.437694] systemd[1]: Hostname set to <machine>.432machine # [ 1.489909] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0433machine # [ 1.604935] systemd[1]: bpf-restrict-fs: LSM BPF program attached434machine # [ 1.613830] usb 1-2: new high-speed USB device number 3 using ehci-pci435machine # [ 1.662275] systemd[1]: Queued start job for default target Initrd Default Target.436machine # [ 1.671829] systemd[1]: Created slice Slice /system/modprobe.437machine # [ 1.672855] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.438machine # [ 1.674063] systemd[1]: Expecting device /dev/disk/by-label/nixos...439machine # [ 1.674882] systemd[1]: Reached target Path Units.440machine # [ 1.675507] systemd[1]: Reached target Slice Units.441machine # [ 1.676184] systemd[1]: Reached target Swaps.442machine # [ 1.676761] systemd[1]: Reached target Timer Units.443machine # [ 1.677491] systemd[1]: Listening on D-Bus System Message Bus Socket.444machine # [ 1.678693] systemd[1]: Listening on Journal Socket (/dev/log).445machine # [ 1.679610] systemd[1]: Listening on Journal Sockets.446machine # [ 1.680345] systemd[1]: Listening on udev Kernel Socket.447machine # [ 1.681043] systemd[1]: Reached target Socket Units.448machine # [ 1.683236] systemd[1]: Starting Create List of Static Device Nodes...449machine # [ 1.684203] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs450machine # [ 1.691202] systemd[1]: Mounting Kernel Configuration File System...451machine # [ 1.701974] systemd[1]: Starting Journal Service...452machine # [ 1.727165] systemd[1]: Starting Load Kernel Modules...453machine # [ 1.728090] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os454machine # [ 1.751508] systemd-journald[72]: Collecting audit messages is disabled.455machine # [ 1.752891] systemd[1]: Starting Coldplug All udev Devices...456machine # [ 1.757828] systemd[1]: Finished Create List of Static Device Nodes.457machine # [ 1.758621] systemd[1]: Mounted Kernel Configuration File System.458machine # [ 1.767742] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2459machine # [ 1.767900] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0460machine # [ 1.793922] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...461machine # [ 1.842443] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.462machine # [ 1.845114] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.463machine # [ 1.847890] systemd[1]: Starting Create Static Device Nodes in /dev...464machine # [ 1.861163] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev465machine # [ 1.867731] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0466machine # [ 1.867991] [drm] features: -virgl +edid -resource_blob -host_visible467machine # [ 1.868001] [drm] features: -context_init468machine # [ 1.868743] [drm] number of scanouts: 1469machine # [ 1.868761] [drm] number of cap sets: 0470machine # [ 1.898073] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic471machine # [ 1.898109] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0472machine # [ 1.909760] systemd[1]: Finished Create Static Device Nodes in /dev.473machine # [ 1.910177] systemd[1]: Reached target Preparation for Local File Systems.474machine # [ 1.910208] systemd[1]: Reached target Local File Systems.475machine # [ 1.922077] systemd[1]: Starting Rule-based Manager for Device Events and Files...476machine # [ 1.926985] Console: switching to colour frame buffer device 160x50477machine # [ 1.940359] systemd[1]: Started Journal Service.478machine # [ 1.930391] systemd-modules-load[74]: Inserted module 'dm_mod'479machine # [ 1.931735] systemd-modules-load[74]: Module 'virtio_balloon' is built in480machine # [ 1.936683] systemd-modules-load[74]: Module 'virtio_console' is built in481machine # [ 1.958264] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device482machine # [ 1.953670] systemd-modules-load[74]: Inserted module 'virtio_gpu'483machine # [ 1.955827] systemd-modules-load[74]: Module 'virtio_rng' is built in484machine # [ 1.960149] systemd[1]: Starting Create System Files and Directories...485machine # [ 1.968242] systemd[1]: Finished Load Kernel Modules.486machine # [ 1.990940] systemd[1]: Starting Apply Kernel Variables...487machine # [ 2.026426] systemd-udevd[78]: Using default interface naming scheme 'v261'.488machine # [ 2.028061] systemd[1]: Finished Create System Files and Directories.489machine # [ 2.037227] systemd[1]: Finished Apply Kernel Variables.490machine # [ 2.061312] systemd[1]: Started Rule-based Manager for Device Events and Files.491machine # [ 2.152125] systemd[1]: Starting Virtual Console Setup...492machine # [ 2.224603] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.493machine # [ 2.228460] systemd[1]: Finished Virtual Console Setup.494machine # [ 2.848456] systemd[1]: Finished Coldplug All udev Devices.495machine # [ 2.852166] systemd[1]: Reached target System Initialization.496machine # [ 2.853114] systemd[1]: Reached target Basic System.497machine # [ 3.009166] (udev-worker)[94]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.498machine # [ 3.013819] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.499machine # [ 3.069114] systemd[1]: Found device /dev/disk/by-label/nixos.500machine # [ 3.071639] systemd[1]: Reached target Initrd Root Device.501machine # [ 3.075900] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...502machine # [ 3.130658] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks503machine # [ 3.138379] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.504machine # [ 3.148298] systemd[1]: Mounting /sysroot...505machine # [ 3.197508] EXT4-fs (vda): mounted filesystem 5b4d64e5-434a-471e-934f-146c0ad6b8ef r/w with ordered data mode. Quota mode: none.506machine # [ 3.185137] systemd[1]: Mounted /sysroot.507machine # [ 3.186256] systemd[1]: Reached target Initrd Root File System.508machine # [ 3.190107] systemd[1]: Starting Mountpoints Configured in the Real Root...509machine # [ 3.216277] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload.510machine # [ 3.222487] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)...511machine # [ 3.227190] systemd[1]: Reloading...512machine # [ 3.414696] systemd[1]: Reloading finished in 189 ms.513machine # [ 3.451515] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace...514machine # [ 3.455907] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace...515machine # [ 3.460594] systemd[1]: initrd-parse-etc.service: Deactivated successfully.516machine # [ 3.464414] systemd[1]: Finished Mountpoints Configured in the Real Root.517machine # [ 3.465376] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.518machine # [ 3.740251] systemd[1]: Mounting /sysroot/nix/.ro-store...519machine # [ 3.749544] systemd[1]: Mounting /sysroot/nix/.rw-store...520machine # [ 3.764519] systemd[1]: Mounting /sysroot/run...521machine # [ 3.799338] systemd[1]: Mounting /sysroot/tmp/shared...522machine # [ 3.803188] systemd[1]: Mounting /sysroot/tmp/xchg...523machine # [ 3.846130] systemd[1]: Mounted /sysroot/nix/.rw-store.524machine # [ 3.894153] fuse: init (API version 7.45)525machine # [ 3.901888] virtiofs virtio6: discovered new tag: nix-store526machine # [ 3.902647] virtiofs virtio6: virtio_fs_setup_dax: No cache capability527machine # [ 3.889753] systemd[1]: Starting rw-sysroot-nix-store.service...528machine # [ 3.919286] virtiofs virtio7: discovered new tag: shared529machine # [ 3.920055] virtiofs virtio7: virtio_fs_setup_dax: No cache capability530machine # [ 3.905838] systemd[1]: Mounted /sysroot/run.531machine # [ 3.926243] virtiofs virtio8: discovered new tag: xchg532machine # [ 3.926970] virtiofs virtio8: virtio_fs_setup_dax: No cache capability533machine # [ 3.925022] systemd[1]: Mounted /sysroot/tmp/shared.534machine # [ 3.929572] systemd[1]: Mounted /sysroot/nix/.ro-store.535machine # [ 3.931965] systemd[1]: Mounted /sysroot/tmp/xchg.536machine # [ 3.949901] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.537machine # [ 3.951316] systemd[1]: Finished rw-sysroot-nix-store.service.538machine # [ 4.388258] (udev-worker)[96]: mtd0ro: Failed to find and pin callout binary "/nix/store/myyzs1saangna5kpwllaxsv0wflpwyd3-systemd-262-f3880de/lib/udev/mtd_probe": No such file or directory539machine # [ 4.405540] (udev-worker)[96]: mtd0ro: /etc/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory540machine # [ 4.428111] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.541machine # [ 4.429254] systemd[1]: Stopped Virtual Console Setup.542machine # [ 4.432174] systemd[1]: Stopping Virtual Console Setup...543machine # [ 4.433001] systemd[1]: Starting Virtual Console Setup...544machine # [ 4.444854] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.545machine # [ 4.446338] systemd[1]: Stopped Virtual Console Setup.546machine # [ 4.449294] systemd[1]: Starting Virtual Console Setup...547machine # [ 4.470825] systemd-vconsole-setup[155]: Configuration of first virtual console was skipped, ignoring remaining ones.548machine # [ 4.474320] systemd[1]: Finished Virtual Console Setup.549machine # [ 4.743462] systemd[1]: Mounting /sysroot/nix/store...550machine # [ 4.816951] systemd[1]: Mounted /sysroot/nix/store.551machine # [ 4.820284] systemd[1]: Reached target Initrd File Systems.552machine # [ 4.823338] systemd[1]: Starting Find NixOS closure...553machine # [ 4.832350] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...554machine # [ 4.869106] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.555machine # [ 4.872859] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.556machine # [ 4.888504] systemd[1]: Finished Find NixOS closure.557machine # [ 4.891730] systemd[1]: Reached target Initrd Default Target.558machine # [ 4.896349] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...559machine # [ 4.926345] systemd[1]: Stopped target Initrd Default Target.560machine # [ 4.928418] systemd[1]: Stopped target Basic System.561machine # [ 4.929836] systemd[1]: Stopped target Initrd Root Device.562machine # [ 4.932247] systemd[1]: Stopped target Path Units.563machine # [ 4.936522] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.564machine # [ 4.938070] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.565machine # [ 4.940956] systemd[1]: Stopped target Slice Units.566machine # [ 4.944182] systemd[1]: Stopped target Socket Units.567machine # [ 4.945223] systemd[1]: Stopped target System Initialization.568machine # [ 4.949015] systemd[1]: Stopped target Swaps.569machine # [ 4.952496] systemd[1]: Stopped target Timer Units.570machine # [ 4.954335] systemd[1]: dbus.socket: Deactivated successfully.571machine # [ 4.958872] systemd[1]: Closed D-Bus System Message Bus Socket.572machine # [ 4.961544] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.573machine # [ 4.966929] systemd[1]: Stopped Find NixOS closure.574machine # [ 4.971028] systemd[1]: Starting rw-sysroot-nix-store.service...575machine # [ 4.977518] systemd[1]: systemd-sysctl.service: Deactivated successfully.576machine # [ 4.981930] systemd[1]: Stopped Apply Kernel Variables.577machine # [ 4.982874] systemd[1]: systemd-modules-load.service: Deactivated successfully.578machine # [ 4.986593] systemd[1]: Stopped Load Kernel Modules.579machine # [ 4.987382] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.580machine # [ 4.990705] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.581machine # [ 4.992437] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.582machine # [ 4.994946] systemd[1]: Stopped Create System Files and Directories.583machine # [ 4.996968] systemd[1]: Stopped target Local File Systems.584machine # [ 5.000394] systemd[1]: Stopped target Preparation for Local File Systems.585machine # [ 5.001451] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.586machine # [ 5.004242] systemd[1]: Stopped Coldplug All udev Devices.587machine # [ 5.005089] systemd[1]: Stopping Rule-based Manager for Device Events and Files...588machine # [ 5.006385] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.589machine # [ 5.007494] systemd[1]: Stopped Virtual Console Setup.590machine # [ 5.008384] systemd[1]: initrd-cleanup.service: Deactivated successfully.591machine # [ 5.009320] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.592machine # [ 5.010243] systemd[1]: systemd-udevd.service: Deactivated successfully.593machine # [ 5.011165] systemd[1]: Stopped Rule-based Manager for Device Events and Files.594machine # [ 5.016266] systemd[1]: systemd-udevd.service: Consumed 1.470s CPU time over 3.081s wall clock time, 22.2M memory peak.595machine # [ 5.017742] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.596machine # [ 5.019104] systemd[1]: Finished rw-sysroot-nix-store.service.597machine # [ 5.020655] systemd[1]: Starting Cleanup udev Database...598machine # [ 5.024358] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.599machine # [ 5.025519] systemd[1]: Stopped Create Static Device Nodes in /dev.600machine # [ 5.028143] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.601machine # [ 5.029342] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.602machine # [ 5.032186] systemd[1]: kmod-static-nodes.service: Deactivated successfully.603machine # [ 5.036133] systemd[1]: Stopped Create List of Static Device Nodes.604machine # [ 5.061526] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.605machine # [ 5.064478] systemd[1]: Finished Cleanup udev Database.606machine # [ 5.065296] systemd[1]: Reached target Switch Root.607machine # [ 5.067055] systemd[1]: Starting NixOS Activation...608machine # [ 5.155012] initrd-nixos-activation-start[178]: booting system configuration /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test609machine # [ 5.189815] initrd-nixos-activation-start[178]: running activation script...610machine # [ 5.431093] initrd-nixos-activation-start[201]: setting up /etc...611machine # [ 5.553064] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.612machine # [ 5.555963] systemd[1]: Finished NixOS Activation.613machine # [ 5.557261] systemd[1]: Starting Switch Root...614machine # [ 5.580417] systemd[1]: Switching root.615machine # [ 5.771949] systemd-journald[72]: Received SIGTERM from PID 1 (systemd).616machine # [ 6.302137] systemd[1]: systemd 262-f3880de 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)617machine # [ 6.315824] systemd[1]: Detected virtualization qemu.618machine # [ 6.320492] systemd[1]: Detected architecture arm64.619machine # [ 6.323139] systemd[1]: Detected first boot.620machine # [ 6.329299] systemd[1]: Initializing machine ID from random generator.621machine # [ 6.561824] systemd[1]: bpf-restrict-fs: LSM BPF program attached622machine # [ 6.731588] systemd[1]: Applying preset policy.623machine # [ 6.978450] systemd[1]: Populated /etc with preset unit settings.624machine # [ 7.200570] systemd[1]: initrd-switch-root.service: Deactivated successfully.625machine # [ 7.202039] systemd[1]: Stopped initrd-switch-root.service.626machine # [ 7.205451] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.627machine # [ 7.208704] systemd[1]: Created slice Slice /system/getty.628machine # [ 7.210924] systemd[1]: Created slice User and Session Slice.629machine # [ 7.212348] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.630machine # [ 7.214396] systemd[1]: Started Forward Password Requests to Wall Directory Watch.631machine # [ 7.217048] systemd[1]: Expecting device /dev/hvc0...632machine # [ 7.218163] systemd[1]: Expecting device /dev/ttyAMA0...633machine # [ 7.218499] systemd[1]: Reached target Local Encrypted Volumes.634machine # [ 7.218782] systemd[1]: Stopped target initrd-fs.target.635machine # [ 7.219044] systemd[1]: Stopped target initrd-root-fs.target.636machine # [ 7.219287] systemd[1]: Stopped target initrd-switch-root.target.637machine # [ 7.219553] systemd[1]: Reached target Virtual Machines and Containers.638machine # [ 7.219813] systemd[1]: Reached target Path Units.639machine # [ 7.220049] systemd[1]: Reached target Remote File Systems.640machine # [ 7.220278] systemd[1]: Reached target Slice Units.641machine # [ 7.220509] systemd[1]: Reached target Swaps.642machine # [ 7.229302] systemd[1]: Listening on Query the User Interactively for a Password.643machine # [ 7.232409] systemd[1]: Listening on Process Core Dump Socket.644machine # [ 7.234656] systemd[1]: Listening on Credential Encryption/Decryption.645machine # [ 7.236879] systemd[1]: Listening on Factory Reset Management.646machine # [ 7.238197] systemd[1]: Listening on Hostname Service Socket.647machine # [ 7.242372] systemd[1]: Starting Journal Log Access Socket...648machine # [ 7.244577] systemd[1]: Listening on Journal Audit Socket.649machine # [ 7.248307] systemd[1]: Listening on Console Output Muting Service Socket.650machine # [ 7.250138] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.651machine # [ 7.252163] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os652machine # [ 7.254954] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki653machine # [ 7.261256] systemd[1]: Listening on Disk Repartitioning Service Socket.654machine # [ 7.262771] systemd[1]: Listening on udev Varlink Socket.655machine # [ 7.266430] systemd[1]: Mounting Huge Pages File System...656machine # [ 7.274651] systemd[1]: Mounting POSIX Message Queue File System...657machine # [ 7.284031] systemd[1]: Mounting Kernel Debug File System...658machine # [ 7.297267] systemd[1]: Mounting Kernel Trace File System...659machine # [ 7.311383] systemd[1]: Starting Create List of Static Device Nodes...660machine # [ 7.313576] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs661machine # [ 7.334151] systemd[1]: Mounting Kernel Configuration File System...662machine # [ 7.336472] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm663machine # [ 7.346161] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore664machine # [ 7.349044] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse665machine # [ 7.366483] systemd[1]: Mounting FUSE Control File System...666machine # [ 7.367667] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67667machine # [ 7.394948] systemd[1]: Starting Journal Service...668machine # [ 7.415041] systemd[1]: Starting Load Kernel Modules...669machine # [ 7.434955] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...670machine # [ 7.462191] systemd[1]: Starting Remount Root and Kernel File Systems...671machine # [ 7.462614] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os672machine # [ 7.480416] systemd[1]: Starting Coldplug All udev Devices...673machine # [ 7.496489] systemd[1]: Listening on Journal Log Access Socket.674machine # [ 7.503539] systemd[1]: Mounted Huge Pages File System.675machine # [ 7.505049] systemd-journald[272]: Collecting audit messages is enabled.676machine # [ 7.509948] systemd[1]: Mounted POSIX Message Queue File System.677machine # [ 7.518026] systemd[1]: Mounted Kernel Debug File System.678machine # [ 7.518532] systemd[1]: Mounted Kernel Trace File System.679machine # [ 7.509394] systemd[1]: Queued start job for default target Multi-User System.680machine # [ 7.512875] systemd[1]: systemd-journald.service: Deactivated successfully.681machine # [ 7.514287] systemd-modules-load[273]: Module 'atkbd' is built in682machine # [ 7.515368] systemd-modules-load[273]: Module 'loop' is built in683machine # [ 7.536288] systemd[1]: Finished Create List of Static Device Nodes.684machine # [ 7.537021] systemd[1]: Started Journal Service.685machine # [ 7.531896] systemd[1]: Finished Load Kernel Modules.686machine # [ 7.546697] systemd[1]: Starting Firewall...687machine # [ 7.560904] systemd[1]: Starting Apply Kernel Variables...688machine # [ 7.589861] EXT4-fs (vda): re-mounted 5b4d64e5-434a-471e-934f-146c0ad6b8ef.689machine # [ 7.578718] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...690machine # [ 7.597077] systemd-oomd[274]: No swap; memory pressure usage will be degraded691machine # [ 7.606406] systemd[1]: Mounted Kernel Configuration File System.692machine # [ 7.617258] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.693machine # [ 7.619459] systemd[1]: Mounted FUSE Control File System.694machine # [ 7.624942] systemd[1]: Finished Remount Root and Kernel File Systems.695machine # [ 7.648326] systemd[1]: Listening on Disk Image Download Service Socket.696machine # [ 7.658838] systemd[1]: Starting Flush Journal to Persistent Storage...697machine # [ 7.668175] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore698machine # [ 7.671387] systemd[1]: Starting Load/Save OS Random Seed...699machine # [ 7.676340] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os700machine # [ 7.768655] systemd-journald[272]: Received client request to flush runtime journal.701machine # [ 7.808468] systemd[1]: Finished Load/Save OS Random Seed.702machine # [ 7.809485] systemd[1]: Reached target First Boot Complete.703machine # [ 7.810345] systemd[1]: Finished Apply Kernel Variables.704machine # [ 7.817513] systemd[1]: Finished Flush Journal to Persistent Storage.705machine # [ 7.944896] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.706machine # [ 7.960695] systemd[1]: Starting Create Static Device Nodes in /dev...707machine # [ 8.280874] systemd[1]: Finished Create Static Device Nodes in /dev.708machine # [ 8.283013] systemd[1]: Reached target Preparation for Local File Systems.709machine # [ 8.292702] systemd[1]: Mounting /run/wrappers...710machine # [ 8.296938] systemd[1]: Starting Rule-based Manager for Device Events and Files...711machine # [ 8.368838] systemd[1]: Mounted /run/wrappers.712machine # [ 8.369671] systemd[1]: Reached target Local File Systems.713machine # [ 8.378906] systemd[1]: Listening on Boot Loader Control Service Socket.714machine # [ 8.386279] systemd[1]: Starting Create SUID/SGID Wrappers...715machine # [ 8.387213] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.716machine # [ 8.394837] systemd[1]: Starting Save Transient machine-id to Disk...717machine # [ 8.400267] systemd[1]: Starting Create System Files and Directories...718machine # [ 8.470071] systemd-udevd[311]: Using default interface naming scheme 'v261'.719machine # [ 8.622425] systemd[1]: Started Rule-based Manager for Device Events and Files.720machine # [ 8.629958] systemd[1]: Finished Create System Files and Directories.721machine # [ 8.648586] systemd[1]: Starting Rebuild Journal Catalog...722machine # [ 8.656221] systemd[1]: Starting Record System Boot/Shutdown in UTMP...723machine # [ 8.696966] systemd[1]: Finished Save Transient machine-id to Disk.724machine # [ 8.781136] systemd[1]: Finished Coldplug All udev Devices.725machine # [ 8.787593] systemd[1]: Finished Record System Boot/Shutdown in UTMP.726machine # [ 8.826387] systemd[1]: Finished Rebuild Journal Catalog.727machine # [ 8.833928] systemd[1]: Starting Update is Completed...728machine # [ 8.903295] systemd[1]: Finished Update is Completed.729machine # [ 9.109749] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs730machine # [ 9.134620] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse731machine # [ 9.183892] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.732machine # [ 9.196724] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.733machine # [ 9.200194] systemd[1]: Finished Create SUID/SGID Wrappers.734machine # [ 9.204634] systemd[1]: Reached target System Initialization.735machine # [ 9.205566] systemd[1]: Started Discard unused filesystem blocks once a week.736machine # [ 9.206598] systemd[1]: Started Daily Cleanup of Temporary Directories.737machine # [ 9.207530] systemd[1]: Reached target Timer Units.738machine # [ 9.218981] systemd[1]: Listening on D-Bus System Message Bus Socket.739machine # [ 9.219939] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.740machine # [ 9.226106] systemd[1]: Reached target Socket Units.741machine # [ 9.226899] systemd[1]: Reached target Basic System.742machine # [ 9.227627] systemd[1]: Starting Import lastlog data into lastlog2 database...743machine # [ 9.235326] systemd[1]: Starting Name Service Cache Daemon (nsncd)...744machine # [ 9.238744] systemd[1]: Starting Post-Boot Actions...745machine # [ 9.251536] systemd[1]: Started Reset console on configuration changes.746machine # [ 9.280289] systemd[1]: Starting resolvconf update...747machine # [ 9.342741] systemd[1]: Starting D-Bus System Message Bus...748machine # [ 9.384532] nsncd[424]: Sep 16 02:57:41.897 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"749machine # [ 9.386698] systemd[1]: Started Name Service Cache Daemon (nsncd).750machine # [ 9.403146] systemd[1]: Reached target Host and Network Name Lookups.751machine # [ 9.409712] systemd[1]: Reached target User and Group Name Lookups.752machine # [ 9.443404] systemd[1]: Starting User Login Management...753machine # [ 9.458814] systemd[1]: Finished Post-Boot Actions.754machine # [ 9.501537] systemd[1]: Finished Import lastlog data into lastlog2 database.755machine # [ 9.564205] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.756machine # [ 9.573359] dbus-broker-launch[431]: Looking up NSS user entry for 'systemd-timesync'...757machine # [ 9.584877] dbus-broker-launch[431]: NSS returned no entry for 'systemd-timesync'758machine # [ 9.586054] dbus-broker-launch[431]: Invalid user-name in /nix/store/vblc6s1jf416nl6scqx9knad4kcsfpz5-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"759machine # [ 9.651162] systemd[1]: Started D-Bus System Message Bus.760machine # [ 9.667864] systemd-logind[447]: New seat seat0.761machine # [ 9.675969] systemd[1]: Started User Login Management.762machine # [ 9.689260] systemd[1]: Starting linger-users.service...763machine # [ 9.711463] dbus-broker-launch[431]: Ready764machine # [ 9.716908] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.765machine # [ 9.727324] systemd[1]: Started backdoor.service.766machine # [ 9.773641] systemd[1]: Stopped target Host and Network Name Lookups.767machine # [ 9.779717] systemd[1]: Stopping Host and Network Name Lookups...768machine # [ 9.786182] systemd[1]: Stopped target User and Group Name Lookups.769machine # [ 9.787291] systemd[1]: Stopping User and Group Name Lookups...770machine # [ 9.801130] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...771machine # [ 9.802136] systemd[1]: nscd.service: Deactivated successfully.772machine # [ 9.803008] systemd[1]: Stopped Name Service Cache Daemon (nsncd).773machine # [ 9.840645] systemd[1]: Starting Name Service Cache Daemon (nsncd)...774machine # [ 9.904366] systemd[1]: Created slice Slice /user/1001.775machine # connecting to host...776machine # [ 9.919168] systemd[1]: Starting User Runtime Directory /run/user/1001...777machine # [ 9.958846] nsncd[513]: Sep 16 02:57:42.474 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"778machine: Guest shell says: b'Spawning backdoor root shell...\n'779machine # [ 9.972398] systemd[1]: Started Name Service Cache Daemon (nsncd).780machine: connected to guest root shell781machine # [ 9.982411] systemd[1]: linger-users.service: Deactivated successfully.782machine: (connecting took 10.28 seconds)783machine: (finished: waiting for the VM to finish booting, in 10.83 seconds)784machine # [ 9.987810] systemd[1]: Finished linger-users.service.785machine # [ 9.994421] systemd[1]: Reached target Host and Network Name Lookups.786machine # [ 9.995361] systemd[1]: Reached target User and Group Name Lookups.787machine # [ 10.022176] systemd[1]: Finished resolvconf update.788machine # [ 10.032672] (udev-worker)[385]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.789machine # [ 10.048411] systemd[1]: Starting DHCP Client...790machine # [ 10.049214] (udev-worker)[385]: Network interface NamePolicy= disabled on kernel command line.791machine # [ 10.096507] systemd[1]: Finished User Runtime Directory /run/user/1001.792machine # [ 10.143008] systemd[1]: Starting User Manager for UID 1001...793machine # [ 10.300526] systemd[1]: Condition check resulted in Virtio network device being skipped.794machine # [ 10.341826] systemd-logind[447]: Watching system buttons on /dev/input/event0 (gpio-keys)795machine # [ 10.443918] (systemd)[560]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0)796machine # [ 10.481676] systemd-logind[447]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'.797machine # [ 10.550280] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy798machine # [ 10.654007] mousedev: PS/2 mouse device common for all mice799machine # [ 10.859559] systemd[560]: Queued start job for default target Main User Target.800machine # [ 10.895193] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy801machine # [ 10.944422] systemd[560]: Created slice User Application Slice.802machine # [ 10.945408] systemd[560]: Started Daily Cleanup of User's Temporary Directories.803machine # [ 11.000233] systemd[560]: Reached target Paths.804machine # [ 11.032188] systemd[560]: Reached target Timers.805machine # [ 11.033277] systemd[560]: Starting D-Bus User Message Bus Socket...806machine # [ 11.076927] systemd[560]: Starting Create User Files and Directories...807machine # [ 11.078179] systemd[560]: Finished Create User Files and Directories.808machine # [ 11.079118] systemd[560]: Listening on D-Bus User Message Bus Socket.809machine # [ 11.080005] systemd[560]: Reached target Sockets.810machine # [ 11.121833] systemd[560]: Reached target Basic System.811machine # [ 11.123018] systemd[1]: Started User Manager for UID 1001.812machine # [ 11.123850] systemd[560]: Starting Run user-specific NixOS activation...813machine # [ 11.170906] systemd-logind[447]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)814machine # [ 11.197661] systemd[560]: Finished Run user-specific NixOS activation.815machine # [ 11.198724] systemd[560]: Reached target Main User Target.816machine # [ 11.199474] systemd[560]: Startup finished in 552ms.817machine # [ 11.434644] dhcpcd[583]: dhcpcd-10.3.2 starting818machine # [ 11.458760] dhcpcd[605]: dev: loaded udev819machine # [ 11.513364] 8021q: 802.1Q VLAN Support v1.8820machine # [ 11.588723] cfg80211: Loading compiled-in X.509 certificates for regulatory database821machine # [ 11.596553] systemd[1]: Finished Firewall.822machine # [ 11.598452] systemd[1]: Reached target Preparation for Network.823machine # [ 11.628266] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'824machine # [ 11.628816] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'825machine # [ 11.631416] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2826machine # [ 11.631805] cfg80211: failed to load regulatory.db827machine # [ 11.621203] systemd[1]: Starting Address configuration of eth1...828machine # [ 11.634536] systemd[1]: Starting Extra networking commands....829machine # [ 12.086090] 8021q: adding VLAN 0 to HW filter on device eth1830machine # [ 12.222980] network-addresses-eth1-start[617]: adding address 192.168.1.1/24... done831machine # [ 12.256092] 8021q: adding VLAN 0 to HW filter on device eth0832machine # [ 12.277230] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3833machine # [ 12.269117] dhcpcd[605]: eth0: waiting for carrier834machine # [ 12.270043] dhcpcd[605]: eth0: carrier acquired835machine # [ 12.331124] network-addresses-eth1-start[617]: adding address 2001:db8:1::1/64... done836machine # [ 12.403649] dhcpcd[605]: DUID 00:01:00:01:32:3c:c2:28:52:54:00:12:34:56837machine # [ 12.418241] dhcpcd[605]: eth0: IAID 00:12:34:56838machine # [ 12.419096] dhcpcd[605]: eth0: adding address fe80::5054:ff:fe12:3456839machine # [ 12.484521] systemd[1]: Finished Address configuration of eth1.840machine # [ 12.742641] systemd[1]: Starting Virtual Console Setup...841machine # [ 12.762736] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.842machine # [ 12.800258] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.843machine # [ 12.801507] systemd[1]: Stopped Virtual Console Setup.844machine # [ 12.811136] systemd[1]: Starting Virtual Console Setup...845machine # [ 12.823033] systemd-logind[447]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)846machine # [ 12.953974] systemd-vconsole-setup[667]: Configuration of first virtual console was skipped, ignoring remaining ones.847machine # [ 12.962579] systemd[1]: Finished Virtual Console Setup.848machine # [ 13.194405] dhcpcd[605]: eth0: soliciting a DHCP lease849machine # [ 13.198313] dhcpcd[605]: eth0: offered 10.0.2.15 from 10.0.2.2850machine # [ 13.204695] dhcpcd[605]: eth0: probing address 10.0.2.15/24851machine # [ 13.452525] systemd[1]: Finished Extra networking commands..852machine # [ 13.455073] systemd[1]: Reached target Network.853machine # [ 13.461358] systemd[1]: Starting Permit User Sessions...854machine # [ 13.501585] systemd[1]: Finished Permit User Sessions.855machine # [ 13.512350] systemd[1]: Started Getty on tty1.856machine # [ 13.513360] systemd[1]: Reached target Login Prompts.857machine # [ 13.690309] dhcpcd[605]: eth0: soliciting an IPv6 router858machine # [ 13.692982] dhcpcd[605]: eth0: Router Advertisement from fe80::2859machine # [ 13.694272] dhcpcd[605]: eth0: adding address fec0::5054:ff:fe12:3456/64860machine # [ 13.695656] dhcpcd[605]: eth0: adding route to fec0::/64861machine # [ 13.696970] dhcpcd[605]: eth0: adding default route via fe80::2862machine # [ 18.289032] dhcpcd[605]: eth0: leased 10.0.2.15 for 86400 seconds863machine # [ 18.293164] dhcpcd[605]: eth0: adding route to 10.0.2.0/24864machine # [ 18.295637] dhcpcd[605]: eth0: adding default route via 10.0.2.2865machine # [ 18.441740] systemd[1]: Started DHCP Client.866machine # [ 18.443820] systemd[1]: Reached target Multi-User System.867machine # [ 18.448540] systemd[1]: Startup finished in 1.050s (kernel) + 4.804s (initrd) + 12.588s (userspace) = 18.443s.868machine: (finished: waiting for unit multi-user.target, in 20.02 seconds)869machine: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/bin/switch-to-configuration test870machine # Checking switch inhibitors... done871machine # [ 19.440003] nixos[832]: switching to system configuration /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test872machine # [ 19.442821] systemd[1]: Stopped target Remote File Systems.873machine # activating the configuration...874machine # [ 19.445216] systemd[1]: Stopped target Local File Systems.875machine # setting up /etc...876machine # [ 19.729136] systemd[1]: Reload requested from client PID 832 ('.switch-to-conf') (unit backdoor.service)...877machine # [ 19.730750] systemd[1]: Reloading...878machine # [ 20.055954] systemd[1]: Reloading finished in 323 ms.879machine # reloading user units for usertest...880machine # [ 20.108491] systemd[560]: Created slice User Core Session Slice.881machine # [ 20.109512] systemd[560]: Starting D-Bus User Message Bus...882machine # [ 20.140138] dbus-broker-launch[902]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/vblc6s1jf416nl6scqx9knad4kcsfpz5-system-path/share/dbus-1/services/org.freedesktop.import1.service'883machine # [ 20.143103] dbus-broker-launch[902]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/vblc6s1jf416nl6scqx9knad4kcsfpz5-system-path/share/dbus-1/services/org.freedesktop.machine1.service'884machine # [ 20.146036] dbus-broker-launch[902]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/vblc6s1jf416nl6scqx9knad4kcsfpz5-system-path/share/dbus-1/services/org.freedesktop.portable1.service'885machine # [ 20.148857] dbus-broker-launch[902]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/vblc6s1jf416nl6scqx9knad4kcsfpz5-system-path/share/dbus-1/services/org.freedesktop.systemd1.service'886machine # [ 20.152985] dbus-broker-launch[902]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored887machine # [ 20.154685] dbus-broker-launch[902]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored888machine # [ 20.156705] systemd[560]: Started D-Bus User Message Bus.889machine # [ 20.161542] dbus-broker-launch[902]: Ready890machine # [ 20.203859] systemd[560]: Reexecution requested from client PID 901 ('switch-to-confi')...891machine # [ 20.208044] systemd[560]: Reexecuting.892machine # [ 20.247246] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy893machine # [ 20.358314] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy894machine # [ 20.364848] systemd[560]: Reload requested from client PID 901 ('switch-to-confi')...895machine # [ 20.367144] systemd[560]: Reloading...896machine # [ 20.477913] systemd[560]: Reloading finished in 109 ms.897machine # [ 20.492157] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy898machine # restarting the following user units: nixos-activation.service899machine # [ 20.501418] systemd[560]: Stopped Run user-specific NixOS activation.900machine # [ 20.503584] systemd[560]: Stopping Run user-specific NixOS activation...901machine # [ 20.505628] systemd[560]: Starting Run user-specific NixOS activation...902machine # [ 20.534352] systemd[560]: Finished Run user-specific NixOS activation.903machine # restarting sysinit-reactivation.target904machine # [ 20.545169] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....905machine # [ 20.624328] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..906machine # [ 20.627480] systemd[1]: Reached target Reactivate sysinit units.907machine # [ 20.631391] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os908machine # [ 20.634027] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki909machine # [ 20.635301] systemd[1]: Reached target Remote File Systems.910machine # [ 20.640439] systemd[1]: Reached target Local File Systems.911machine # [ 20.641263] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore912machine # [ 20.644761] systemd[1]: Starting Create SUID/SGID Wrappers...913machine # [ 20.645631] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.914machine # [ 20.646870] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67915machine # [ 20.656764] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore916machine # [ 20.658407] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os917machine # [ 20.659636] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os918machine # [ 20.822373] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.919machine # [ 20.826438] systemd[1]: Finished Create SUID/SGID Wrappers.920machine # [ 20.828565] systemd[1]: Starting linger-users.service...921machine # [ 20.868233] systemd[1]: linger-users.service: Deactivated successfully.922machine # [ 20.871028] systemd[1]: Finished linger-users.service.923machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service924machine # [ 21.132811] nixos[832]: finished switching to system configuration /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test925machine: (finished: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/bin/switch-to-configuration test, in 1.98 seconds)926machine: must succeed: rm /etc/NIXOS927machine: (finished: must succeed: rm /etc/NIXOS, in 0.04 seconds)928machine: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/pillnrmip86vryyzz3g02gmd21wasg9s-nixos-system-other-test/bin/switch-to-configuration test929machine # this should succeed (config: /nix/store/pillnrmip86vryyzz3g02gmd21wasg9s-nixos-system-other-test, action: test)930machine # Checking switch inhibitors... done931machine # [ 21.447730] nixos[979]: switching to system configuration /nix/store/pillnrmip86vryyzz3g02gmd21wasg9s-nixos-system-other-test932machine # [ 21.450328] systemd[1]: Stopped target Local File Systems.933machine # activating the configuration...934machine # [ 21.452965] systemd[1]: Stopped target Remote File Systems.935machine # removing user ‘usertest’936machine # setting up /etc...937machine # [ 21.750229] systemd[1]: Reload requested from client PID 979 ('.switch-to-conf') (unit backdoor.service)...938machine # [ 21.752128] systemd[1]: Reloading...939machine # [ 22.080672] systemd[1]: Reloading finished in 327 ms.940machine # reloading user units for usertest...941machine # [ 22.174287] systemd[560]: Reexecution requested from client PID 1051 ('switch-to-confi')...942machine # [ 22.178672] systemd[560]: Reexecuting.943machine # [ 22.240063] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy944machine # [ 22.369686] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy945machine # [ 22.376289] systemd[560]: Reload requested from client PID 1051 ('switch-to-confi')...946machine # [ 22.379986] systemd[560]: Reloading...947machine # [ 22.496866] systemd[560]: Reloading finished in 117 ms.948machine # [ 22.513829] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy949machine # restarting the following user units: nixos-activation.service950machine # [ 22.525374] systemd[560]: Stopped Run user-specific NixOS activation.951machine # [ 22.527760] systemd[560]: Stopping Run user-specific NixOS activation...952machine # [ 22.530119] systemd[560]: Starting Run user-specific NixOS activation...953machine # [ 22.564821] systemd[560]: Finished Run user-specific NixOS activation.954machine # restarting sysinit-reactivation.target955machine # [ 22.568703] systemd[1]: Stopped target Reactivate sysinit units.956machine # reloading the following units: dbus-broker.service957machine # [ 22.573184] systemd[1]: Stopping Reactivate sysinit units...958machine # [ 22.574138] systemd[1]: Reached target Reactivate sysinit units.959machine # [ 22.574981] systemd[1]: Reloading D-Bus System Message Bus...960machine # [ 22.577208] dbus-broker-launch[431]: Caught SIGHUP, trigger reload.961machine # [ 22.583421] dbus-broker-launch[431]: Looking up NSS user entry for 'systemd-timesync'...962machine # [ 22.585711] dbus-broker-launch[431]: NSS returned no entry for 'systemd-timesync'963machine # [ 22.586788] dbus-broker-launch[431]: Invalid user-name in /nix/store/irfcixxab1p55wrjp592agjjy6ad31na-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"964machine # [ 22.603990] systemd[1]: Reloaded D-Bus System Message Bus.965machine # restarting the following units: network-addresses-eth1.service966machine # [ 22.610375] systemd[1]: Stopping Address configuration of eth1...967machine # [ 22.643556] network-addresses-eth1-pre-stop[1063]: deleting address 192.168.1.1/24... done968machine # [ 22.650084] network-addresses-eth1-pre-stop[1063]: deleting address 2001:db8:1::1/64... done969machine # [ 22.657003] systemd[1]: network-addresses-eth1.service: Deactivated successfully.970machine # [ 22.659274] systemd[1]: Stopped Address configuration of eth1.971machine # [ 22.664174] systemd[1]: Starting Address configuration of eth1...972machine # [ 22.706491] network-addresses-eth1-start[1068]: adding address 192.168.1.2/24... done973machine # [ 22.713704] network-addresses-eth1-start[1068]: adding address 2001:db8:1::2/64... done974machine # [ 22.723245] systemd[1]: Finished Address configuration of eth1.975machine # [ 22.727321] systemd[1]: Reached target Remote File Systems.976machine # [ 22.731948] systemd[1]: Starting linger-users.service...977machine # [ 22.741471] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os978machine # [ 22.742988] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki979machine # [ 22.748100] systemd[1]: Reached target Local File Systems.980machine # [ 22.748969] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore981machine # [ 22.758016] systemd[1]: Starting Create SUID/SGID Wrappers...982machine # [ 22.758934] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.983machine # [ 22.769725] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67984machine # [ 22.775685] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore985machine # [ 22.778431] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os986machine # [ 22.782096] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os987machine # [ 22.806851] linger-users-start[1082]: id: ‘usertest’: no such user988machine # [ 22.809902] linger-users-start[1079]: Removing linger for missing user usertest989machine # [ 22.818424] systemd[1]: linger-users.service: Deactivated successfully.990machine # [ 22.820958] systemd[1]: Finished linger-users.service.991machine # [ 22.991296] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.992machine # [ 22.994301] systemd[1]: Finished Create SUID/SGID Wrappers.993machine # [ 23.253205] nixos[979]: finished switching to system configuration /nix/store/pillnrmip86vryyzz3g02gmd21wasg9s-nixos-system-other-test994machine: (finished: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/pillnrmip86vryyzz3g02gmd21wasg9s-nixos-system-other-test/bin/switch-to-configuration test, in 2.08 seconds)995subtest: services996machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/bin/switch-to-configuration test 2>&1997machine # [ 23.542209] nixos[1146]: switching to system configuration /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test998machine # [ 23.544713] systemd[1]: Stopped target Remote File Systems.999machine # [ 23.546944] systemd[1]: Stopped target Local File Systems.1000machine # [ 23.824737] systemd[1]: Reload requested from client PID 1146 ('.switch-to-conf') (unit backdoor.service)...1001machine # [ 23.826659] systemd[1]: Reloading...1002machine # [ 24.161552] systemd[1]: Reloading finished in 333 ms.1003machine # [ 24.250355] systemd[560]: Reexecution requested from client PID 1215 ('switch-to-confi')...1004machine # [ 24.254260] systemd[560]: Reexecuting.1005machine # [ 24.311788] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1006machine # [ 24.427572] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1007machine # [ 24.434429] systemd[560]: Reload requested from client PID 1215 ('switch-to-confi')...1008machine # [ 24.436711] systemd[560]: Reloading...1009machine # [ 24.544722] systemd[560]: Reloading finished in 106 ms.1010machine # [ 24.561734] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1011machine # [ 24.570112] systemd[560]: Stopped Run user-specific NixOS activation.1012machine # [ 24.572614] systemd[560]: Stopping Run user-specific NixOS activation...1013machine # [ 24.574785] systemd[560]: Starting Run user-specific NixOS activation...1014machine # [ 24.608577] systemd[560]: Finished Run user-specific NixOS activation.1015machine # [ 24.612445] systemd[1]: Stopped target Reactivate sysinit units.1016machine # [ 24.613818] systemd[1]: Stopping Reactivate sysinit units...1017machine # [ 24.614633] systemd[1]: Reached target Reactivate sysinit units.1018machine # [ 24.619089] dbus-broker-launch[431]: Caught SIGHUP, trigger reload.1019machine # [ 24.620386] systemd[1]: Reloading D-Bus System Message Bus...1020machine # [ 24.624565] dbus-broker-launch[431]: Looking up NSS user entry for 'systemd-timesync'...1021machine # [ 24.626560] dbus-broker-launch[431]: NSS returned no entry for 'systemd-timesync'1022machine # [ 24.627691] dbus-broker-launch[431]: Invalid user-name in /nix/store/vblc6s1jf416nl6scqx9knad4kcsfpz5-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1023machine # [ 24.651949] systemd[1]: Reloaded D-Bus System Message Bus.1024machine # [ 24.658000] systemd[1]: Stopping Address configuration of eth1...1025machine # [ 24.688727] network-addresses-eth1-pre-stop[1227]: deleting address 192.168.1.2/24... done1026machine # [ 24.694925] network-addresses-eth1-pre-stop[1227]: deleting address 2001:db8:1::2/64... done1027machine # [ 24.701595] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1028machine # [ 24.704302] systemd[1]: Stopped Address configuration of eth1.1029machine # [ 24.708335] systemd[1]: Starting Address configuration of eth1...1030machine # [ 24.749142] network-addresses-eth1-start[1232]: adding address 192.168.1.1/24... done1031machine # [ 24.755931] network-addresses-eth1-start[1232]: adding address 2001:db8:1::1/64... done1032machine # [ 24.764935] systemd[1]: Finished Address configuration of eth1.1033machine # [ 24.770370] systemd[1]: Reached target Remote File Systems.1034machine # [ 24.774505] systemd[1]: Starting linger-users.service...1035machine # [ 24.787013] systemd[1]: Reached target Local File Systems.1036machine # [ 24.787886] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1037machine # [ 24.797342] systemd[1]: Starting Create SUID/SGID Wrappers...1038machine # [ 24.798233] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1039machine # [ 24.799438] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671040machine # [ 24.812151] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1041machine # [ 24.813850] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1042machine # [ 24.826522] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1043machine # [ 24.834255] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1044machine # [ 24.835691] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1045machine # [ 24.869972] systemd[1]: linger-users.service: Deactivated successfully.1046machine # [ 24.874435] systemd[1]: Finished linger-users.service.1047machine # [ 25.025315] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1048machine # [ 25.028636] systemd[1]: Finished Create SUID/SGID Wrappers.1049machine # [ 25.286274] nixos[1146]: finished switching to system configuration /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test1050machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.03 seconds)1051machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/bin/switch-to-configuration test 2>&11052machine # [ 25.565939] nixos[1302]: switching to system configuration /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test1053machine # [ 25.568652] systemd[1]: Stopped target Local File Systems.1054machine # [ 25.571271] systemd[1]: Stopped target Remote File Systems.1055machine # [ 25.855414] systemd[1]: Reload requested from client PID 1302 ('.switch-to-conf') (unit backdoor.service)...1056machine # [ 25.857823] systemd[1]: Reloading...1057machine # [ 26.193885] systemd[1]: Reloading finished in 334 ms.1058machine # [ 26.285359] systemd[560]: Reexecution requested from client PID 1371 ('switch-to-confi')...1059machine # [ 26.289668] systemd[560]: Reexecuting.1060machine # [ 26.347665] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1061machine # [ 26.468946] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1062machine # [ 26.475735] systemd[560]: Reload requested from client PID 1371 ('switch-to-confi')...1063machine # [ 26.479139] systemd[560]: Reloading...1064machine # [ 26.591701] systemd[560]: Reloading finished in 113 ms.1065machine # [ 26.608230] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1066machine # [ 26.617139] systemd[560]: Stopped Run user-specific NixOS activation.1067machine # [ 26.619597] systemd[560]: Stopping Run user-specific NixOS activation...1068machine # [ 26.621890] systemd[560]: Starting Run user-specific NixOS activation...1069machine # [ 26.657048] systemd[560]: Finished Run user-specific NixOS activation.1070machine # [ 26.661082] systemd[1]: Stopped target Reactivate sysinit units.1071machine # [ 26.663135] systemd[1]: Stopping Reactivate sysinit units...1072machine # [ 26.665873] systemd[1]: Reached target Reactivate sysinit units.1073machine # [ 26.666812] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1074machine # [ 26.668963] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1075machine # [ 26.673101] systemd[1]: Reached target Remote File Systems.1076machine # [ 26.675694] systemd[1]: Starting linger-users.service...1077machine # [ 26.687051] systemd[1]: Reached target Local File Systems.1078machine # [ 26.687921] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1079machine # [ 26.698395] systemd[1]: Starting Create SUID/SGID Wrappers...1080machine # [ 26.699303] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1081machine # [ 26.705590] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671082machine # [ 26.707828] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1083machine # [ 26.712630] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1084machine # [ 26.714006] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1085machine # [ 26.757033] systemd[1]: linger-users.service: Deactivated successfully.1086machine # [ 26.760125] systemd[1]: Finished linger-users.service.1087machine # [ 26.906835] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1088machine # [ 26.910320] systemd[1]: Finished Create SUID/SGID Wrappers.1089machine # [ 27.167400] nixos[1302]: finished switching to system configuration /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test1090machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.88 seconds)1091machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11092machine # [ 27.473585] nixos[1442]: switching to system configuration /nix/store/3if996b400l4jbpbwv9h1vpbvzgqyqbr-nixos-system-machine-test1093machine # [ 27.476210] systemd[1]: Stopped target Local File Systems.1094machine # [ 27.478477] systemd[1]: Stopped target Remote File Systems.1095machine # [ 27.771785] systemd[1]: Reload requested from client PID 1442 ('.switch-to-conf') (unit backdoor.service)...1096machine # [ 27.773996] systemd[1]: Reloading...1097machine # [ 28.111322] systemd[1]: Reloading finished in 335 ms.1098machine # [ 28.238254] systemd[560]: Reexecution requested from client PID 1511 ('switch-to-confi')...1099machine # [ 28.239658] systemd[560]: Reexecuting.1100machine # [ 28.303584] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1101machine # [ 28.425069] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1102machine # [ 28.432271] systemd[560]: Reload requested from client PID 1511 ('switch-to-confi')...1103machine # [ 28.435598] systemd[560]: Reloading...1104machine # [ 28.545488] systemd[560]: Reloading finished in 110 ms.1105machine # [ 28.561680] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1106machine # [ 28.570142] systemd[560]: Stopped Run user-specific NixOS activation.1107machine # [ 28.572428] systemd[560]: Stopping Run user-specific NixOS activation...1108machine # [ 28.574572] systemd[560]: Starting Run user-specific NixOS activation...1109machine # [ 28.604092] systemd[560]: Finished Run user-specific NixOS activation.1110machine # [ 28.607667] systemd[1]: Stopped target Reactivate sysinit units.1111machine # [ 28.610674] systemd[1]: Stopping Reactivate sysinit units...1112machine # [ 28.611502] systemd[1]: Reached target Reactivate sysinit units.1113machine # [ 28.613361] systemd[1]: Reached target Local File Systems.1114machine # [ 28.614185] systemd[1]: Reached target Remote File Systems.1115machine # [ 28.619370] systemd[1]: Starting linger-users.service...1116machine # [ 28.622991] systemd[1]: Starting test.service...1117machine # [ 28.628218] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1118machine # [ 28.636436] systemd[1]: Starting Create SUID/SGID Wrappers...1119machine # [ 28.637347] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1120machine # [ 28.638584] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671121machine # [ 28.655192] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1122machine # [ 28.659452] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1123machine # [ 28.666142] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1124machine # [ 28.667528] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1125machine # [ 28.676851] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1126machine # [ 28.702450] systemd[1]: Finished test.service.1127machine # [ 28.729522] systemd[1]: linger-users.service: Deactivated successfully.1128machine # [ 28.731201] systemd[1]: Finished linger-users.service.1129machine # [ 28.866370] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1130machine # [ 28.870023] systemd[1]: Finished Create SUID/SGID Wrappers.1131machine # [ 29.128979] nixos[1442]: finished switching to system configuration /nix/store/3if996b400l4jbpbwv9h1vpbvzgqyqbr-nixos-system-machine-test1132machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.96 seconds)1133machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11134machine # [ 29.396890] nixos[1585]: switching to system configuration /nix/store/3if996b400l4jbpbwv9h1vpbvzgqyqbr-nixos-system-machine-test1135machine # [ 29.399639] systemd[1]: Stopped target Remote File Systems.1136machine # [ 29.402533] systemd[1]: Stopped target Local File Systems.1137machine # [ 29.689440] systemd[1]: Reload requested from client PID 1585 ('.switch-to-conf') (unit backdoor.service)...1138machine # [ 29.691462] systemd[1]: Reloading...1139machine # [ 30.032305] systemd[1]: Reloading finished in 339 ms.1140machine # [ 30.123926] systemd[560]: Reexecution requested from client PID 1654 ('switch-to-confi')...1141machine # [ 30.126145] systemd[560]: Reexecuting.1142machine # [ 30.187985] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1143machine # [ 30.305294] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1144machine # [ 30.311691] systemd[560]: Reload requested from client PID 1654 ('switch-to-confi')...1145machine # [ 30.315311] systemd[560]: Reloading...1146machine # [ 30.425132] systemd[560]: Reloading finished in 110 ms.1147machine # [ 30.440176] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1148machine # [ 30.449436] systemd[560]: Stopped Run user-specific NixOS activation.1149machine # [ 30.451786] systemd[560]: Stopping Run user-specific NixOS activation...1150machine # [ 30.454015] systemd[560]: Starting Run user-specific NixOS activation...1151machine # [ 30.489026] systemd[560]: Finished Run user-specific NixOS activation.1152machine # [ 30.492941] systemd[1]: Stopped target Reactivate sysinit units.1153machine # [ 30.494893] systemd[1]: Stopping Reactivate sysinit units...1154machine # [ 30.495751] systemd[1]: Reached target Reactivate sysinit units.1155machine # [ 30.501094] systemd[1]: Reached target Local File Systems.1156machine # [ 30.501890] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1157machine # [ 30.505333] systemd[1]: Starting Create SUID/SGID Wrappers...1158machine # [ 30.506237] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1159machine # [ 30.507425] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671160machine # [ 30.516395] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1161machine # [ 30.518081] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1162machine # [ 30.519342] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1163machine # [ 30.527859] systemd[1]: Reached target Remote File Systems.1164machine # [ 30.530130] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1165machine # [ 30.531427] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1166machine # [ 30.691138] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1167machine # [ 30.693270] systemd[1]: Finished Create SUID/SGID Wrappers.1168machine # [ 30.698274] systemd[1]: Starting linger-users.service...1169machine # [ 30.742060] systemd[1]: linger-users.service: Deactivated successfully.1170machine # [ 30.743885] systemd[1]: Finished linger-users.service.1171machine # [ 31.003236] nixos[1585]: finished switching to system configuration /nix/store/3if996b400l4jbpbwv9h1vpbvzgqyqbr-nixos-system-machine-test1172machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.88 seconds)1173machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&11174machine # [ 31.298884] nixos[1725]: switching to system configuration /nix/store/vlpzngy9x9vw8wn3l510wj6n38vb03i2-nixos-system-machine-test1175machine # [ 31.301296] systemd[1]: Stopped target Local File Systems.1176machine # [ 31.303620] systemd[1]: Stopped target Remote File Systems.1177machine # [ 31.632627] systemd[1]: Reload requested from client PID 1725 ('.switch-to-conf') (unit backdoor.service)...1178machine # [ 31.634550] systemd[1]: Reloading...1179machine # [ 32.069244] systemd[1]: Reloading finished in 433 ms.1180machine # [ 32.158396] systemd[560]: Reexecution requested from client PID 1795 ('switch-to-confi')...1181machine # [ 32.159750] systemd[560]: Reexecuting.1182machine # [ 32.224367] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1183machine # [ 32.354613] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1184machine # [ 32.361644] systemd[560]: Reload requested from client PID 1795 ('switch-to-confi')...1185machine # [ 32.365497] systemd[560]: Reloading...1186machine # [ 32.478449] systemd[560]: Reloading finished in 113 ms.1187machine # [ 32.496185] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1188machine # [ 32.506154] systemd[560]: Stopped Run user-specific NixOS activation.1189machine # [ 32.508780] systemd[560]: Stopping Run user-specific NixOS activation...1190machine # [ 32.512129] systemd[560]: Starting Run user-specific NixOS activation...1191machine # [ 32.540728] systemd[560]: Finished Run user-specific NixOS activation.1192machine # [ 32.544349] systemd[1]: Stopped target Reactivate sysinit units.1193machine # [ 32.545827] systemd[1]: Stopping Reactivate sysinit units...1194machine # [ 32.546813] systemd[1]: Reached target Reactivate sysinit units.1195machine # [ 32.552476] systemd[1]: Reached target Remote File Systems.1196machine # [ 32.556725] systemd[1]: Starting linger-users.service...1197machine # [ 32.566985] systemd[1]: Reached target Local File Systems.1198machine # [ 32.567865] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1199machine # [ 32.576753] systemd[1]: Starting Create SUID/SGID Wrappers...1200machine # [ 32.577652] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1201machine # [ 32.578916] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671202machine # [ 32.592891] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1203machine # [ 32.594627] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1204machine # [ 32.602868] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1205machine # [ 32.607666] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1206machine # [ 32.611420] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1207machine # [ 32.647307] systemd[1]: linger-users.service: Deactivated successfully.1208machine # [ 32.652158] systemd[1]: Finished linger-users.service.1209machine # [ 32.786975] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1210machine # [ 32.790139] systemd[1]: Finished Create SUID/SGID Wrappers.1211machine # [ 33.045341] nixos[1725]: finished switching to system configuration /nix/store/vlpzngy9x9vw8wn3l510wj6n38vb03i2-nixos-system-machine-test1212machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 2.03 seconds)1213machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11214machine # [ 33.324370] nixos[1866]: switching to system configuration /nix/store/x2ysb5v4hqnib4g99q9lxqa7ln87f77n-nixos-system-machine-test1215machine # [ 33.327017] systemd[1]: Stopped target Local File Systems.1216machine # [ 33.331552] systemd[1]: Stopped target Remote File Systems.1217machine # [ 33.333314] systemd[1]: test.service: Deactivated successfully.1218machine # [ 33.334190] systemd[1]: Stopped Test unit.1219machine # [ 33.615860] systemd[1]: Reload requested from client PID 1866 ('.switch-to-conf') (unit backdoor.service)...1220machine # [ 33.617974] systemd[1]: Reloading...1221machine # [ 33.950510] systemd[1]: Reloading finished in 330 ms.1222machine # [ 34.034085] systemd[560]: Reexecution requested from client PID 1935 ('switch-to-confi')...1223machine # [ 34.037737] systemd[560]: Reexecuting.1224machine # [ 34.095693] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1225machine # [ 34.212808] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1226machine # [ 34.220096] systemd[560]: Reload requested from client PID 1935 ('switch-to-confi')...1227machine # [ 34.221445] systemd[560]: Reloading...1228machine # [ 34.331771] systemd[560]: Reloading finished in 108 ms.1229machine # [ 34.348223] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1230machine # [ 34.358231] systemd[560]: Stopped Run user-specific NixOS activation.1231machine # [ 34.360634] systemd[560]: Stopping Run user-specific NixOS activation...1232machine # [ 34.362831] systemd[560]: Starting Run user-specific NixOS activation...1233machine # [ 34.396852] systemd[560]: Finished Run user-specific NixOS activation.1234machine # [ 34.400918] systemd[1]: Stopped target Reactivate sysinit units.1235machine # [ 34.401898] systemd[1]: Stopping Reactivate sysinit units...1236machine # [ 34.402711] systemd[1]: Reached target Reactivate sysinit units.1237machine # [ 34.407914] systemd[1]: Starting test.service...1238machine # [ 34.411876] systemd[1]: Reached target Remote File Systems.1239machine # [ 34.420107] systemd[1]: Reached target Local File Systems.1240machine # [ 34.421026] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1241machine # [ 34.432127] systemd[1]: Starting Create SUID/SGID Wrappers...1242machine # [ 34.433066] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1243machine # [ 34.434338] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671244machine # [ 34.450947] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1245machine # [ 34.454310] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1246machine # [ 34.455794] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1247machine # [ 34.460609] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1248machine # [ 34.461951] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1249machine # [ 34.475126] systemd[1]: Finished test.service.1250machine # [ 34.625680] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1251machine # [ 34.628145] systemd[1]: Finished Create SUID/SGID Wrappers.1252machine # [ 34.632637] systemd[1]: Starting linger-users.service...1253machine # [ 34.673580] systemd[1]: linger-users.service: Deactivated successfully.1254machine # [ 34.677740] systemd[1]: Finished linger-users.service.1255machine # [ 34.933995] nixos[1866]: finished switching to system configuration /nix/store/x2ysb5v4hqnib4g99q9lxqa7ln87f77n-nixos-system-machine-test1256machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.89 seconds)1257machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&11258machine # [ 35.218948] nixos[2009]: switching to system configuration /nix/store/k9cd3abnik0zy4an4glnrpdnvngi11df-nixos-system-machine-test1259machine # [ 35.221789] systemd[1]: Stopped target Local File Systems.1260machine # [ 35.224172] systemd[1]: Stopped target Remote File Systems.1261machine # [ 35.506427] systemd[1]: Reload requested from client PID 2009 ('.switch-to-conf') (unit backdoor.service)...1262machine # [ 35.508447] systemd[1]: Reloading...1263machine # [ 35.842741] systemd[1]: Reloading finished in 332 ms.1264machine # [ 35.932422] systemd[560]: Reexecution requested from client PID 2078 ('switch-to-confi')...1265machine # [ 35.935696] systemd[560]: Reexecuting.1266machine # [ 35.991218] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1267machine # [ 36.103410] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1268machine # [ 36.110087] systemd[560]: Reload requested from client PID 2078 ('switch-to-confi')...1269machine # [ 36.113677] systemd[560]: Reloading...1270machine # [ 36.222793] systemd[560]: Reloading finished in 110 ms.1271machine # [ 36.236358] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1272machine # [ 36.247079] systemd[560]: Stopped Run user-specific NixOS activation.1273machine # [ 36.249725] systemd[560]: Stopping Run user-specific NixOS activation...1274machine # [ 36.252120] systemd[560]: Starting Run user-specific NixOS activation...1275machine # [ 36.285461] systemd[560]: Finished Run user-specific NixOS activation.1276machine # [ 36.290142] systemd[1]: Stopped target Reactivate sysinit units.1277machine # [ 36.295465] systemd[1]: Stopping Reactivate sysinit units...1278machine # [ 36.296922] systemd[1]: Reached target Reactivate sysinit units.1279machine # [ 36.297861] systemd[1]: test.service: Deactivated successfully.1280machine # [ 36.298703] systemd[1]: Stopped test.service.1281machine # [ 36.299346] systemd[1]: Stopping test.service...1282machine # [ 36.301282] systemd[1]: Starting test.service...1283machine # [ 36.331844] systemd[1]: Finished test.service.1284machine # [ 36.342034] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1285machine # [ 36.345570] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1286machine # [ 36.348523] systemd[1]: Reached target Remote File Systems.1287machine # [ 36.354410] systemd[1]: Starting linger-users.service...1288machine # [ 36.364875] systemd[1]: Reached target Local File Systems.1289machine # [ 36.365880] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1290machine # [ 36.374103] systemd[1]: Starting Create SUID/SGID Wrappers...1291machine # [ 36.375099] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1292machine # [ 36.380738] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671293machine # [ 36.383108] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1294machine # [ 36.393099] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1295machine # [ 36.394858] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1296machine # [ 36.440853] systemd[1]: linger-users.service: Deactivated successfully.1297machine # [ 36.445584] systemd[1]: Finished linger-users.service.1298machine # [ 36.584777] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1299machine # [ 36.588222] systemd[1]: Finished Create SUID/SGID Wrappers.1300machine # [ 36.844967] nixos[2009]: finished switching to system configuration /nix/store/k9cd3abnik0zy4an4glnrpdnvngi11df-nixos-system-machine-test1301machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.91 seconds)1302machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&11303machine # [ 37.146335] nixos[2151]: switching to system configuration /nix/store/hni7rjl90y56yldhszm3n6kjz6n6rb4w-nixos-system-machine-test1304machine # [ 37.148795] systemd[1]: Stopped target Remote File Systems.1305machine # [ 37.151035] systemd[1]: Stopped target Local File Systems.1306machine # [ 37.442864] systemd[1]: Reload requested from client PID 2151 ('.switch-to-conf') (unit backdoor.service)...1307machine # [ 37.444896] systemd[1]: Reloading...1308machine # [ 37.794279] systemd[1]: Reloading finished in 347 ms.1309machine # [ 37.887207] systemd[560]: Reexecution requested from client PID 2219 ('switch-to-confi')...1310machine # [ 37.891001] systemd[560]: Reexecuting.1311machine # [ 37.943176] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1312machine # [ 38.058872] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1313machine # [ 38.065313] systemd[560]: Reload requested from client PID 2219 ('switch-to-confi')...1314machine # [ 38.067634] systemd[560]: Reloading...1315machine # [ 38.224996] systemd[560]: Reloading finished in 156 ms.1316machine # [ 38.242047] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1317machine # [ 38.251873] systemd[560]: Stopped Run user-specific NixOS activation.1318machine # [ 38.253115] systemd[560]: Stopping Run user-specific NixOS activation...1319machine # [ 38.255386] systemd[560]: Starting Run user-specific NixOS activation...1320machine # [ 38.287963] systemd[560]: Finished Run user-specific NixOS activation.1321machine # [ 38.292360] systemd[1]: Stopped target Reactivate sysinit units.1322machine # [ 38.296473] systemd[1]: Stopping Reactivate sysinit units...1323machine # [ 38.297406] systemd[1]: Reached target Reactivate sysinit units.1324machine # [ 38.300169] systemd[1]: Reloading test.service...1325machine # [ 38.326769] systemd[1]: Reloaded test.service.1326machine # [ 38.331586] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1327machine # [ 38.335266] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1328machine # [ 38.337552] systemd[1]: Reached target Remote File Systems.1329machine # [ 38.342485] systemd[1]: Reached target Local File Systems.1330machine # [ 38.347760] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1331machine # [ 38.351819] systemd[1]: Starting Create SUID/SGID Wrappers...1332machine # [ 38.355750] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1333machine # [ 38.360775] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671334machine # [ 38.363268] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1335machine # [ 38.368442] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1336machine # [ 38.369866] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1337machine # [ 38.548752] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1338machine # [ 38.552516] systemd[1]: Finished Create SUID/SGID Wrappers.1339machine # [ 38.556397] systemd[1]: Starting linger-users.service...1340machine # [ 38.601337] systemd[1]: linger-users.service: Deactivated successfully.1341machine # [ 38.604416] systemd[1]: Finished linger-users.service.1342machine # [ 38.863365] nixos[2151]: finished switching to system configuration /nix/store/hni7rjl90y56yldhszm3n6kjz6n6rb4w-nixos-system-machine-test1343machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 2.02 seconds)1344machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&11345machine # [ 39.177154] nixos[2294]: switching to system configuration /nix/store/8k97xh1d3m4888rqp4hi71k6cr6j744p-nixos-system-machine-test1346machine # [ 39.179708] systemd[1]: Stopped target Remote File Systems.1347machine # [ 39.182022] systemd[1]: Stopped target Local File Systems.1348machine # [ 39.478851] systemd[1]: Reload requested from client PID 2294 ('.switch-to-conf') (unit backdoor.service)...1349machine # [ 39.481056] systemd[1]: Reloading...1350machine # [ 39.823973] systemd[1]: Reloading finished in 341 ms.1351machine # [ 39.912416] systemd[560]: Reexecution requested from client PID 2363 ('switch-to-confi')...1352machine # [ 39.915715] systemd[560]: Reexecuting.1353machine # [ 39.971597] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1354machine # [ 40.090681] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1355machine # [ 40.097321] systemd[560]: Reload requested from client PID 2363 ('switch-to-confi')...1356machine # [ 40.099561] systemd[560]: Reloading...1357machine # [ 40.211527] systemd[560]: Reloading finished in 111 ms.1358machine # [ 40.228206] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1359machine # [ 40.238274] systemd[560]: Stopped Run user-specific NixOS activation.1360machine # [ 40.240741] systemd[560]: Stopping Run user-specific NixOS activation...1361machine # [ 40.242942] systemd[560]: Starting Run user-specific NixOS activation...1362machine # [ 40.277402] systemd[560]: Finished Run user-specific NixOS activation.1363machine # [ 40.281278] systemd[1]: Stopped target Reactivate sysinit units.1364machine # [ 40.284118] systemd[1]: Stopping Reactivate sysinit units...1365machine # [ 40.285016] systemd[1]: Reached target Reactivate sysinit units.1366machine # [ 40.288451] systemd[1]: Reached target Remote File Systems.1367machine # [ 40.291501] systemd[1]: Starting linger-users.service...1368machine # [ 40.296484] systemd[1]: Reached target Local File Systems.1369machine # [ 40.304826] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1370machine # [ 40.310207] systemd[1]: Starting Create SUID/SGID Wrappers...1371machine # [ 40.311134] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1372machine # [ 40.322179] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671373machine # [ 40.333184] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1374machine # [ 40.335434] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1375machine # [ 40.337537] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1376machine # [ 40.338763] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1377machine # [ 40.343264] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1378machine # [ 40.384645] systemd[1]: linger-users.service: Deactivated successfully.1379machine # [ 40.387616] systemd[1]: Finished linger-users.service.1380machine # [ 40.528567] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1381machine # [ 40.532260] systemd[1]: Finished Create SUID/SGID Wrappers.1382machine # [ 40.789152] nixos[2294]: finished switching to system configuration /nix/store/8k97xh1d3m4888rqp4hi71k6cr6j744p-nixos-system-machine-test1383machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.92 seconds)1384machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&11385machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.35 seconds)1386machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/bin/switch-to-configuration test 2>&11387machine # [ 41.352427] nixos[2444]: switching to system configuration /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test1388machine # [ 41.358173] systemd[1]: Stopped target Local File Systems.1389machine # [ 41.359109] systemd[1]: test.service: Deactivated successfully.1390machine # [ 41.359929] systemd[1]: Stopped test.service.1391machine # [ 41.361676] systemd[1]: Stopped target Remote File Systems.1392machine # [ 41.681890] systemd[1]: Reload requested from client PID 2444 ('.switch-to-conf') (unit backdoor.service)...1393machine # [ 41.683863] systemd[1]: Reloading...1394machine # [ 42.025686] systemd[1]: Reloading finished in 340 ms.1395machine # [ 42.114018] systemd[560]: Reexecution requested from client PID 2514 ('switch-to-confi')...1396machine # [ 42.115384] systemd[560]: Reexecuting.1397machine # [ 42.180369] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1398machine # [ 42.306547] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1399machine # [ 42.313061] systemd[560]: Reload requested from client PID 2514 ('switch-to-confi')...1400machine # [ 42.315390] systemd[560]: Reloading...1401machine # [ 42.429835] systemd[560]: Reloading finished in 114 ms.1402machine # [ 42.444179] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1403machine # [ 42.453311] systemd[560]: Stopped Run user-specific NixOS activation.1404machine # [ 42.455729] systemd[560]: Stopping Run user-specific NixOS activation...1405machine # [ 42.458052] systemd[560]: Starting Run user-specific NixOS activation...1406machine # [ 42.489612] systemd[560]: Finished Run user-specific NixOS activation.1407machine # [ 42.493930] systemd[1]: Stopped target Reactivate sysinit units.1408machine # [ 42.496413] systemd[1]: Stopping Reactivate sysinit units...1409machine # [ 42.497356] systemd[1]: Reached target Reactivate sysinit units.1410machine # [ 42.502301] systemd[1]: Reached target Remote File Systems.1411machine # [ 42.505441] systemd[1]: Starting linger-users.service...1412machine # [ 42.507783] systemd[1]: Reached target Local File Systems.1413machine # [ 42.514655] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1414machine # [ 42.527573] systemd[1]: Starting Create SUID/SGID Wrappers...1415machine # [ 42.528615] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1416machine # [ 42.529908] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671417machine # [ 42.538093] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1418machine # [ 42.539775] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1419machine # [ 42.541129] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1420machine # [ 42.542305] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1421machine # [ 42.543563] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1422machine # [ 42.596542] systemd[1]: linger-users.service: Deactivated successfully.1423machine # [ 42.599371] systemd[1]: Finished linger-users.service.1424machine # [ 42.741718] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1425machine # [ 42.744905] systemd[1]: Finished Create SUID/SGID Wrappers.1426machine # [ 43.003621] nixos[2444]: finished switching to system configuration /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test1427machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.87 seconds)1428machine: must succeed: /nix/store/msz9zmp8f71ffsjxv9l47hkd68drzhzi-separate-activation-script/bin/switch-to-configuration test 2>&11429machine # [ 43.237875] nixos[2585]: switching to system configuration /nix/store/52113bkn4rpwrlqpw73waivh0zbqspjz-nixos-system-machine-test1430machine # [ 43.240437] systemd[1]: Stopped target Local File Systems.1431machine # [ 43.242726] systemd[1]: Stopped target Remote File Systems.1432machine # [ 43.537847] systemd[1]: Reload requested from client PID 2585 ('.switch-to-conf') (unit backdoor.service)...1433machine # [ 43.539749] systemd[1]: Reloading...1434machine # [ 43.890049] systemd[1]: Reloading finished in 348 ms.1435machine # [ 43.994726] systemd[560]: Stopped Run user-specific NixOS activation.1436machine # [ 43.998898] systemd[560]: Reexecution requested from client PID 2654 ('switch-to-confi')...1437machine # [ 44.001312] systemd[560]: Reexecuting.1438machine # [ 44.059759] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1439machine # [ 44.182440] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1440machine # [ 44.189336] systemd[560]: Reload requested from client PID 2654 ('switch-to-confi')...1441machine # [ 44.193355] systemd[560]: Reloading...1442machine # [ 44.304663] systemd[560]: Reloading finished in 112 ms.1443machine # [ 44.320181] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1444machine # [ 44.332085] systemd[1]: Stopped target Reactivate sysinit units.1445machine # [ 44.334139] systemd[1]: Stopping Reactivate sysinit units...1446machine # [ 44.335010] systemd[1]: Reached target Reactivate sysinit units.1447machine # [ 44.341757] systemd[1]: Reached target Remote File Systems.1448machine # [ 44.347900] systemd[1]: Starting linger-users.service...1449machine # [ 44.352283] systemd[1]: Starting test.service...1450machine # [ 44.364158] systemd[1]: Reached target Local File Systems.1451machine # [ 44.365108] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1452machine # [ 44.366413] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1453machine # [ 44.380349] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1454machine # [ 44.382037] systemd[1]: Starting Create SUID/SGID Wrappers...1455machine # [ 44.382872] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1456machine # [ 44.387430] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671457machine # [ 44.396721] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1458machine # [ 44.398499] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1459machine # [ 44.401656] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1460machine # [ 44.432156] systemd[1]: Finished test.service.1461machine # [ 44.473742] systemd[1]: linger-users.service: Deactivated successfully.1462machine # [ 44.477628] systemd[1]: Finished linger-users.service.1463machine # [ 44.614987] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1464machine # [ 44.618435] systemd[1]: Finished Create SUID/SGID Wrappers.1465machine # [ 44.875500] nixos[2585]: finished switching to system configuration /nix/store/52113bkn4rpwrlqpw73waivh0zbqspjz-nixos-system-machine-test1466machine: (finished: must succeed: /nix/store/msz9zmp8f71ffsjxv9l47hkd68drzhzi-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.87 seconds)1467machine: must succeed: ! test -e /run/current-system/activate1468machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.02 seconds)1469machine: must succeed: ! test -e /run/current-system/dry-activate1470machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.02 seconds)1471machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration1472machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.02 seconds)1473machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&11474machine # [ 45.176929] nixos[2734]: switching to system configuration /nix/store/9r0bz7g1cd48zpnzb5z4vnjbl6f25dxj-nixos-system-machine-test1475machine # [ 45.179505] systemd[1]: test.service: Deactivated successfully.1476machine # [ 45.183156] systemd[1]: Stopped test.service.1477machine # [ 45.183856] systemd[1]: Stopped target Remote File Systems.1478machine # [ 45.185317] systemd[1]: Stopped target Local File Systems.1479machine # [ 45.470178] systemd[1]: Reload requested from client PID 2734 ('.switch-to-conf') (unit backdoor.service)...1480machine # [ 45.472228] systemd[1]: Reloading...1481machine # [ 45.809149] systemd[1]: Reloading finished in 335 ms.1482machine # [ 45.896417] systemd[560]: Reexecution requested from client PID 2803 ('switch-to-confi')...1483machine # [ 45.897960] systemd[560]: Reexecuting.1484machine # [ 45.959171] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1485machine # [ 46.071738] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1486machine # [ 46.078316] systemd[560]: Reload requested from client PID 2803 ('switch-to-confi')...1487machine # [ 46.081757] systemd[560]: Reloading...1488machine # [ 46.193185] systemd[560]: Reloading finished in 112 ms.1489machine # [ 46.208252] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1490machine # [ 46.218387] systemd[560]: Starting Run user-specific NixOS activation...1491machine # [ 46.253060] systemd[560]: Finished Run user-specific NixOS activation.1492machine # [ 46.258282] systemd[560]: Stopped Run user-specific NixOS activation.1493machine # [ 46.259316] systemd[560]: Stopping Run user-specific NixOS activation...1494machine # [ 46.262061] systemd[560]: Starting Run user-specific NixOS activation...1495machine # [ 46.269374] systemd[1]: Stopped target Reactivate sysinit units.1496machine # [ 46.270741] systemd[1]: Stopping Reactivate sysinit units...1497machine # [ 46.271574] systemd[1]: Reached target Reactivate sysinit units.1498machine # [ 46.275902] systemd[1]: Reached target Remote File Systems.1499machine # [ 46.287006] systemd[1]: Started test.service.1500machine # [ 46.295806] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1501machine # [ 46.306251] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1502machine # [ 46.311810] systemd[1]: Starting linger-users.service...1503machine # [ 46.317576] systemd[1]: Reached target Local File Systems.1504machine # [ 46.334475] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1505machine # [ 46.344243] systemd[560]: Finished Run user-specific NixOS activation.1506machine # [ 46.352657] systemd[1]: Starting Create SUID/SGID Wrappers...1507machine # [ 46.357127] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1508machine # [ 46.358383] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671509machine # [ 46.372305] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1510machine # [ 46.374001] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1511machine # [ 46.375251] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1512machine # [ 46.388805] systemd[1]: test.service: Deactivated successfully.1513machine # [ 46.423184] systemd[1]: linger-users.service: Deactivated successfully.1514machine # [ 46.428162] systemd[1]: Finished linger-users.service.1515machine # [ 46.570708] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1516machine # [ 46.573794] systemd[1]: Finished Create SUID/SGID Wrappers.1517machine # [ 46.832718] nixos[2734]: finished switching to system configuration /nix/store/9r0bz7g1cd48zpnzb5z4vnjbl6f25dxj-nixos-system-machine-test1518machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.90 seconds)1519machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&11520machine # [ 47.130901] nixos[2879]: switching to system configuration /nix/store/ilqn3s8n9l4dgxsfqnj0dhxczw307hnq-nixos-system-machine-test1521machine # [ 47.133761] systemd[1]: Stopped target Remote File Systems.1522machine # [ 47.136068] systemd[1]: Stopped target Local File Systems.1523machine # [ 47.419845] systemd[1]: Reload requested from client PID 2879 ('.switch-to-conf') (unit backdoor.service)...1524machine # [ 47.422004] systemd[1]: Reloading...1525machine # [ 47.752790] systemd[1]: Reloading finished in 329 ms.1526machine # [ 47.840177] systemd[560]: Reexecution requested from client PID 2948 ('switch-to-confi')...1527machine # [ 47.841581] systemd[560]: Reexecuting.1528machine # [ 47.895307] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1529machine # [ 48.010296] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1530machine # [ 48.017655] systemd[560]: Reload requested from client PID 2948 ('switch-to-confi')...1531machine # [ 48.020961] systemd[560]: Reloading...1532machine # [ 48.130005] systemd[560]: Reloading finished in 109 ms.1533machine # [ 48.144168] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1534machine # [ 48.152940] systemd[560]: Stopped Run user-specific NixOS activation.1535machine # [ 48.155189] systemd[560]: Stopping Run user-specific NixOS activation...1536machine # [ 48.157256] systemd[560]: Starting Run user-specific NixOS activation...1537machine # [ 48.187384] systemd[560]: Finished Run user-specific NixOS activation.1538machine # [ 48.191598] systemd[1]: Stopped target Reactivate sysinit units.1539machine # [ 48.194333] systemd[1]: Stopping Reactivate sysinit units...1540machine # [ 48.195200] systemd[1]: Reached target Reactivate sysinit units.1541machine # [ 48.198441] systemd[1]: Reached target Remote File Systems.1542machine # [ 48.202157] systemd[1]: Starting escaped\x2ddash.service...1543machine # [ 48.204180] systemd[1]: Starting linger-users.service...1544machine # [ 48.208720] systemd[1]: Reached target Local File Systems.1545machine # [ 48.219950] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1546machine # [ 48.228238] systemd[1]: Starting Create SUID/SGID Wrappers...1547machine # [ 48.229082] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1548machine # [ 48.230284] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671549machine # [ 48.237855] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1550machine # [ 48.239429] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1551machine # [ 48.243592] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1552machine # [ 48.253050] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1553machine # [ 48.254416] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1554machine # [ 48.280558] systemd[1]: Finished escaped\x2ddash.service.1555machine # [ 48.312823] systemd[1]: linger-users.service: Deactivated successfully.1556machine # [ 48.316810] systemd[1]: Finished linger-users.service.1557machine # [ 48.446525] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1558machine # [ 48.449546] systemd[1]: Finished Create SUID/SGID Wrappers.1559machine # [ 48.706435] nixos[2879]: finished switching to system configuration /nix/store/ilqn3s8n9l4dgxsfqnj0dhxczw307hnq-nixos-system-machine-test1560machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 1.87 seconds)1561machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&11562machine # [ 48.993754] nixos[3021]: switching to system configuration /nix/store/4y7vmq6qp3b5i19xlcy751hrrh286znc-nixos-system-machine-test1563machine # [ 48.996522] systemd[1]: Stopped target Local File Systems.1564machine # [ 48.998181] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1565machine # [ 49.000883] systemd[1]: Stopped escaped\x2ddash.service.1566machine # [ 49.001711] systemd[1]: Stopped target Remote File Systems.1567machine # [ 49.299315] systemd[1]: Reload requested from client PID 3021 ('.switch-to-conf') (unit backdoor.service)...1568machine # [ 49.301294] systemd[1]: Reloading...1569machine # [ 49.652060] systemd[1]: Reloading finished in 349 ms.1570machine # [ 49.746514] systemd[560]: Reexecution requested from client PID 3089 ('switch-to-confi')...1571machine # [ 49.747952] systemd[560]: Reexecuting.1572machine # [ 49.807855] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1573machine # [ 49.934892] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1574machine # [ 49.942177] systemd[560]: Reload requested from client PID 3089 ('switch-to-confi')...1575machine # [ 49.946208] systemd[560]: Reloading...1576machine # [ 50.064261] systemd[560]: Reloading finished in 119 ms.1577machine # [ 50.080207] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1578machine # [ 50.089583] systemd[560]: Stopped Run user-specific NixOS activation.1579machine # [ 50.092221] systemd[560]: Stopping Run user-specific NixOS activation...1580machine # [ 50.094871] systemd[560]: Starting Run user-specific NixOS activation...1581machine # [ 50.131888] systemd[560]: Finished Run user-specific NixOS activation.1582machine # [ 50.136461] systemd[1]: Stopped target Reactivate sysinit units.1583machine # [ 50.138634] systemd[1]: Stopping Reactivate sysinit units...1584machine # [ 50.139588] systemd[1]: Reached target Reactivate sysinit units.1585machine # [ 50.142866] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1586machine # [ 50.145804] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1587machine # [ 50.149242] systemd[1]: Reached target Local File Systems.1588machine # [ 50.150148] systemd[1]: Reached target Remote File Systems.1589machine # [ 50.155712] systemd[1]: Starting escaped\x2ddash.service...1590machine # [ 50.169014] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1591machine # [ 50.180311] systemd[1]: Starting Create SUID/SGID Wrappers...1592machine # [ 50.181356] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1593machine # [ 50.182646] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671594machine # [ 50.193035] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1595machine # [ 50.198216] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1596machine # [ 50.204191] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1597machine # [ 50.217108] systemd[1]: Finished escaped\x2ddash.service.1598machine # [ 50.367372] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1599machine # [ 50.372385] systemd[1]: Finished Create SUID/SGID Wrappers.1600machine # [ 50.374481] systemd[1]: Starting linger-users.service...1601machine # [ 50.417564] systemd[1]: linger-users.service: Deactivated successfully.1602machine # [ 50.420809] systemd[1]: Finished linger-users.service.1603machine # [ 50.680116] nixos[3021]: finished switching to system configuration /nix/store/4y7vmq6qp3b5i19xlcy751hrrh286znc-nixos-system-machine-test1604machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 1.98 seconds)1605machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&11606machine # [ 51.049718] nixos[3163]: switching to system configuration /nix/store/3gllqw6mrn0bsn9p8a110m4gy5zd3ylz-nixos-system-machine-test1607machine # [ 51.053637] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1608machine # [ 51.054792] systemd[1]: Stopped escaped\x2ddash.service.1609machine # [ 51.057674] systemd[1]: Stopped target Remote File Systems.1610machine # [ 51.059408] systemd[1]: Stopped target Local File Systems.1611machine # [ 51.392615] systemd[1]: Reload requested from client PID 3163 ('.switch-to-conf') (unit backdoor.service)...1612machine # [ 51.394231] systemd[1]: Reloading...1613machine # [ 51.746973] systemd[1]: Reloading finished in 351 ms.1614machine # [ 51.840750] systemd[560]: Reexecution requested from client PID 3232 ('switch-to-confi')...1615machine # [ 51.844498] systemd[560]: Reexecuting.1616machine # [ 51.899334] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1617machine # [ 52.015617] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1618machine # [ 52.023355] systemd[560]: Reload requested from client PID 3232 ('switch-to-confi')...1619machine # [ 52.026513] systemd[560]: Reloading...1620machine # [ 52.137949] systemd[560]: Reloading finished in 112 ms.1621machine # [ 52.152168] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1622machine # [ 52.161815] systemd[560]: Stopped Run user-specific NixOS activation.1623machine # [ 52.164132] systemd[560]: Stopping Run user-specific NixOS activation...1624machine # [ 52.166392] systemd[560]: Starting Run user-specific NixOS activation...1625machine # [ 52.202333] systemd[560]: Finished Run user-specific NixOS activation.1626machine # [ 52.207198] systemd[1]: Stopped target Reactivate sysinit units.1627machine # [ 52.209094] systemd[1]: Stopping Reactivate sysinit units...1628machine # [ 52.209932] systemd[1]: Reached target Reactivate sysinit units.1629machine # [ 52.215155] systemd[1]: Reached target Local File Systems.1630machine # [ 52.218782] systemd[1]: Reached target Remote File Systems.1631machine # [ 52.219638] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1632machine # [ 52.224206] systemd[1]: Starting Create SUID/SGID Wrappers...1633machine # [ 52.225114] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1634machine # [ 52.226365] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671635machine # [ 52.240428] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1636machine # [ 52.242145] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1637machine # [ 52.243429] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1638machine # [ 52.248484] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1639machine # [ 52.249825] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1640machine # [ 52.413671] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1641machine # [ 52.418622] systemd[1]: Finished Create SUID/SGID Wrappers.1642machine # [ 52.422308] systemd[1]: Starting -.service...1643machine # [ 52.425017] systemd[1]: Starting linger-users.service...1644machine # [ 52.466030] systemd[1]: Finished -.service.1645machine # [ 52.485691] systemd[1]: linger-users.service: Deactivated successfully.1646machine # [ 52.488401] systemd[1]: Finished linger-users.service.1647machine # [ 52.745057] nixos[3163]: finished switching to system configuration /nix/store/3gllqw6mrn0bsn9p8a110m4gy5zd3ylz-nixos-system-machine-test1648machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 2.06 seconds)1649machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&11650machine # [ 53.042486] nixos[3305]: switching to system configuration /nix/store/5rihsfma0h661983hhq2jkjf8jm5ka4j-nixos-system-machine-test1651machine # [ 53.045383] systemd[1]: Stopped target Local File Systems.1652machine # [ 53.048310] systemd[1]: Stopped target Remote File Systems.1653machine # [ 53.381706] systemd[1]: Reload requested from client PID 3305 ('.switch-to-conf') (unit backdoor.service)...1654machine # [ 53.383690] systemd[1]: Reloading...1655machine # [ 53.737358] systemd[1]: Reloading finished in 351 ms.1656machine # [ 53.828443] systemd[560]: Reexecution requested from client PID 3374 ('switch-to-confi')...1657machine # [ 53.829893] systemd[560]: Reexecuting.1658machine # [ 53.887198] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1659machine # [ 54.008185] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1660machine # [ 54.014589] systemd[560]: Reload requested from client PID 3374 ('switch-to-confi')...1661machine # [ 54.018249] systemd[560]: Reloading...1662machine # [ 54.131409] systemd[560]: Reloading finished in 114 ms.1663machine # [ 54.148162] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1664machine # [ 54.157307] systemd[560]: Stopped Run user-specific NixOS activation.1665machine # [ 54.159731] systemd[560]: Stopping Run user-specific NixOS activation...1666machine # [ 54.161944] systemd[560]: Starting Run user-specific NixOS activation...1667machine # [ 54.192599] systemd[560]: Finished Run user-specific NixOS activation.1668machine # [ 54.196572] systemd[1]: Stopped target Reactivate sysinit units.1669machine # [ 54.200417] systemd[1]: Stopping Reactivate sysinit units...1670machine # [ 54.201339] systemd[1]: Reached target Reactivate sysinit units.1671machine # [ 54.204327] systemd[1]: Reloading -.service...1672machine # [ 54.229510] systemd[1]: Reloaded -.service.1673machine # [ 54.231944] systemd[1]: Reached target Remote File Systems.1674machine # [ 54.237639] systemd[1]: Starting linger-users.service...1675machine # [ 54.243303] systemd[1]: Reached target Local File Systems.1676machine # [ 54.249694] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1677machine # [ 54.251174] systemd[1]: Starting Create SUID/SGID Wrappers...1678machine # [ 54.251963] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1679machine # [ 54.265750] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671680machine # [ 54.267947] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1681machine # [ 54.272482] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1682machine # [ 54.273794] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1683machine # [ 54.274950] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1684machine # [ 54.280847] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1685machine # [ 54.328540] systemd[1]: linger-users.service: Deactivated successfully.1686machine # [ 54.331664] systemd[1]: Finished linger-users.service.1687machine # [ 54.473086] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1688machine # [ 54.476296] systemd[1]: Finished Create SUID/SGID Wrappers.1689machine # [ 54.738596] nixos[3305]: finished switching to system configuration /nix/store/5rihsfma0h661983hhq2jkjf8jm5ka4j-nixos-system-machine-test1690machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 2.00 seconds)1691machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&11692machine # [ 55.049158] nixos[3447]: switching to system configuration /nix/store/3f2ik5n511nnbzq4ijb0h6fidhxlyi0h-nixos-system-machine-test1693machine # [ 55.052290] systemd[1]: -.service: Deactivated successfully.1694machine # [ 55.055730] systemd[1]: Stopped -.service.1695machine # [ 55.057385] systemd[1]: Stopped target Remote File Systems.1696machine # [ 55.058279] systemd[1]: Stopped target Local File Systems.1697machine # [ 55.357456] systemd[1]: Reload requested from client PID 3447 ('.switch-to-conf') (unit backdoor.service)...1698machine # [ 55.359415] systemd[1]: Reloading...1699machine # [ 55.710879] systemd[1]: Reloading finished in 349 ms.1700machine # [ 55.804761] systemd[560]: Reexecution requested from client PID 3515 ('switch-to-confi')...1701machine # [ 55.808692] systemd[560]: Reexecuting.1702machine # [ 55.867534] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1703machine # [ 55.986927] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1704machine # [ 55.993645] systemd[560]: Reload requested from client PID 3515 ('switch-to-confi')...1705machine # [ 55.997343] systemd[560]: Reloading...1706machine # [ 56.108377] systemd[560]: Reloading finished in 111 ms.1707machine # [ 56.129711] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1708machine # [ 56.137275] systemd[560]: Stopped Run user-specific NixOS activation.1709machine # [ 56.139672] systemd[560]: Stopping Run user-specific NixOS activation...1710machine # [ 56.141737] systemd[560]: Starting Run user-specific NixOS activation...1711machine # [ 56.177151] systemd[560]: Finished Run user-specific NixOS activation.1712machine # [ 56.181578] systemd[1]: Stopped target Reactivate sysinit units.1713machine # [ 56.183434] systemd[1]: Stopping Reactivate sysinit units...1714machine # [ 56.188210] systemd[1]: Reached target Reactivate sysinit units.1715machine # [ 56.189134] systemd[1]: Reached target Remote File Systems.1716machine # [ 56.192326] systemd[1]: Starting linger-users.service...1717machine # [ 56.195757] systemd[1]: Starting required-service.service...1718machine # [ 56.199748] systemd[1]: Starting test-service.service...1719machine # [ 56.216207] systemd[1]: Reached target Local File Systems.1720machine # [ 56.217172] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1721machine # [ 56.224889] systemd[1]: Starting Create SUID/SGID Wrappers...1722machine # [ 56.225867] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1723machine # [ 56.227101] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671724machine # [ 56.249742] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1725machine # [ 56.251535] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1726machine # [ 56.267067] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1727machine # [ 56.276842] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1728machine # [ 56.287773] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1729machine # [ 56.292821] systemd[1]: Finished required-service.service.1730machine # [ 56.293818] systemd[1]: Finished test-service.service.1731machine # [ 56.325322] systemd[1]: linger-users.service: Deactivated successfully.1732machine # [ 56.329028] systemd[1]: Finished linger-users.service.1733machine # [ 56.475011] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1734machine # [ 56.478103] systemd[1]: Finished Create SUID/SGID Wrappers.1735machine # [ 56.739169] nixos[3447]: finished switching to system configuration /nix/store/3f2ik5n511nnbzq4ijb0h6fidhxlyi0h-nixos-system-machine-test1736machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 2.00 seconds)1737machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&11738machine # [ 57.065940] nixos[3591]: switching to system configuration /nix/store/lqig7vnfmjf8pkvwb01xyfc5rmyr6zsb-nixos-system-machine-test1739machine # [ 57.069143] systemd[1]: Stopped target Remote File Systems.1740machine # [ 57.071557] systemd[1]: Stopped target Local File Systems.1741machine # [ 57.075018] systemd[1]: required-service.service: Deactivated successfully.1742machine # [ 57.077098] systemd[1]: Stopped required-service.service.1743machine # [ 57.078550] systemd[1]: test-service.service: Deactivated successfully.1744machine # [ 57.079495] systemd[1]: Stopped test-service.service.1745machine # [ 57.385156] systemd[1]: Reload requested from client PID 3591 ('.switch-to-conf') (unit backdoor.service)...1746machine # [ 57.387126] systemd[1]: Reloading...1747machine # [ 57.752891] systemd[1]: Reloading finished in 364 ms.1748machine # [ 57.845850] systemd[560]: Reexecution requested from client PID 3660 ('switch-to-confi')...1749machine # [ 57.850240] systemd[560]: Reexecuting.1750machine # [ 57.882992] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1751machine # [ 58.000602] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1752machine # [ 58.008332] systemd[560]: Reload requested from client PID 3660 ('switch-to-confi')...1753machine # [ 58.013085] systemd[560]: Reloading...1754machine # [ 58.129029] systemd[560]: Reloading finished in 117 ms.1755machine # [ 58.144180] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1756machine # [ 58.154725] systemd[560]: Stopped Run user-specific NixOS activation.1757machine # [ 58.157280] systemd[560]: Stopping Run user-specific NixOS activation...1758machine # [ 58.159569] systemd[560]: Starting Run user-specific NixOS activation...1759machine # [ 58.194034] systemd[560]: Finished Run user-specific NixOS activation.1760machine # [ 58.198525] systemd[1]: Stopped target Reactivate sysinit units.1761machine # [ 58.200688] systemd[1]: Stopping Reactivate sysinit units...1762machine # [ 58.201679] systemd[1]: Reached target Reactivate sysinit units.1763machine # [ 58.209881] systemd[1]: Starting required-service.service...1764machine # [ 58.212530] systemd[1]: Starting test-service.service...1765machine # [ 58.224147] systemd[1]: Reached target Local File Systems.1766machine # [ 58.230927] systemd[1]: Reached target Remote File Systems.1767machine # [ 58.244703] systemd[1]: Starting linger-users.service...1768machine # [ 58.251632] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1769machine # [ 58.262882] systemd[1]: Starting Create SUID/SGID Wrappers...1770machine # [ 58.263790] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1771machine # [ 58.278297] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671772machine # [ 58.286313] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1773machine # [ 58.287951] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1774machine # [ 58.300714] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1775machine # [ 58.302194] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1776machine # [ 58.311666] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1777machine # [ 58.316860] systemd[1]: Finished test-service.service.1778machine # [ 58.317741] systemd[1]: Finished required-service.service.1779machine # [ 58.365153] systemd[1]: linger-users.service: Deactivated successfully.1780machine # [ 58.368896] systemd[1]: Finished linger-users.service.1781machine # [ 58.519142] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1782machine # [ 58.522660] systemd[1]: Finished Create SUID/SGID Wrappers.1783machine # [ 58.779794] nixos[3591]: finished switching to system configuration /nix/store/lqig7vnfmjf8pkvwb01xyfc5rmyr6zsb-nixos-system-machine-test1784machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 2.04 seconds)1785machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&11786machine # [ 59.093633] nixos[3735]: switching to system configuration /nix/store/hc5iiax9ld9a41zcwkvi1q13r8j2kcn4-nixos-system-machine-test1787machine # [ 59.096383] systemd[1]: required-service.service: Deactivated successfully.1788machine # [ 59.099612] systemd[1]: Stopped required-service.service.1789machine # [ 59.101635] systemd[1]: test-service.service: Deactivated successfully.1790machine # [ 59.102725] systemd[1]: Stopped test-service.service.1791machine # [ 59.103435] systemd[1]: Stopped target Local File Systems.1792machine # [ 59.105599] systemd[1]: Stopped target Remote File Systems.1793machine # [ 59.409419] systemd[1]: Reload requested from client PID 3735 ('.switch-to-conf') (unit backdoor.service)...1794machine # [ 59.411485] systemd[1]: Reloading...1795machine # [ 59.767494] systemd[1]: Reloading finished in 354 ms.1796machine # [ 59.859214] systemd[560]: Reexecution requested from client PID 3804 ('switch-to-confi')...1797machine # [ 59.861552] systemd[560]: Reexecuting.1798machine # [ 59.919578] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1799machine # [ 60.039933] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1800machine # [ 60.046473] systemd[560]: Reload requested from client PID 3804 ('switch-to-confi')...1801machine # [ 60.050270] systemd[560]: Reloading...1802machine # [ 60.163558] systemd[560]: Reloading finished in 114 ms.1803machine # [ 60.180186] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1804machine # [ 60.191135] systemd[560]: Stopped Run user-specific NixOS activation.1805machine # [ 60.192654] systemd[560]: Stopping Run user-specific NixOS activation...1806machine # [ 60.194911] systemd[560]: Starting Run user-specific NixOS activation...1807machine # [ 60.230642] systemd[560]: Finished Run user-specific NixOS activation.1808machine # [ 60.235216] systemd[1]: Stopped target Reactivate sysinit units.1809machine # [ 60.236552] systemd[1]: Stopping Reactivate sysinit units...1810machine # [ 60.237375] systemd[1]: Reached target Reactivate sysinit units.1811machine # [ 60.238929] systemd[1]: Reached target Remote File Systems.1812machine # [ 60.243748] systemd[1]: Reached target Local File Systems.1813machine # [ 60.247436] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1814machine # [ 60.251147] systemd[1]: Starting Create SUID/SGID Wrappers...1815machine # [ 60.256311] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1816machine # [ 60.257688] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671817machine # [ 60.259865] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1818machine # [ 60.269022] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1819machine # [ 60.270380] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1820machine # [ 60.271575] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1821machine # [ 60.276292] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1822machine # [ 60.434921] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1823machine # [ 60.439789] systemd[1]: Finished Create SUID/SGID Wrappers.1824machine # [ 60.443656] systemd[1]: Starting linger-users.service...1825machine # [ 60.452613] systemd[1]: Starting required-service.service...1826machine # [ 60.453519] systemd[1]: Starting test-service.service...1827machine # [ 60.500672] systemd[1]: Finished test-service.service.1828machine # [ 60.503969] systemd[1]: Finished required-service.service.1829machine # [ 60.521442] systemd[1]: linger-users.service: Deactivated successfully.1830machine # [ 60.524582] systemd[1]: Finished linger-users.service.1831machine # [ 60.783306] nixos[3735]: finished switching to system configuration /nix/store/hc5iiax9ld9a41zcwkvi1q13r8j2kcn4-nixos-system-machine-test1832machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 2.00 seconds)1833machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&11834machine # [ 61.084872] nixos[3879]: switching to system configuration /nix/store/m7q5qy26pappsdlf57kirj2z1d84x2d2-nixos-system-machine-test1835machine # [ 61.087757] systemd[1]: Stopped target Local File Systems.1836machine # [ 61.092827] systemd[1]: required-service.service: Deactivated successfully.1837machine # [ 61.093924] systemd[1]: Stopped required-service.service.1838machine # [ 61.094672] systemd[1]: test-service.service: Deactivated successfully.1839machine # [ 61.095588] systemd[1]: Stopped test-service.service.1840machine # [ 61.096484] systemd[1]: Stopped target Remote File Systems.1841machine # [ 61.382898] systemd[1]: Reload requested from client PID 3879 ('.switch-to-conf') (unit backdoor.service)...1842machine # [ 61.385014] systemd[1]: Reloading...1843machine # [ 61.730787] systemd[1]: Reloading finished in 344 ms.1844machine # [ 61.819828] systemd[560]: Reexecution requested from client PID 3948 ('switch-to-confi')...1845machine # [ 61.823576] systemd[560]: Reexecuting.1846machine # [ 61.871356] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1847machine # [ 61.988146] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1848machine # [ 61.994705] systemd[560]: Reload requested from client PID 3948 ('switch-to-confi')...1849machine # [ 61.997041] systemd[560]: Reloading...1850machine # [ 62.110893] systemd[560]: Reloading finished in 112 ms.1851machine # [ 62.128185] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1852machine # [ 62.137537] systemd[560]: Stopped Run user-specific NixOS activation.1853machine # [ 62.139907] systemd[560]: Stopping Run user-specific NixOS activation...1854machine # [ 62.142105] systemd[560]: Starting Run user-specific NixOS activation...1855machine # [ 62.176521] systemd[560]: Finished Run user-specific NixOS activation.1856machine # [ 62.180705] systemd[1]: Stopped target Reactivate sysinit units.1857machine # [ 62.181674] systemd[1]: Stopping Reactivate sysinit units...1858machine # [ 62.182550] systemd[1]: Reached target Reactivate sysinit units.1859machine # [ 62.185816] systemd[1]: Reached target Remote File Systems.1860machine # [ 62.191923] systemd[1]: Created slice Slice /system/instantiated.1861machine # [ 62.195802] systemd[1]: Starting instantiated@one.service...1862machine # [ 62.200182] systemd[1]: Starting instantiated@two.service...1863machine # [ 62.209556] systemd[1]: Starting linger-users.service...1864machine # [ 62.218862] systemd[1]: Reached target Local File Systems.1865machine # [ 62.222975] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1866machine # [ 62.228136] systemd[1]: Starting Create SUID/SGID Wrappers...1867machine # [ 62.228996] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1868machine # [ 62.230220] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671869machine # [ 62.249055] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1870machine # [ 62.250778] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1871machine # [ 62.266022] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1872machine # [ 62.277037] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1873machine # [ 62.283745] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1874machine # [ 62.293508] systemd[1]: Finished instantiated@one.service.1875machine # [ 62.294425] systemd[1]: Finished instantiated@two.service.1876machine # [ 62.326735] systemd[1]: linger-users.service: Deactivated successfully.1877machine # [ 62.329107] systemd[1]: Finished linger-users.service.1878machine # [ 62.467731] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1879machine # [ 62.471198] systemd[1]: Finished Create SUID/SGID Wrappers.1880machine # [ 62.729766] nixos[3879]: finished switching to system configuration /nix/store/m7q5qy26pappsdlf57kirj2z1d84x2d2-nixos-system-machine-test1881machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.95 seconds)1882machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&11883machine # [ 63.034660] nixos[4023]: switching to system configuration /nix/store/y1qy2dlsgrf2cmyqhqi3v5jcxmk8xkss-nixos-system-machine-test1884machine # [ 63.037242] systemd[1]: instantiated@one.service: Deactivated successfully.1885machine # [ 63.040933] systemd[1]: Stopped instantiated@one.service.1886machine # [ 63.041822] systemd[1]: instantiated@two.service: Deactivated successfully.1887machine # [ 63.042779] systemd[1]: Stopped instantiated@two.service.1888machine # [ 63.043524] systemd[1]: Stopped target Remote File Systems.1889machine # [ 63.045357] systemd[1]: Stopped target Local File Systems.1890machine # [ 63.326895] systemd[1]: Reload requested from client PID 4023 ('.switch-to-conf') (unit backdoor.service)...1891machine # [ 63.328917] systemd[1]: Reloading...1892machine # [ 63.663235] systemd[1]: Reloading finished in 330 ms.1893machine # [ 63.750368] systemd[560]: Reexecution requested from client PID 4092 ('switch-to-confi')...1894machine # [ 63.753882] systemd[560]: Reexecuting.1895machine # [ 63.795109] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1896machine # [ 63.905370] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1897machine # [ 63.912093] systemd[560]: Reload requested from client PID 4092 ('switch-to-confi')...1898machine # [ 63.913419] systemd[560]: Reloading...1899machine # [ 64.022106] systemd[560]: Reloading finished in 107 ms.1900machine # [ 64.036170] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1901machine # [ 64.045817] systemd[560]: Stopped Run user-specific NixOS activation.1902machine # [ 64.048159] systemd[560]: Stopping Run user-specific NixOS activation...1903machine # [ 64.050214] systemd[560]: Starting Run user-specific NixOS activation...1904machine # [ 64.078955] systemd[560]: Finished Run user-specific NixOS activation.1905machine # [ 64.082647] systemd[1]: Stopped target Reactivate sysinit units.1906machine # [ 64.085661] systemd[1]: Stopping Reactivate sysinit units...1907machine # [ 64.086501] systemd[1]: Reached target Reactivate sysinit units.1908machine # [ 64.090706] systemd[1]: Starting instantiated@one.service...1909machine # [ 64.101165] systemd[1]: Starting instantiated@two.service...1910machine # [ 64.108347] systemd[1]: Reached target Local File Systems.1911machine # [ 64.109177] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1912machine # [ 64.120222] systemd[1]: Starting Create SUID/SGID Wrappers...1913machine # [ 64.121147] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1914machine # [ 64.122519] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671915machine # [ 64.140616] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1916machine # [ 64.142327] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1917machine # [ 64.155815] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1918machine # [ 64.160850] systemd[1]: Reached target Remote File Systems.1919machine # [ 64.161687] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1920machine # [ 64.162920] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1921machine # [ 64.169889] systemd[1]: Finished instantiated@one.service.1922machine # [ 64.177164] systemd[1]: Finished instantiated@two.service.1923machine # [ 64.320172] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1924machine # [ 64.324518] systemd[1]: Finished Create SUID/SGID Wrappers.1925machine # [ 64.327750] systemd[1]: Starting linger-users.service...1926machine # [ 64.368526] systemd[1]: linger-users.service: Deactivated successfully.1927machine # [ 64.371376] systemd[1]: Finished linger-users.service.1928machine # [ 64.629834] nixos[4023]: finished switching to system configuration /nix/store/y1qy2dlsgrf2cmyqhqi3v5jcxmk8xkss-nixos-system-machine-test1929machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.90 seconds)1930(finished: subtest: services, in 41.37 seconds)1931subtest: failing units1932machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11933machine # [ 64.900406] nixos[4167]: switching to system configuration /nix/store/x2ysb5v4hqnib4g99q9lxqa7ln87f77n-nixos-system-machine-test1934machine # [ 64.903178] systemd[1]: Stopped target Remote File Systems.1935machine # [ 64.905615] systemd[1]: instantiated@two.service: Deactivated successfully.1936machine # [ 64.906626] systemd[1]: Stopped instantiated@two.service.1937machine # [ 64.908061] systemd[1]: Stopped target Local File Systems.1938machine # [ 64.910443] systemd[1]: instantiated@one.service: Deactivated successfully.1939machine # [ 64.911965] systemd[1]: Stopped instantiated@one.service.1940machine # [ 65.176319] systemd[1]: Reload requested from client PID 4167 ('.switch-to-conf') (unit backdoor.service)...1941machine # [ 65.178275] systemd[1]: Reloading...1942machine # [ 65.503911] systemd[1]: Reloading finished in 323 ms.1943machine # [ 65.607172] systemd[560]: Reexecution requested from client PID 4236 ('switch-to-confi')...1944machine # [ 65.609548] systemd[560]: Reexecuting.1945machine # [ 65.677333] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1946machine # [ 65.799522] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1947machine # [ 65.806223] systemd[560]: Reload requested from client PID 4236 ('switch-to-confi')...1948machine # [ 65.808739] systemd[560]: Reloading...1949machine # [ 65.922279] systemd[560]: Reloading finished in 112 ms.1950machine # [ 65.940248] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1951machine # [ 65.949973] systemd[560]: Stopped Run user-specific NixOS activation.1952machine # [ 65.952965] systemd[560]: Stopping Run user-specific NixOS activation...1953machine # [ 65.955222] systemd[560]: Starting Run user-specific NixOS activation...1954machine # [ 65.988126] systemd[560]: Finished Run user-specific NixOS activation.1955machine # [ 65.992115] systemd[1]: Stopped target Reactivate sysinit units.1956machine # [ 65.994524] systemd[1]: Stopping Reactivate sysinit units...1957machine # [ 65.995461] systemd[1]: Reached target Reactivate sysinit units.1958machine # [ 65.999126] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1959machine # [ 66.001222] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1960machine # [ 66.004923] systemd[1]: Reached target Local File Systems.1961machine # [ 66.008794] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1962machine # [ 66.017086] systemd[1]: Starting Create SUID/SGID Wrappers...1963machine # [ 66.018067] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1964machine # [ 66.019277] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671965machine # [ 66.028445] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1966machine # [ 66.030130] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1967machine # [ 66.031385] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1968machine # [ 66.032696] systemd[1]: Reached target Remote File Systems.1969machine # [ 66.200687] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1970machine # [ 66.204491] systemd[1]: Finished Create SUID/SGID Wrappers.1971machine # [ 66.208444] systemd[1]: Starting linger-users.service...1972machine # [ 66.212649] systemd[1]: Starting test.service...1973machine # [ 66.248252] systemd[1]: Finished test.service.1974machine # [ 66.267347] systemd[1]: linger-users.service: Deactivated successfully.1975machine # [ 66.270130] systemd[1]: Finished linger-users.service.1976machine # [ 66.531565] nixos[4167]: finished switching to system configuration /nix/store/x2ysb5v4hqnib4g99q9lxqa7ln87f77n-nixos-system-machine-test1977machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.90 seconds)1978machine: must fail: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&11979machine # [ 66.850236] nixos[4309]: switching to system configuration /nix/store/111dfgwzsicjxs8dlpp12mdh3xkq13wc-nixos-system-machine-test1980machine # [ 66.853176] systemd[1]: Stopped target Remote File Systems.1981machine # [ 66.856850] systemd[1]: test.service: Deactivated successfully.1982machine # [ 66.858781] systemd[1]: Stopped test.service.1983machine # [ 66.859498] systemd[1]: Stopped target Local File Systems.1984machine # [ 67.163530] systemd[1]: Reload requested from client PID 4309 ('.switch-to-conf') (unit backdoor.service)...1985machine # [ 67.165752] systemd[1]: Reloading...1986machine # [ 67.513623] systemd[1]: Reloading finished in 346 ms.1987machine # [ 67.602903] systemd[560]: Reexecution requested from client PID 4378 ('switch-to-confi')...1988machine # [ 67.606473] systemd[560]: Reexecuting.1989machine # [ 67.655711] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1990machine # [ 67.775856] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1991machine # [ 67.783116] systemd[560]: Reload requested from client PID 4378 ('switch-to-confi')...1992machine # [ 67.787195] systemd[560]: Reloading...1993machine # [ 67.903885] systemd[560]: Reloading finished in 117 ms.1994machine # [ 67.920219] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1995machine # [ 67.930472] systemd[560]: Stopped Run user-specific NixOS activation.1996machine # [ 67.932826] systemd[560]: Stopping Run user-specific NixOS activation...1997machine # [ 67.934984] systemd[560]: Starting Run user-specific NixOS activation...1998machine # [ 67.969089] systemd[560]: Finished Run user-specific NixOS activation.1999machine # [ 67.972861] systemd[1]: Stopped target Reactivate sysinit units.2000machine # [ 67.976800] systemd[1]: Stopping Reactivate sysinit units...2001machine # [ 67.977696] systemd[1]: Reached target Reactivate sysinit units.2002machine # [ 67.978511] systemd[1]: Reached target Local File Systems.2003machine # [ 67.981788] systemd[1]: Reached target Remote File Systems.2004machine # [ 67.987756] systemd[1]: Starting test.service...2005machine # [ 67.997545] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2006machine # [ 68.015480] systemd[1]: Starting Create SUID/SGID Wrappers...2007machine # [ 68.021407] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2008machine # [ 68.022706] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672009machine # [ 68.030265] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2010machine # [ 68.033254] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2011machine # [ 68.034552] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2012machine # [ 68.035718] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2013machine # [ 68.044679] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2014machine # [ 68.047290] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE2015machine # [ 68.049963] systemd[1]: test.service: Failed with result 'exit-code'.2016machine # [ 68.053339] systemd[1]: Failed to start test.service.2017machine # [ 68.210025] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2018machine # [ 68.213183] systemd[1]: Finished Create SUID/SGID Wrappers.2019machine # [ 68.218034] systemd[1]: Starting linger-users.service...2020machine # [ 68.271607] systemd[1]: linger-users.service: Deactivated successfully.2021machine # [ 68.273884] systemd[1]: Finished linger-users.service.2022machine # [ 68.569789] nixos[4309]: switching to system configuration /nix/store/111dfgwzsicjxs8dlpp12mdh3xkq13wc-nixos-system-machine-test failed (status 4)2023machine: (finished: must fail: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 2.04 seconds)2024machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12025machine # [ 68.864969] nixos[4452]: switching to system configuration /nix/store/5ags8ljf6gch21wmg50jiyd3bgp82ab9-nixos-system-machine-test2026machine # [ 68.867555] systemd[1]: Stopped target Remote File Systems.2027machine # [ 68.869925] systemd[1]: Stopped target Local File Systems.2028machine # [ 69.157621] systemd[1]: Reload requested from client PID 4452 ('.switch-to-conf') (unit backdoor.service)...2029machine # [ 69.159507] systemd[1]: Reloading...2030machine # [ 69.497704] systemd[1]: Reloading finished in 336 ms.2031machine # [ 69.584368] systemd[560]: Reexecution requested from client PID 4521 ('switch-to-confi')...2032machine # [ 69.588113] systemd[560]: Reexecuting.2033machine # [ 69.639245] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2034machine # [ 69.755306] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2035machine # [ 69.761934] systemd[560]: Reload requested from client PID 4521 ('switch-to-confi')...2036machine # [ 69.764396] systemd[560]: Reloading...2037machine # [ 69.878804] systemd[560]: Reloading finished in 113 ms.2038machine # [ 69.900195] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2039machine # [ 69.910307] systemd[560]: Stopped Run user-specific NixOS activation.2040machine # [ 69.912810] systemd[560]: Stopping Run user-specific NixOS activation...2041machine # [ 69.915049] systemd[560]: Starting Run user-specific NixOS activation...2042machine # [ 69.948848] systemd[560]: Finished Run user-specific NixOS activation.2043machine # [ 69.952754] systemd[1]: Stopped target Reactivate sysinit units.2044machine # [ 69.953739] systemd[1]: Stopping Reactivate sysinit units...2045machine # [ 69.955435] systemd[1]: Reached target Reactivate sysinit units.2046machine # [ 69.961381] systemd[1]: Reached target Local File Systems.2047machine # [ 69.963923] systemd[1]: Reached target Remote File Systems.2048machine # [ 69.969932] systemd[1]: Started autorestart.service.2049machine # [ 69.976379] systemd[1]: Starting linger-users.service...2050machine # [ 69.987462] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2051machine # [ 69.994072] systemd[1]: Starting Create SUID/SGID Wrappers...2052machine # [ 69.994952] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2053machine # [ 70.004569] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672054machine # [ 70.006859] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2055machine # [ 70.020008] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2056machine # [ 70.028138] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2057machine # [ 70.032855] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2058machine # [ 70.038591] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2059machine # [ 70.047450] systemd[1]: autorestart.service: Deactivated successfully.2060machine # [ 70.075555] systemd[1]: linger-users.service: Deactivated successfully.2061machine # [ 70.079462] systemd[1]: Finished linger-users.service.2062machine # [ 70.219332] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2063machine # [ 70.222783] systemd[1]: Finished Create SUID/SGID Wrappers.2064machine # [ 70.483401] nixos[4452]: finished switching to system configuration /nix/store/5ags8ljf6gch21wmg50jiyd3bgp82ab9-nixos-system-machine-test2065machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.91 seconds)2066machine # [ 70.558181] systemd[1]: Stopped autorestart.service.2067machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12068machine # [ 70.792599] nixos[4599]: switching to system configuration /nix/store/5ags8ljf6gch21wmg50jiyd3bgp82ab9-nixos-system-machine-test2069machine # [ 70.796139] systemd[1]: Stopped target Remote File Systems.2070machine # [ 70.797050] systemd[1]: Stopped target Local File Systems.2071machine # [ 71.068327] systemd[1]: Reload requested from client PID 4599 ('.switch-to-conf') (unit backdoor.service)...2072machine # [ 71.069885] systemd[1]: Reloading...2073machine # [ 71.386383] systemd[1]: Reloading finished in 314 ms.2074machine # [ 71.476933] systemd[560]: Reexecution requested from client PID 4668 ('switch-to-confi')...2075machine # [ 71.481144] systemd[560]: Reexecuting.2076machine # [ 71.539883] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2077machine # [ 71.663425] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2078machine # [ 71.670534] systemd[560]: Reload requested from client PID 4668 ('switch-to-confi')...2079machine # [ 71.674530] systemd[560]: Reloading...2080machine # [ 71.789274] systemd[560]: Reloading finished in 115 ms.2081machine # [ 71.804218] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2082machine # [ 71.813898] systemd[560]: Stopped Run user-specific NixOS activation.2083machine # [ 71.816082] systemd[560]: Stopping Run user-specific NixOS activation...2084machine # [ 71.818546] systemd[560]: Starting Run user-specific NixOS activation...2085machine # [ 71.852910] systemd[560]: Finished Run user-specific NixOS activation.2086machine # [ 71.856859] systemd[1]: Stopped target Reactivate sysinit units.2087machine # [ 71.859434] systemd[1]: Stopping Reactivate sysinit units...2088machine # [ 71.861128] systemd[1]: Reached target Reactivate sysinit units.2089machine # [ 71.863857] systemd[1]: Reached target Local File Systems.2090machine # [ 71.868460] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2091machine # [ 71.878085] systemd[1]: Starting Create SUID/SGID Wrappers...2092machine # [ 71.879103] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2093machine # [ 71.880899] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672094machine # [ 71.890620] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2095machine # [ 71.892642] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2096machine # [ 71.893979] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2097machine # [ 71.895220] systemd[1]: Reached target Remote File Systems.2098machine # [ 71.897397] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2099machine # [ 71.899768] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2100machine # [ 72.064842] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2101machine # [ 72.068749] systemd[1]: Finished Create SUID/SGID Wrappers.2102machine # [ 72.072450] systemd[1]: Started autorestart.service.2103machine # [ 72.075237] systemd[1]: Starting linger-users.service...2104machine # [ 72.116689] systemd[1]: autorestart.service: Deactivated successfully.2105machine # [ 72.136730] systemd[1]: linger-users.service: Deactivated successfully.2106machine # [ 72.139782] systemd[1]: Finished linger-users.service.2107machine # [ 72.399804] nixos[4599]: finished switching to system configuration /nix/store/5ags8ljf6gch21wmg50jiyd3bgp82ab9-nixos-system-machine-test2108machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.84 seconds)2109machine # [ 72.474747] systemd[1]: Stopped autorestart.service.2110machine: must fail: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&12111machine # [ 72.737665] nixos[4746]: switching to system configuration /nix/store/n0sxhk0n9cl779fizmxd8hrk32qbk578-nixos-system-machine-test2112machine # [ 72.740202] systemd[1]: Stopped target Remote File Systems.2113machine # [ 72.742603] systemd[1]: Stopped target Local File Systems.2114machine # [ 73.033855] systemd[1]: Reload requested from client PID 4746 ('.switch-to-conf') (unit backdoor.service)...2115machine # [ 73.035785] systemd[1]: Reloading...2116machine # [ 73.379813] systemd[1]: Reloading finished in 342 ms.2117machine # [ 73.474331] systemd[560]: Reexecution requested from client PID 4815 ('switch-to-confi')...2118machine # [ 73.475702] systemd[560]: Reexecuting.2119machine # [ 73.535582] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2120machine # [ 73.656593] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2121machine # [ 73.663411] systemd[560]: Reload requested from client PID 4815 ('switch-to-confi')...2122machine # [ 73.665752] systemd[560]: Reloading...2123machine # [ 73.779543] systemd[560]: Reloading finished in 112 ms.2124machine # [ 73.794388] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2125machine # [ 73.805460] systemd[560]: Stopped Run user-specific NixOS activation.2126machine # [ 73.808132] systemd[560]: Stopping Run user-specific NixOS activation...2127machine # [ 73.811077] systemd[560]: Starting Run user-specific NixOS activation...2128machine # [ 73.848138] systemd[560]: Finished Run user-specific NixOS activation.2129machine # [ 73.852925] systemd[1]: Stopped target Reactivate sysinit units.2130machine # [ 73.856898] systemd[1]: Stopping Reactivate sysinit units...2131machine # [ 73.857927] systemd[1]: Reached target Reactivate sysinit units.2132machine # [ 73.859876] systemd[1]: Reached target Local File Systems.2133machine # [ 73.863097] systemd[1]: Reached target Remote File Systems.2134machine # [ 73.869049] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2135machine # [ 73.880239] systemd[1]: Starting Create SUID/SGID Wrappers...2136machine # [ 73.881239] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2137machine # [ 73.882518] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672138machine # [ 73.889870] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2139machine # [ 73.891506] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2140machine # [ 73.892850] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2141machine # [ 73.894126] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2142machine # [ 73.895493] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2143machine # [ 74.060561] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2144machine # [ 74.064597] systemd[1]: Finished Create SUID/SGID Wrappers.2145machine # [ 74.066317] systemd[1]: Started autorestart.service.2146machine # [ 74.071051] systemd[1]: Starting linger-users.service...2147machine # [ 74.110921] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE2148machine # [ 74.115160] systemd[1]: autorestart.service: Failed with result 'exit-code'.2149machine # [ 74.133365] systemd[1]: linger-users.service: Deactivated successfully.2150machine # [ 74.136161] systemd[1]: Finished linger-users.service.2151machine # [ 74.443912] nixos[4746]: switching to system configuration /nix/store/n0sxhk0n9cl779fizmxd8hrk32qbk578-nixos-system-machine-test failed (status 4)2152machine: (finished: must fail: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.97 seconds)2153(finished: subtest: failing units, in 9.81 seconds)2154subtest: unit file parser2155machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12156machine # [ 74.698901] nixos[4889]: switching to system configuration /nix/store/k9cd3abnik0zy4an4glnrpdnvngi11df-nixos-system-machine-test2157machine # [ 74.701570] systemd[1]: Stopped target Remote File Systems.2158machine # [ 74.704967] systemd[1]: Stopped target Local File Systems.2159machine # [ 74.705930] systemd[1]: Stopped autorestart.service.2160machine # [ 74.994624] systemd[1]: Reload requested from client PID 4889 ('.switch-to-conf') (unit backdoor.service)...2161machine # [ 74.996814] systemd[1]: Reloading...2162machine # [ 75.336270] systemd[1]: Reloading finished in 337 ms.2163machine # [ 75.436855] systemd[560]: Reexecution requested from client PID 4958 ('switch-to-confi')...2164machine # [ 75.441970] systemd[560]: Reexecuting.2165machine # [ 75.491971] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2166machine # [ 75.616945] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2167machine # [ 75.623651] systemd[560]: Reload requested from client PID 4958 ('switch-to-confi')...2168machine # [ 75.627617] systemd[560]: Reloading...2169machine # [ 75.742032] systemd[560]: Reloading finished in 114 ms.2170machine # [ 75.760207] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2171machine # [ 75.772092] systemd[560]: Stopped Run user-specific NixOS activation.2172machine # [ 75.773246] systemd[560]: Stopping Run user-specific NixOS activation...2173machine # [ 75.775825] systemd[560]: Starting Run user-specific NixOS activation...2174machine # [ 75.812118] systemd[560]: Finished Run user-specific NixOS activation.2175machine # [ 75.816830] systemd[1]: Stopped target Reactivate sysinit units.2176machine # [ 75.819042] systemd[1]: Stopping Reactivate sysinit units...2177machine # [ 75.820005] systemd[1]: Reached target Reactivate sysinit units.2178machine # [ 75.824389] systemd[1]: Reached target Local File Systems.2179machine # [ 75.825448] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2180machine # [ 75.836215] systemd[1]: Starting Create SUID/SGID Wrappers...2181machine # [ 75.837212] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2182machine # [ 75.838465] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672183machine # [ 75.849535] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2184machine # [ 75.851165] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2185machine # [ 75.852696] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2186machine # [ 75.853933] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2187machine # [ 75.855227] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2188machine # [ 75.859225] systemd[1]: Reached target Remote File Systems.2189machine # [ 76.021708] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2190machine # [ 76.027030] systemd[1]: Finished Create SUID/SGID Wrappers.2191machine # [ 76.030378] systemd[1]: Starting linger-users.service...2192machine # [ 76.032995] systemd[1]: Starting test.service...2193machine # [ 76.071870] systemd[1]: Finished test.service.2194machine # [ 76.089701] systemd[1]: linger-users.service: Deactivated successfully.2195machine # [ 76.092828] systemd[1]: Finished linger-users.service.2196machine # [ 76.351327] nixos[4889]: finished switching to system configuration /nix/store/k9cd3abnik0zy4an4glnrpdnvngi11df-nixos-system-machine-test2197machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.91 seconds)2198machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&12199machine # [ 76.651945] nixos[5031]: switching to system configuration /nix/store/gqb69ayqpfphdbwmrx8xh6hw4s7xdxiv-nixos-system-machine-test2200machine # [ 76.656419] systemd[1]: Stopped target Remote File Systems.2201machine # [ 76.658161] systemd[1]: Stopped target Local File Systems.2202machine # [ 76.937539] systemd[1]: Reload requested from client PID 5031 ('.switch-to-conf') (unit backdoor.service)...2203machine # [ 76.939412] systemd[1]: Reloading...2204machine # [ 77.277806] systemd[1]: Reloading finished in 336 ms.2205machine # [ 77.370958] systemd[560]: Reexecution requested from client PID 5100 ('switch-to-confi')...2206machine # [ 77.374637] systemd[560]: Reexecuting.2207machine # [ 77.435583] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2208machine # [ 77.560685] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2209machine # [ 77.567793] systemd[560]: Reload requested from client PID 5100 ('switch-to-confi')...2210machine # [ 77.571102] systemd[560]: Reloading...2211machine # [ 77.682915] systemd[560]: Reloading finished in 113 ms.2212machine # [ 77.700175] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2213machine # [ 77.710969] systemd[560]: Stopped Run user-specific NixOS activation.2214machine # [ 77.713369] systemd[560]: Stopping Run user-specific NixOS activation...2215machine # [ 77.715480] systemd[560]: Starting Run user-specific NixOS activation...2216machine # [ 77.747952] systemd[560]: Finished Run user-specific NixOS activation.2217machine # [ 77.751921] systemd[1]: Stopped target Reactivate sysinit units.2218machine # [ 77.756605] systemd[1]: Stopping Reactivate sysinit units...2219machine # [ 77.757480] systemd[1]: Reached target Reactivate sysinit units.2220machine # [ 77.758324] systemd[1]: test.service: Deactivated successfully.2221machine # [ 77.759171] systemd[1]: Stopped test.service.2222machine # [ 77.759805] systemd[1]: Stopping test.service...2223machine # [ 77.761774] systemd[1]: Starting test.service...2224machine # [ 77.786716] systemd[1]: Finished test.service.2225machine # [ 77.790589] systemd[1]: Reached target Remote File Systems.2226machine # [ 77.794806] systemd[1]: Starting linger-users.service...2227machine # [ 77.800470] systemd[1]: Reached target Local File Systems.2228machine # [ 77.809096] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2229machine # [ 77.810548] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2230machine # [ 77.814705] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2231machine # [ 77.825259] systemd[1]: Starting Create SUID/SGID Wrappers...2232machine # [ 77.826170] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2233machine # [ 77.827427] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672234machine # [ 77.836945] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2235machine # [ 77.839355] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2236machine # [ 77.841236] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2237machine # [ 77.885662] systemd[1]: linger-users.service: Deactivated successfully.2238machine # [ 77.889143] systemd[1]: Finished linger-users.service.2239machine # [ 78.029777] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2240machine # [ 78.032850] systemd[1]: Finished Create SUID/SGID Wrappers.2241machine # [ 78.291331] nixos[5031]: finished switching to system configuration /nix/store/gqb69ayqpfphdbwmrx8xh6hw4s7xdxiv-nixos-system-machine-test2242machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.94 seconds)2243machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&12244machine # [ 78.598335] nixos[5173]: switching to system configuration /nix/store/d5spvbxxpav103j51a3kg0lrvaiqwyl0-nixos-system-machine-test2245machine # [ 78.601193] systemd[1]: Stopped target Remote File Systems.2246machine # [ 78.603483] systemd[1]: Stopped target Local File Systems.2247machine # [ 78.888855] systemd[1]: Reload requested from client PID 5173 ('.switch-to-conf') (unit backdoor.service)...2248machine # [ 78.890778] systemd[1]: Reloading...2249machine # [ 79.254804] systemd[1]: Reloading finished in 362 ms.2250machine # [ 79.360488] systemd[560]: Reexecution requested from client PID 5242 ('switch-to-confi')...2251machine # [ 79.364416] systemd[560]: Reexecuting.2252machine # [ 79.424160] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2253machine # [ 79.561007] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2254machine # [ 79.568125] systemd[560]: Reload requested from client PID 5242 ('switch-to-confi')...2255machine # [ 79.569581] systemd[560]: Reloading...2256machine # [ 79.687152] systemd[560]: Reloading finished in 115 ms.2257machine # [ 79.704190] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2258machine # [ 79.714235] systemd[560]: Stopped Run user-specific NixOS activation.2259machine # [ 79.716865] systemd[560]: Stopping Run user-specific NixOS activation...2260machine # [ 79.719415] systemd[560]: Starting Run user-specific NixOS activation...2261machine # [ 79.754440] systemd[560]: Finished Run user-specific NixOS activation.2262machine # [ 79.759053] systemd[1]: Stopped target Reactivate sysinit units.2263machine # [ 79.760964] systemd[1]: Stopping Reactivate sysinit units...2264machine # [ 79.761885] systemd[1]: Reached target Reactivate sysinit units.2265machine # [ 79.766221] systemd[1]: test.service: Deactivated successfully.2266machine # [ 79.767207] systemd[1]: Stopped test.service.2267machine # [ 79.767881] systemd[1]: Stopping test.service...2268machine # [ 79.770998] systemd[1]: Starting test.service...2269machine # [ 79.799097] systemd[1]: Finished test.service.2270machine # [ 79.805182] systemd[1]: Reached target Local File Systems.2271machine # [ 79.809394] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2272machine # [ 79.813808] systemd[1]: Starting Create SUID/SGID Wrappers...2273machine # [ 79.814693] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2274machine # [ 79.815940] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672275machine # [ 79.831122] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2276machine # [ 79.834866] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2277machine # [ 79.836483] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2278machine # [ 79.838891] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2279machine # [ 79.840983] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2280machine # [ 79.842817] systemd[1]: Reached target Remote File Systems.2281machine # [ 80.007082] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2282machine # [ 80.012282] systemd[1]: Finished Create SUID/SGID Wrappers.2283machine # [ 80.014632] systemd[1]: Starting linger-users.service...2284machine # [ 80.058991] systemd[1]: linger-users.service: Deactivated successfully.2285machine # [ 80.061624] systemd[1]: Finished linger-users.service.2286machine # [ 80.320000] nixos[5173]: finished switching to system configuration /nix/store/d5spvbxxpav103j51a3kg0lrvaiqwyl0-nixos-system-machine-test2287machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 2.03 seconds)2288machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12289machine # [ 80.601818] nixos[5315]: switching to system configuration /nix/store/k9cd3abnik0zy4an4glnrpdnvngi11df-nixos-system-machine-test2290machine # [ 80.604627] systemd[1]: Stopped target Remote File Systems.2291machine # [ 80.606295] systemd[1]: Stopped target Local File Systems.2292machine # [ 80.870416] systemd[1]: Reload requested from client PID 5315 ('.switch-to-conf') (unit backdoor.service)...2293machine # [ 80.872407] systemd[1]: Reloading...2294machine # [ 81.199962] systemd[1]: Reloading finished in 325 ms.2295machine # [ 81.293796] systemd[560]: Reexecution requested from client PID 5384 ('switch-to-confi')...2296machine # [ 81.295207] systemd[560]: Reexecuting.2297machine # [ 81.355524] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2298machine # [ 81.477071] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2299machine # [ 81.483972] systemd[560]: Reload requested from client PID 5384 ('switch-to-confi')...2300machine # [ 81.485435] systemd[560]: Reloading...2301machine # [ 81.603752] systemd[560]: Reloading finished in 116 ms.2302machine # [ 81.620182] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2303machine # [ 81.630941] systemd[560]: Stopped Run user-specific NixOS activation.2304machine # [ 81.633489] systemd[560]: Stopping Run user-specific NixOS activation...2305machine # [ 81.635663] systemd[560]: Starting Run user-specific NixOS activation...2306machine # [ 81.669191] systemd[560]: Finished Run user-specific NixOS activation.2307machine # [ 81.673551] systemd[1]: Stopped target Reactivate sysinit units.2308machine # [ 81.675616] systemd[1]: Stopping Reactivate sysinit units...2309machine # [ 81.679880] systemd[1]: Reached target Reactivate sysinit units.2310machine # [ 81.680988] systemd[1]: test.service: Deactivated successfully.2311machine # [ 81.681885] systemd[1]: Stopped test.service.2312machine # [ 81.682534] systemd[1]: Stopping test.service...2313machine # [ 81.684437] systemd[1]: Starting test.service...2314machine # [ 81.710517] systemd[1]: Finished test.service.2315machine # [ 81.715249] systemd[1]: Reached target Local File Systems.2316machine # [ 81.719427] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2317machine # [ 81.728871] systemd[1]: Starting Create SUID/SGID Wrappers...2318machine # [ 81.729832] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2319machine # [ 81.731061] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672320machine # [ 81.739634] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2321machine # [ 81.745825] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2322machine # [ 81.747270] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2323machine # [ 81.750829] systemd[1]: Reached target Remote File Systems.2324machine # [ 81.752814] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2325machine # [ 81.754594] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2326machine # [ 81.915072] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2327machine # [ 81.920298] systemd[1]: Finished Create SUID/SGID Wrappers.2328machine # [ 81.922544] systemd[1]: Starting linger-users.service...2329machine # [ 81.966755] systemd[1]: linger-users.service: Deactivated successfully.2330machine # [ 81.969671] systemd[1]: Finished linger-users.service.2331machine # [ 82.228229] nixos[5315]: finished switching to system configuration /nix/store/k9cd3abnik0zy4an4glnrpdnvngi11df-nixos-system-machine-test2332machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.91 seconds)2333machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&12334machine # [ 82.531736] nixos[5457]: switching to system configuration /nix/store/89y6s2vl0m5cm7hksf6hn8wpmk2my9cd-nixos-system-machine-test2335machine # [ 82.536305] systemd[1]: Stopped target Remote File Systems.2336machine # [ 82.537833] systemd[1]: Stopped target Local File Systems.2337machine # [ 82.837549] systemd[1]: Reload requested from client PID 5457 ('.switch-to-conf') (unit backdoor.service)...2338machine # [ 82.839516] systemd[1]: Reloading...2339machine # [ 83.211066] systemd[1]: Reloading finished in 369 ms.2340machine # [ 83.312852] systemd[560]: Reexecution requested from client PID 5526 ('switch-to-confi')...2341machine # [ 83.316989] systemd[560]: Reexecuting.2342machine # [ 83.380101] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2343machine # [ 83.516120] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2344machine # [ 83.524326] systemd[560]: Reload requested from client PID 5526 ('switch-to-confi')...2345machine # [ 83.527027] systemd[560]: Reloading...2346machine # [ 83.644777] systemd[560]: Reloading finished in 116 ms.2347machine # [ 83.660205] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2348machine # [ 83.670607] systemd[560]: Stopped Run user-specific NixOS activation.2349machine # [ 83.673500] systemd[560]: Stopping Run user-specific NixOS activation...2350machine # [ 83.676267] systemd[560]: Starting Run user-specific NixOS activation...2351machine # [ 83.711746] systemd[560]: Finished Run user-specific NixOS activation.2352machine # [ 83.716875] systemd[1]: Stopped target Reactivate sysinit units.2353machine # [ 83.719858] systemd[1]: Stopping Reactivate sysinit units...2354machine # [ 83.722523] systemd[1]: Reached target Reactivate sysinit units.2355machine # [ 83.723442] systemd[1]: Reached target Remote File Systems.2356machine # [ 83.726830] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2357machine # [ 83.729415] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2358machine # [ 83.733540] systemd[1]: Reached target Local File Systems.2359machine # [ 83.736872] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2360machine # [ 83.741888] systemd[1]: Starting Create SUID/SGID Wrappers...2361machine # [ 83.742883] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2362machine # [ 83.752185] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672363machine # [ 83.754617] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2364machine # [ 83.760500] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2365machine # [ 83.761962] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2366machine # [ 83.937778] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2367machine # [ 83.939556] systemd[1]: Finished Create SUID/SGID Wrappers.2368machine # [ 83.944864] systemd[1]: Starting linger-users.service...2369machine # [ 83.987896] systemd[1]: linger-users.service: Deactivated successfully.2370machine # [ 83.990742] systemd[1]: Finished linger-users.service.2371machine # [ 84.251657] nixos[5457]: finished switching to system configuration /nix/store/89y6s2vl0m5cm7hksf6hn8wpmk2my9cd-nixos-system-machine-test2372machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 2.02 seconds)2373machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&12374machine # [ 84.569797] nixos[5597]: switching to system configuration /nix/store/fg8ml4cl2d8vmnyd4i9srq240dapwxs4-nixos-system-machine-test2375machine # [ 84.573147] systemd[1]: Stopped target Remote File Systems.2376machine # [ 84.575372] systemd[1]: Stopped target Local File Systems.2377machine # [ 84.864584] systemd[1]: Reload requested from client PID 5597 ('.switch-to-conf') (unit backdoor.service)...2378machine # [ 84.866554] systemd[1]: Reloading...2379machine # [ 85.209952] systemd[1]: Reloading finished in 341 ms.2380machine # [ 85.301779] systemd[560]: Reexecution requested from client PID 5666 ('switch-to-confi')...2381machine # [ 85.305613] systemd[560]: Reexecuting.2382machine # [ 85.367985] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2383machine # [ 85.494507] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2384machine # [ 85.501669] systemd[560]: Reload requested from client PID 5666 ('switch-to-confi')...2385machine # [ 85.505731] systemd[560]: Reloading...2386machine # [ 85.615021] systemd[560]: Reloading finished in 110 ms.2387machine # [ 85.628181] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2388machine # [ 85.638034] systemd[560]: Stopped Run user-specific NixOS activation.2389machine # [ 85.640353] systemd[560]: Stopping Run user-specific NixOS activation...2390machine # [ 85.642475] systemd[560]: Starting Run user-specific NixOS activation...2391machine # [ 85.676901] systemd[560]: Finished Run user-specific NixOS activation.2392machine # [ 85.681331] systemd[1]: Stopped target Reactivate sysinit units.2393machine # [ 85.682681] systemd[1]: Stopping Reactivate sysinit units...2394machine # [ 85.683501] systemd[1]: Reached target Reactivate sysinit units.2395machine # [ 85.688202] systemd[1]: test.service: Deactivated successfully.2396machine # [ 85.689120] systemd[1]: Stopped test.service.2397machine # [ 85.689776] systemd[1]: Stopping test.service...2398machine # [ 85.691559] systemd[1]: Starting test.service...2399machine # [ 85.719126] systemd[1]: Finished test.service.2400machine # [ 85.721728] systemd[1]: Reached target Remote File Systems.2401machine # [ 85.730043] systemd[1]: Reached target Local File Systems.2402machine # [ 85.732575] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2403machine # [ 85.737647] systemd[1]: Starting Create SUID/SGID Wrappers...2404machine # [ 85.738535] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2405machine # [ 85.739753] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672406machine # [ 85.748315] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2407machine # [ 85.750069] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2408machine # [ 85.751279] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2409machine # [ 85.755275] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2410machine # [ 85.756667] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2411machine # [ 85.918166] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2412machine # [ 85.923094] systemd[1]: Finished Create SUID/SGID Wrappers.2413machine # [ 85.925463] systemd[1]: Starting linger-users.service...2414machine # [ 85.965532] systemd[1]: linger-users.service: Deactivated successfully.2415machine # [ 85.968112] systemd[1]: Finished linger-users.service.2416machine # [ 86.226354] nixos[5597]: finished switching to system configuration /nix/store/fg8ml4cl2d8vmnyd4i9srq240dapwxs4-nixos-system-machine-test2417machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.98 seconds)2418machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&12419machine # [ 86.530996] nixos[5739]: switching to system configuration /nix/store/j4jpm48alp5y4jscx38l89pxygps86m9-nixos-system-machine-test2420machine # [ 86.533521] systemd[1]: Stopped target Local File Systems.2421machine # [ 86.535857] systemd[1]: Stopped target Remote File Systems.2422machine # [ 86.820455] systemd[1]: Reload requested from client PID 5739 ('.switch-to-conf') (unit backdoor.service)...2423machine # [ 86.822353] systemd[1]: Reloading...2424machine # [ 87.166343] systemd[1]: Reloading finished in 342 ms.2425machine # [ 87.258628] systemd[560]: Reexecution requested from client PID 5808 ('switch-to-confi')...2426machine # [ 87.262160] systemd[560]: Reexecuting.2427machine # [ 87.319496] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2428machine # [ 87.439500] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2429machine # [ 87.446242] systemd[560]: Reload requested from client PID 5808 ('switch-to-confi')...2430machine # [ 87.449831] systemd[560]: Reloading...2431machine # [ 87.559320] systemd[560]: Reloading finished in 110 ms.2432machine # [ 87.576174] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2433machine # [ 87.585536] systemd[560]: Stopped Run user-specific NixOS activation.2434machine # [ 87.587925] systemd[560]: Stopping Run user-specific NixOS activation...2435machine # [ 87.590220] systemd[560]: Starting Run user-specific NixOS activation...2436machine # [ 87.624112] systemd[560]: Finished Run user-specific NixOS activation.2437machine # [ 87.627645] systemd[1]: Stopped target Reactivate sysinit units.2438machine # [ 87.632606] systemd[1]: Stopping Reactivate sysinit units...2439machine # [ 87.633528] systemd[1]: Reached target Reactivate sysinit units.2440machine # [ 87.634359] systemd[1]: test.service: Deactivated successfully.2441machine # [ 87.635201] systemd[1]: Stopped test.service.2442machine # [ 87.635832] systemd[1]: Stopping test.service...2443machine # [ 87.637808] systemd[1]: Starting test.service...2444machine # [ 87.661530] systemd[1]: Finished test.service.2445machine # [ 87.666571] systemd[1]: Reached target Remote File Systems.2446machine # [ 87.670894] systemd[1]: Starting linger-users.service...2447machine # [ 87.681518] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2448machine # [ 87.682934] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2449machine # [ 87.686781] systemd[1]: Reached target Local File Systems.2450machine # [ 87.687612] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2451machine # [ 87.698108] systemd[1]: Starting Create SUID/SGID Wrappers...2452machine # [ 87.699023] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2453machine # [ 87.707305] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672454machine # [ 87.713152] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2455machine # [ 87.714786] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2456machine # [ 87.719684] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2457machine # [ 87.759523] systemd[1]: linger-users.service: Deactivated successfully.2458machine # [ 87.763660] systemd[1]: Finished linger-users.service.2459machine # [ 87.901263] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2460machine # [ 87.904758] systemd[1]: Finished Create SUID/SGID Wrappers.2461machine # [ 88.164244] nixos[5739]: finished switching to system configuration /nix/store/j4jpm48alp5y4jscx38l89pxygps86m9-nixos-system-machine-test2462machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.94 seconds)2463machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&12464machine # [ 88.516481] nixos[5881]: switching to system configuration /nix/store/hnamh9hmahp3yl2dkcs6spq0kqqb9rfc-nixos-system-machine-test2465machine # [ 88.522093] systemd[1]: Stopped target Local File Systems.2466machine # [ 88.525825] systemd[1]: Stopped target Remote File Systems.2467machine # [ 88.828329] systemd[1]: Reload requested from client PID 5881 ('.switch-to-conf') (unit backdoor.service)...2468machine # [ 88.830289] systemd[1]: Reloading...2469machine # [ 89.217358] systemd[1]: Reloading finished in 385 ms.2470machine # [ 89.323699] systemd[560]: Reexecution requested from client PID 5950 ('switch-to-confi')...2471machine # [ 89.328266] systemd[560]: Reexecuting.2472machine # [ 89.387971] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2473machine # [ 89.513869] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2474machine # [ 89.521113] systemd[560]: Reload requested from client PID 5950 ('switch-to-confi')...2475machine # [ 89.522582] systemd[560]: Reloading...2476machine # [ 89.643722] systemd[560]: Reloading finished in 119 ms.2477machine # [ 89.662279] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2478machine # [ 89.672581] systemd[560]: Stopped Run user-specific NixOS activation.2479machine # [ 89.675351] systemd[560]: Stopping Run user-specific NixOS activation...2480machine # [ 89.678532] systemd[560]: Starting Run user-specific NixOS activation...2481machine # [ 89.719657] systemd[560]: Finished Run user-specific NixOS activation.2482machine # [ 89.725097] systemd[1]: Stopped target Reactivate sysinit units.2483machine # [ 89.726254] systemd[1]: Stopping Reactivate sysinit units...2484machine # [ 89.727069] systemd[1]: Reached target Reactivate sysinit units.2485machine # [ 89.730008] systemd[1]: test.service: Deactivated successfully.2486machine # [ 89.733628] systemd[1]: Stopped test.service.2487machine # [ 89.734499] systemd[1]: Stopping test.service...2488machine # [ 89.736756] systemd[1]: Starting test.service...2489machine # [ 89.762725] systemd[1]: Finished test.service.2490machine # [ 89.767291] systemd[1]: Reached target Local File Systems.2491machine # [ 89.770929] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2492machine # [ 89.773004] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2493machine # [ 89.774410] systemd[1]: Reached target Remote File Systems.2494machine # [ 89.781094] systemd[1]: Starting linger-users.service...2495machine # [ 89.786961] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2496machine # [ 89.796770] systemd[1]: Starting Create SUID/SGID Wrappers...2497machine # [ 89.797714] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2498machine # [ 89.798984] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672499machine # [ 89.807855] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2500machine # [ 89.809791] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2501machine # [ 89.811128] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2502machine # [ 89.865507] systemd[1]: linger-users.service: Deactivated successfully.2503machine # [ 89.870168] systemd[1]: Finished linger-users.service.2504machine # [ 90.018500] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2505machine # [ 90.022009] systemd[1]: Finished Create SUID/SGID Wrappers.2506machine # [ 90.278944] nixos[5881]: finished switching to system configuration /nix/store/hnamh9hmahp3yl2dkcs6spq0kqqb9rfc-nixos-system-machine-test2507machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 2.12 seconds)2508machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12509machine # [ 90.567871] nixos[6023]: switching to system configuration /nix/store/k9cd3abnik0zy4an4glnrpdnvngi11df-nixos-system-machine-test2510machine # [ 90.570867] systemd[1]: Stopped target Local File Systems.2511machine # [ 90.573319] systemd[1]: Stopped target Remote File Systems.2512machine # [ 90.859857] systemd[1]: Reload requested from client PID 6023 ('.switch-to-conf') (unit backdoor.service)...2513machine # [ 90.862092] systemd[1]: Reloading...2514machine # [ 91.192417] systemd[1]: Reloading finished in 328 ms.2515machine # [ 91.282437] systemd[560]: Reexecution requested from client PID 6092 ('switch-to-confi')...2516machine # [ 91.283829] systemd[560]: Reexecuting.2517machine # [ 91.343394] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2518machine # [ 91.465154] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2519machine # [ 91.472394] systemd[560]: Reload requested from client PID 6092 ('switch-to-confi')...2520machine # [ 91.474686] systemd[560]: Reloading...2521machine # [ 91.586938] systemd[560]: Reloading finished in 111 ms.2522machine # [ 91.600443] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2523machine # [ 91.612143] systemd[560]: Stopped Run user-specific NixOS activation.2524machine # [ 91.613345] systemd[560]: Stopping Run user-specific NixOS activation...2525machine # [ 91.616395] systemd[560]: Starting Run user-specific NixOS activation...2526machine # [ 91.654518] systemd[560]: Finished Run user-specific NixOS activation.2527machine # [ 91.659819] systemd[1]: Stopped target Reactivate sysinit units.2528machine # [ 91.665006] systemd[1]: Stopping Reactivate sysinit units...2529machine # [ 91.665972] systemd[1]: Reached target Reactivate sysinit units.2530machine # [ 91.666820] systemd[1]: test.service: Deactivated successfully.2531machine # [ 91.667668] systemd[1]: Stopped test.service.2532machine # [ 91.670459] systemd[1]: Stopping test.service...2533machine # [ 91.673852] systemd[1]: Starting test.service...2534machine # [ 91.706743] systemd[1]: Finished test.service.2535machine # [ 91.710683] systemd[1]: Reached target Local File Systems.2536machine # [ 91.715201] systemd[1]: Reached target Remote File Systems.2537machine # [ 91.721474] systemd[1]: Starting linger-users.service...2538machine # [ 91.730594] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2539machine # [ 91.736324] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2540machine # [ 91.739670] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2541machine # [ 91.749973] systemd[1]: Starting Create SUID/SGID Wrappers...2542machine # [ 91.751055] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2543machine # [ 91.760839] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672544machine # [ 91.763257] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2545machine # [ 91.771109] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2546machine # [ 91.775131] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2547machine # [ 91.824828] systemd[1]: linger-users.service: Deactivated successfully.2548machine # [ 91.826586] systemd[1]: Finished linger-users.service.2549machine # [ 91.969376] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2550machine # [ 91.972846] systemd[1]: Finished Create SUID/SGID Wrappers.2551machine # [ 92.231597] nixos[6023]: finished switching to system configuration /nix/store/k9cd3abnik0zy4an4glnrpdnvngi11df-nixos-system-machine-test2552machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.95 seconds)2553machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&12554machine # [ 92.536750] nixos[6165]: switching to system configuration /nix/store/afgwab9pjwns54g0z7r4v74nlnwd7pi5-nixos-system-machine-test2555machine # [ 92.539103] systemd[1]: Stopped target Remote File Systems.2556machine # [ 92.541533] systemd[1]: Stopped target Local File Systems.2557machine # [ 92.822662] systemd[1]: Reload requested from client PID 6165 ('.switch-to-conf') (unit backdoor.service)...2558machine # [ 92.824696] systemd[1]: Reloading...2559machine # [ 93.160387] systemd[1]: Reloading finished in 334 ms.2560machine # [ 93.264442] systemd[560]: Reexecution requested from client PID 6234 ('switch-to-confi')...2561machine # [ 93.267606] systemd[560]: Reexecuting.2562machine # [ 93.320146] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2563machine # [ 93.442361] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2564machine # [ 93.449104] systemd[560]: Reload requested from client PID 6234 ('switch-to-confi')...2565machine # [ 93.451575] systemd[560]: Reloading...2566machine # [ 93.568151] systemd[560]: Reloading finished in 115 ms.2567machine # [ 93.584266] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2568machine # [ 93.596135] systemd[560]: Stopped Run user-specific NixOS activation.2569machine # [ 93.597340] systemd[560]: Stopping Run user-specific NixOS activation...2570machine # [ 93.600972] systemd[560]: Starting Run user-specific NixOS activation...2571machine # [ 93.641737] systemd[560]: Finished Run user-specific NixOS activation.2572machine # [ 93.646517] systemd[1]: Stopped target Reactivate sysinit units.2573machine # [ 93.651624] systemd[1]: Stopping Reactivate sysinit units...2574machine # [ 93.653082] systemd[1]: Reached target Reactivate sysinit units.2575machine # [ 93.655769] systemd[1]: Reloading test.service...2576machine # [ 93.683739] systemd[1]: Reloaded test.service.2577machine # [ 93.688754] systemd[1]: Reached target Remote File Systems.2578machine # [ 93.694277] systemd[1]: Starting linger-users.service...2579machine # [ 93.705377] systemd[1]: Reached target Local File Systems.2580machine # [ 93.706409] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2581machine # [ 93.707670] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2582machine # [ 93.713923] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2583machine # [ 93.726546] systemd[1]: Starting Create SUID/SGID Wrappers...2584machine # [ 93.733337] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2585machine # [ 93.734810] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672586machine # [ 93.742687] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2587machine # [ 93.745612] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2588machine # [ 93.750857] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2589machine # [ 93.795646] systemd[1]: linger-users.service: Deactivated successfully.2590machine # [ 93.797934] systemd[1]: Finished linger-users.service.2591machine # [ 93.953990] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2592machine # [ 93.957450] systemd[1]: Finished Create SUID/SGID Wrappers.2593machine # [ 94.215454] nixos[6165]: finished switching to system configuration /nix/store/afgwab9pjwns54g0z7r4v74nlnwd7pi5-nixos-system-machine-test2594machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.99 seconds)2595machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&12596machine # [ 94.535337] nixos[6307]: switching to system configuration /nix/store/72xjkvcl642z3xqy0dhrfi2d6s5d3y0l-nixos-system-machine-test2597machine # [ 94.538313] systemd[1]: Stopped target Local File Systems.2598machine # [ 94.541003] systemd[1]: Stopped target Remote File Systems.2599machine # [ 94.846094] systemd[1]: Reload requested from client PID 6307 ('.switch-to-conf') (unit backdoor.service)...2600machine # [ 94.848000] systemd[1]: Reloading...2601machine # [ 95.196938] systemd[1]: Reloading finished in 347 ms.2602machine # [ 95.291801] systemd[560]: Reexecution requested from client PID 6376 ('switch-to-confi')...2603machine # [ 95.295857] systemd[560]: Reexecuting.2604machine # [ 95.343302] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2605machine # [ 95.461410] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2606machine # [ 95.467753] systemd[560]: Reload requested from client PID 6376 ('switch-to-confi')...2607machine # [ 95.471487] systemd[560]: Reloading...2608machine # [ 95.585908] systemd[560]: Reloading finished in 114 ms.2609machine # [ 95.596205] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2610machine # [ 95.606606] systemd[560]: Stopped Run user-specific NixOS activation.2611machine # [ 95.609225] systemd[560]: Stopping Run user-specific NixOS activation...2612machine # [ 95.611454] systemd[560]: Starting Run user-specific NixOS activation...2613machine # [ 95.645272] systemd[560]: Finished Run user-specific NixOS activation.2614machine # [ 95.649302] systemd[1]: Stopped target Reactivate sysinit units.2615machine # [ 95.653920] systemd[1]: Stopping Reactivate sysinit units...2616machine # [ 95.654810] systemd[1]: Reached target Reactivate sysinit units.2617machine # [ 95.656752] systemd[1]: Reloading test.service...2618machine # [ 95.683207] systemd[1]: Reloaded test.service.2619machine # [ 95.686813] systemd[1]: Reached target Remote File Systems.2620machine # [ 95.692241] systemd[1]: Starting linger-users.service...2621machine # [ 95.695232] systemd[1]: Reached target Local File Systems.2622machine # [ 95.700597] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2623machine # [ 95.701999] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2624machine # [ 95.711718] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2625machine # [ 95.720283] systemd[1]: Starting Create SUID/SGID Wrappers...2626machine # [ 95.721193] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2627machine # [ 95.722461] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672628machine # [ 95.731606] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2629machine # [ 95.736943] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2630machine # [ 95.743340] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2631machine # [ 95.785348] systemd[1]: linger-users.service: Deactivated successfully.2632machine # [ 95.788350] systemd[1]: Finished linger-users.service.2633machine # [ 95.926898] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2634machine # [ 95.929921] systemd[1]: Finished Create SUID/SGID Wrappers.2635machine # [ 96.189395] nixos[6307]: finished switching to system configuration /nix/store/72xjkvcl642z3xqy0dhrfi2d6s5d3y0l-nixos-system-machine-test2636machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.97 seconds)2637machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&12638machine # [ 96.525033] nixos[6449]: switching to system configuration /nix/store/17crjqnhlmhj0a0y3gl9y68rzgyk0z7y-nixos-system-machine-test2639machine # [ 96.527851] systemd[1]: Stopped target Remote File Systems.2640machine # [ 96.530747] systemd[1]: Stopped target Local File Systems.2641machine # [ 96.873092] systemd[1]: Reload requested from client PID 6449 ('.switch-to-conf') (unit backdoor.service)...2642machine # [ 96.875066] systemd[1]: Reloading...2643machine # [ 97.252893] systemd[1]: Reloading finished in 376 ms.2644machine # [ 97.346158] systemd[560]: Reexecution requested from client PID 6518 ('switch-to-confi')...2645machine # [ 97.347541] systemd[560]: Reexecuting.2646machine # [ 97.407730] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2647machine # [ 97.529863] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2648machine # [ 97.537396] systemd[560]: Reload requested from client PID 6518 ('switch-to-confi')...2649machine # [ 97.539855] systemd[560]: Reloading...2650machine # [ 97.655424] systemd[560]: Reloading finished in 114 ms.2651machine # [ 97.672165] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2652machine # [ 97.682391] systemd[560]: Stopped Run user-specific NixOS activation.2653machine # [ 97.684891] systemd[560]: Stopping Run user-specific NixOS activation...2654machine # [ 97.687121] systemd[560]: Starting Run user-specific NixOS activation...2655machine # [ 97.721229] systemd[560]: Finished Run user-specific NixOS activation.2656machine # [ 97.724983] systemd[1]: Stopped target Reactivate sysinit units.2657machine # [ 97.727012] systemd[1]: Stopping Reactivate sysinit units...2658machine # [ 97.727868] systemd[1]: Reached target Reactivate sysinit units.2659machine # [ 97.732465] systemd[1]: test.service: Deactivated successfully.2660machine # [ 97.733384] systemd[1]: Stopped test.service.2661machine # [ 97.734032] systemd[1]: Stopping test.service...2662machine # [ 97.740337] systemd[1]: Starting test.service...2663machine # [ 97.762680] systemd[1]: Finished test.service.2664machine # [ 97.764870] systemd[1]: Reached target Local File Systems.2665machine # [ 97.768336] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2666machine # [ 97.773896] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2667machine # [ 97.775241] systemd[1]: Reached target Remote File Systems.2668machine # [ 97.777308] systemd[1]: Starting linger-users.service...2669machine # [ 97.789427] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2670machine # [ 97.797358] systemd[1]: Starting Create SUID/SGID Wrappers...2671machine # [ 97.798298] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2672machine # [ 97.799536] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672673machine # [ 97.809398] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2674machine # [ 97.813404] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2675machine # [ 97.815072] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2676machine # [ 97.862644] systemd[1]: linger-users.service: Deactivated successfully.2677machine # [ 97.867350] systemd[1]: Finished linger-users.service.2678machine # [ 98.011126] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2679machine # [ 98.014273] systemd[1]: Finished Create SUID/SGID Wrappers.2680machine # [ 98.270389] nixos[6449]: finished switching to system configuration /nix/store/17crjqnhlmhj0a0y3gl9y68rzgyk0z7y-nixos-system-machine-test2681machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 2.07 seconds)2682machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&12683machine # [ 98.505231] nixos[6591]: switching to system configuration /nix/store/fg8ml4cl2d8vmnyd4i9srq240dapwxs4-nixos-system-machine-test2684machine # [ 98.507790] systemd[1]: Stopped target Remote File Systems.2685machine # [ 98.510552] systemd[1]: Stopped target Local File Systems.2686machine # [ 98.793343] systemd[1]: Reload requested from client PID 6591 ('.switch-to-conf') (unit backdoor.service)...2687machine # [ 98.795312] systemd[1]: Reloading...2688machine # [ 99.136137] systemd[1]: Reloading finished in 339 ms.2689machine # [ 99.238994] systemd[560]: Reexecution requested from client PID 6660 ('switch-to-confi')...2690machine # [ 99.242801] systemd[560]: Reexecuting.2691machine # [ 99.297040] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2692machine # [ 99.428284] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2693machine # [ 99.435414] systemd[560]: Reload requested from client PID 6660 ('switch-to-confi')...2694machine # [ 99.438664] systemd[560]: Reloading...2695machine # [ 99.550500] systemd[560]: Reloading finished in 113 ms.2696machine # [ 99.564169] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2697machine # [ 99.574203] systemd[560]: Stopped Run user-specific NixOS activation.2698machine # [ 99.576607] systemd[560]: Stopping Run user-specific NixOS activation...2699machine # [ 99.578828] systemd[560]: Starting Run user-specific NixOS activation...2700machine # [ 99.612947] systemd[560]: Finished Run user-specific NixOS activation.2701machine # [ 99.616541] systemd[1]: Stopped target Reactivate sysinit units.2702machine # [ 99.618618] systemd[1]: Stopping Reactivate sysinit units...2703machine # [ 99.619496] systemd[1]: Reached target Reactivate sysinit units.2704machine # [ 99.624986] systemd[1]: Reached target Remote File Systems.2705machine # [ 99.628971] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2706machine # [ 99.630317] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2707machine # [ 99.635313] systemd[1]: Reached target Local File Systems.2708machine # [ 99.638764] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2709machine # [ 99.642398] systemd[1]: Starting Create SUID/SGID Wrappers...2710machine # [ 99.643291] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2711machine # [ 99.652250] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672712machine # [ 99.654496] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2713machine # [ 99.657460] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2714machine # [ 99.658757] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2715machine # [ 99.819504] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2716machine # [ 99.822970] systemd[1]: Finished Create SUID/SGID Wrappers.2717machine # [ 99.826703] systemd[1]: Starting linger-users.service...2718machine # [ 99.869755] systemd[1]: linger-users.service: Deactivated successfully.2719machine # [ 99.872798] systemd[1]: Finished linger-users.service.2720machine # [ 100.130694] nixos[6591]: finished switching to system configuration /nix/store/fg8ml4cl2d8vmnyd4i9srq240dapwxs4-nixos-system-machine-test2721machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.86 seconds)2722(finished: subtest: unit file parser, in 25.69 seconds)2723subtest: restart and reload by activation script2724machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&12725machine # [ 100.404133] nixos[6731]: switching to system configuration /nix/store/8k97xh1d3m4888rqp4hi71k6cr6j744p-nixos-system-machine-test2726machine # [ 100.407247] systemd[1]: Stopped target Remote File Systems.2727machine # [ 100.409353] systemd[1]: Stopped target Local File Systems.2728machine # [ 100.669928] systemd[1]: Reload requested from client PID 6731 ('.switch-to-conf') (unit backdoor.service)...2729machine # [ 100.671830] systemd[1]: Reloading...2730machine # [ 100.994976] systemd[1]: Reloading finished in 321 ms.2731machine # [ 101.087107] systemd[560]: Reexecution requested from client PID 6800 ('switch-to-confi')...2732machine # [ 101.089783] systemd[560]: Reexecuting.2733machine # [ 101.151570] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2734machine # [ 101.273108] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2735machine # [ 101.279526] systemd[560]: Reload requested from client PID 6800 ('switch-to-confi')...2736machine # [ 101.283169] systemd[560]: Reloading...2737machine # [ 101.393151] systemd[560]: Reloading finished in 110 ms.2738machine # [ 101.408207] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2739machine # [ 101.417702] systemd[560]: Stopped Run user-specific NixOS activation.2740machine # [ 101.420083] systemd[560]: Stopping Run user-specific NixOS activation...2741machine # [ 101.422507] systemd[560]: Starting Run user-specific NixOS activation...2742machine # [ 101.460003] systemd[560]: Finished Run user-specific NixOS activation.2743machine # [ 101.465872] systemd[1]: Stopped target Reactivate sysinit units.2744machine # [ 101.470152] systemd[1]: Stopping Reactivate sysinit units...2745machine # [ 101.471205] systemd[1]: Reached target Reactivate sysinit units.2746machine # [ 101.473910] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2747machine # [ 101.475287] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2748machine # [ 101.480409] systemd[1]: Reached target Remote File Systems.2749machine # [ 101.483970] systemd[1]: Starting linger-users.service...2750machine # [ 101.492200] systemd[1]: Reached target Local File Systems.2751machine # [ 101.496945] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2752machine # [ 101.504355] systemd[1]: Starting Create SUID/SGID Wrappers...2753machine # [ 101.505376] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2754machine # [ 101.506629] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672755machine # [ 101.519623] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2756machine # [ 101.524413] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2757machine # [ 101.531763] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2758machine # [ 101.579700] systemd[1]: linger-users.service: Deactivated successfully.2759machine # [ 101.584628] systemd[1]: Finished linger-users.service.2760machine # [ 101.720885] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2761machine # [ 101.723918] systemd[1]: Finished Create SUID/SGID Wrappers.2762machine # [ 101.982619] nixos[6731]: finished switching to system configuration /nix/store/8k97xh1d3m4888rqp4hi71k6cr6j744p-nixos-system-machine-test2763machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.85 seconds)2764machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12765machine # [ 102.300385] nixos[6871]: switching to system configuration /nix/store/h46zkmlpml5y4ylq0r11w9si0gibfya7-nixos-system-machine-test2766machine # [ 102.303610] systemd[1]: Stopped target Local File Systems.2767machine # [ 102.305705] systemd[1]: Stopped target Remote File Systems.2768machine # [ 102.307509] systemd[1]: test.service: Deactivated successfully.2769machine # [ 102.309298] systemd[1]: Stopped test.service.2770machine # [ 102.600813] systemd[1]: Reload requested from client PID 6871 ('.switch-to-conf') (unit backdoor.service)...2771machine # [ 102.602910] systemd[1]: Reloading...2772machine # [ 102.953383] systemd[1]: Reloading finished in 348 ms.2773machine # [ 103.043231] systemd[560]: Reexecution requested from client PID 6942 ('switch-to-confi')...2774machine # [ 103.046149] systemd[560]: Reexecuting.2775machine # [ 103.108122] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2776machine # [ 103.230193] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2777machine # [ 103.236559] systemd[560]: Reload requested from client PID 6942 ('switch-to-confi')...2778machine # [ 103.238963] systemd[560]: Reloading...2779machine # [ 103.354814] systemd[560]: Reloading finished in 114 ms.2780machine # [ 103.368181] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2781machine # [ 103.378408] systemd[560]: Stopped Run user-specific NixOS activation.2782machine # [ 103.379513] systemd[560]: Stopping Run user-specific NixOS activation...2783machine # [ 103.382110] systemd[560]: Starting Run user-specific NixOS activation...2784machine # [ 103.412082] systemd[560]: Finished Run user-specific NixOS activation.2785machine # [ 103.416754] systemd[1]: Stopped target Reactivate sysinit units.2786machine # [ 103.417778] systemd[1]: Stopping Reactivate sysinit units...2787machine # [ 103.418608] systemd[1]: Reached target Reactivate sysinit units.2788machine # [ 103.425027] systemd[1]: Created slice Slice /system/templated-reload-triggers.2789machine # [ 103.427650] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart.2790machine # [ 103.433697] systemd[1]: Reached target Remote File Systems.2791machine # [ 103.434598] systemd[1]: Starting linger-users.service...2792machine # [ 103.437972] systemd[1]: Starting reload-triggers-and-restart.service...2793machine # [ 103.449277] systemd[1]: Starting reload-triggers.service...2794machine # [ 103.450237] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2795machine # [ 103.468511] systemd[1]: Starting templated-reload-triggers@instance.service...2796machine # [ 103.476079] systemd[1]: Starting simple-service.service...2797machine # [ 103.487724] systemd[1]: Created slice Slice /system/templated-simple-restart-service.2798machine # [ 103.504906] systemd[1]: Starting templated-simple-restart-service@instance.service...2799machine # [ 103.524124] systemd[1]: Created slice Slice /system/templated-no-restart-service.2800machine # [ 103.525388] systemd[1]: Starting templated-no-restart-service@instance.service...2801machine # [ 103.526486] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2802machine # [ 103.527749] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2803machine # [ 103.586899] systemd[1]: Starting simple-reload-service.service...2804machine # [ 103.587916] systemd[1]: Reached target Local File Systems.2805machine # [ 103.623555] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2806machine # [ 103.648426] systemd[1]: Starting Create SUID/SGID Wrappers...2807machine # [ 103.662622] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2808machine # [ 103.684461] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672809machine # [ 103.703888] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2810machine # [ 103.713943] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2811machine # [ 103.715310] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2812machine # [ 103.727345] systemd[1]: Created slice Slice /system/templated-simple-service.2813machine # [ 103.731516] systemd[1]: Finished reload-triggers-and-restart.service.2814machine # [ 103.735725] systemd[1]: Finished templated-reload-triggers@instance.service.2815machine # [ 103.737480] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2816machine # [ 103.738663] systemd[1]: Finished reload-triggers.service.2817machine # [ 103.739443] systemd[1]: Created slice Slice /system/templated-simple-reload-service.2818machine # [ 103.745281] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as.2819machine # [ 103.746851] systemd[1]: Finished simple-service.service.2820machine # [ 103.747664] systemd[1]: Finished templated-simple-restart-service@instance.service.2821machine # [ 103.754110] systemd[1]: Finished templated-no-restart-service@instance.service.2822machine # [ 103.755278] systemd[1]: Finished simple-reload-service.service.2823machine # [ 103.758500] systemd[1]: linger-users.service: Deactivated successfully.2824machine # [ 103.760222] systemd[1]: Finished linger-users.service.2825machine # [ 103.898232] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2826machine # [ 103.903065] systemd[1]: Finished Create SUID/SGID Wrappers.2827machine # [ 103.906557] systemd[1]: Starting no-restart-service.service...2828machine # [ 103.910410] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2829machine # [ 103.918655] systemd[1]: Starting simple-restart-service.service...2830machine # [ 103.926923] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2831machine # [ 103.947474] systemd[1]: Starting templated-simple-reload-service@instance.service...2832machine # [ 103.948990] systemd[1]: Starting templated-simple-service@instance.service...2833machine # [ 104.021770] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2834machine # [ 104.027578] systemd[1]: Finished simple-restart-service.service.2835machine # [ 104.029212] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2836machine # [ 104.030448] systemd[1]: Finished templated-simple-service@instance.service.2837machine # [ 104.031440] systemd[1]: Finished no-restart-service.service.2838machine # [ 104.035419] systemd[1]: Finished templated-simple-reload-service@instance.service.2839machine # [ 104.295604] nixos[6871]: finished switching to system configuration /nix/store/h46zkmlpml5y4ylq0r11w9si0gibfya7-nixos-system-machine-test2840machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.31 seconds)2841machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12842machine # [ 104.626761] nixos[7041]: switching to system configuration /nix/store/h46zkmlpml5y4ylq0r11w9si0gibfya7-nixos-system-machine-test2843machine # [ 104.629605] systemd[1]: Stopped target Remote File Systems.2844machine # [ 104.631897] systemd[1]: Stopped target Local File Systems.2845machine # [ 104.913853] systemd[1]: Reload requested from client PID 7041 ('.switch-to-conf') (unit backdoor.service)...2846machine # [ 104.915825] systemd[1]: Reloading...2847machine # [ 105.271891] systemd[1]: Reloading finished in 354 ms.2848machine # [ 105.368522] systemd[560]: Reexecution requested from client PID 7112 ('switch-to-confi')...2849machine # [ 105.372294] systemd[560]: Reexecuting.2850machine # [ 105.431184] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2851machine # [ 105.548874] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2852machine # [ 105.555879] systemd[560]: Reload requested from client PID 7112 ('switch-to-confi')...2853machine # [ 105.559689] systemd[560]: Reloading...2854machine # [ 105.676474] systemd[560]: Reloading finished in 118 ms.2855machine # [ 105.692175] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2856machine # [ 105.701240] systemd[560]: Stopped Run user-specific NixOS activation.2857machine # [ 105.703626] systemd[560]: Stopping Run user-specific NixOS activation...2858machine # [ 105.705937] systemd[560]: Starting Run user-specific NixOS activation...2859machine # [ 105.741414] systemd[560]: Finished Run user-specific NixOS activation.2860machine # [ 105.746028] systemd[1]: Stopped target Reactivate sysinit units.2861machine # [ 105.749129] systemd[1]: Stopping Reactivate sysinit units...2862machine # [ 105.750025] systemd[1]: Reached target Reactivate sysinit units.2863machine # [ 105.756446] systemd[1]: Reloading reload-triggers-and-restart.service...2864machine # [ 105.768400] systemd[1]: Reloading reload-triggers.service...2865machine # [ 105.775630] systemd[1]: Reloading simple-reload-service.service...2866machine # [ 105.785143] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service...2867machine # [ 105.796531] systemd[1]: Reloading templated-reload-triggers@instance.service...2868machine # [ 105.805652] systemd[1]: Reloading templated-simple-reload-service@instance.service...2869machine # [ 105.863559] systemd[1]: Reloaded reload-triggers-and-restart.service.2870machine # [ 105.870607] systemd[1]: Reloaded reload-triggers.service.2871machine # [ 105.871508] systemd[1]: Reloaded simple-reload-service.service.2872machine # [ 105.886315] systemd[1]: Reloaded templated-reload-triggers@instance.service.2873machine # [ 105.889428] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service.2874machine # [ 105.895267] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2875machine # [ 105.899220] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2876machine # [ 105.902867] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2877machine # [ 105.903936] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2878machine # [ 105.910340] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2879machine # [ 105.911476] systemd[1]: simple-restart-service.service: Deactivated successfully.2880machine # [ 105.912882] systemd[1]: Stopped simple-restart-service.service.2881machine # [ 105.919816] systemd[1]: Stopping simple-restart-service.service...2882machine # [ 105.934407] systemd[1]: Starting simple-restart-service.service...2883machine # [ 105.935395] systemd[1]: simple-service.service: Deactivated successfully.2884machine # [ 105.953804] systemd[1]: Stopped simple-service.service.2885machine # [ 105.954664] systemd[1]: Stopping simple-service.service...2886machine # [ 105.955435] systemd[1]: Starting simple-service.service...2887machine # [ 105.964107] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2888machine # [ 105.965658] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2889machine # [ 105.966775] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2890machine # [ 105.967967] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2891machine # [ 105.995028] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2892machine # [ 106.004319] systemd[1]: Stopped templated-simple-restart-service@instance.service.2893machine # [ 106.016216] systemd[1]: Stopping templated-simple-restart-service@instance.service...2894machine # [ 106.030489] systemd[1]: Starting templated-simple-restart-service@instance.service...2895machine # [ 106.031965] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2896machine # [ 106.049726] systemd[1]: Stopped templated-simple-service@instance.service.2897machine # [ 106.050968] systemd[1]: Stopping templated-simple-service@instance.service...2898machine # [ 106.054164] systemd[1]: Starting templated-simple-service@instance.service...2899machine # [ 106.055319] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2900machine # [ 106.061010] systemd[1]: Finished simple-restart-service.service.2901machine # [ 106.061964] systemd[1]: Finished templated-simple-restart-service@instance.service.2902machine # [ 106.062956] systemd[1]: Finished simple-service.service.2903machine # [ 106.063704] systemd[1]: Finished templated-simple-service@instance.service.2904machine # [ 106.065653] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2905machine # [ 106.066892] systemd[1]: Reached target Local File Systems.2906machine # [ 106.067682] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2907machine # [ 106.081924] systemd[1]: Starting Create SUID/SGID Wrappers...2908machine # [ 106.083894] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2909machine # [ 106.089695] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672910machine # [ 106.091993] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2911machine # [ 106.093625] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2912machine # [ 106.094867] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2913machine # [ 106.096499] systemd[1]: Reached target Remote File Systems.2914machine # [ 106.097368] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2915machine # [ 106.098994] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2916machine # [ 106.264568] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2917machine # [ 106.268569] systemd[1]: Finished Create SUID/SGID Wrappers.2918machine # [ 106.271947] systemd[1]: Starting linger-users.service...2919machine # [ 106.321463] systemd[1]: linger-users.service: Deactivated successfully.2920machine # [ 106.324338] systemd[1]: Finished linger-users.service.2921machine # [ 106.586407] nixos[7041]: finished switching to system configuration /nix/store/h46zkmlpml5y4ylq0r11w9si0gibfya7-nixos-system-machine-test2922machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.29 seconds)2923machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&12924machine # [ 106.936534] nixos[7207]: switching to system configuration /nix/store/xc4kgfbawhn1qwrbaxwmsc3s09c5h3bk-nixos-system-machine-test2925machine # [ 106.939417] systemd[1]: Stopped target Local File Systems.2926machine # [ 106.942320] systemd[1]: Stopped target Remote File Systems.2927machine # [ 107.259529] systemd[1]: Reload requested from client PID 7207 ('.switch-to-conf') (unit backdoor.service)...2928machine # [ 107.261643] systemd[1]: Reloading...2929machine # [ 107.627319] systemd[1]: Reloading finished in 364 ms.2930machine # [ 107.719880] systemd[560]: Reexecution requested from client PID 7278 ('switch-to-confi')...2931machine # [ 107.724634] systemd[560]: Reexecuting.2932machine # [ 107.783536] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2933machine # [ 107.907915] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2934machine # [ 107.914661] systemd[560]: Reload requested from client PID 7278 ('switch-to-confi')...2935machine # [ 107.917129] systemd[560]: Reloading...2936machine # [ 108.028666] systemd[560]: Reloading finished in 110 ms.2937machine # [ 108.044167] systemd[560]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2938machine # [ 108.054327] systemd[560]: Stopped Run user-specific NixOS activation.2939machine # [ 108.056799] systemd[560]: Stopping Run user-specific NixOS activation...2940machine # [ 108.059043] systemd[560]: Starting Run user-specific NixOS activation...2941machine # [ 108.092700] systemd[560]: Finished Run user-specific NixOS activation.2942machine # [ 108.096641] systemd[1]: Stopped target Reactivate sysinit units.2943machine # [ 108.101355] systemd[1]: Stopping Reactivate sysinit units...2944machine # [ 108.102257] systemd[1]: Reached target Reactivate sysinit units.2945machine # [ 108.104715] systemd[1]: Reloading reload-triggers.service...2946machine # [ 108.109754] systemd[1]: Reloading simple-reload-service.service...2947machine # [ 108.122345] systemd[1]: Reloading templated-reload-triggers@instance.service...2948machine # [ 108.135853] systemd[1]: Reloading templated-simple-reload-service@instance.service...2949machine # [ 108.180617] systemd[1]: Reloaded simple-reload-service.service.2950machine # [ 108.183629] systemd[1]: Reloaded templated-reload-triggers@instance.service.2951machine # [ 108.186073] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2952machine # [ 108.190962] systemd[1]: Reloaded reload-triggers.service.2953machine # [ 108.196252] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2954machine # [ 108.197484] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2955machine # [ 108.198449] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2956machine # [ 108.203543] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2957machine # [ 108.206309] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully.2958machine # [ 108.207439] systemd[1]: Stopped reload-triggers-and-restart.service.2959machine # [ 108.215724] systemd[1]: Stopping reload-triggers-and-restart.service...2960machine # [ 108.224917] systemd[1]: Starting reload-triggers-and-restart.service...2961machine # [ 108.225921] systemd[1]: simple-restart-service.service: Deactivated successfully.2962machine # [ 108.226903] systemd[1]: Stopped simple-restart-service.service.2963machine # [ 108.227738] systemd[1]: Stopping simple-restart-service.service...2964machine # [ 108.248319] systemd[1]: Starting simple-restart-service.service...2965machine # [ 108.249301] systemd[1]: simple-service.service: Deactivated successfully.2966machine # [ 108.250193] systemd[1]: Stopped simple-service.service.2967machine # [ 108.250912] systemd[1]: Stopping simple-service.service...2968machine # [ 108.251666] systemd[1]: Starting simple-service.service...2969machine # [ 108.291631] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2970machine # [ 108.302455] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2971machine # [ 108.315570] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2972machine # [ 108.339305] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2973machine # [ 108.350984] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully.2974machine # [ 108.359767] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service.2975machine # [ 108.369781] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service...2976machine # [ 108.371143] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2977machine # [ 108.385408] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2978machine # [ 108.392496] systemd[1]: Stopped templated-simple-restart-service@instance.service.2979machine # [ 108.402620] systemd[1]: Stopping templated-simple-restart-service@instance.service...2980machine # [ 108.403748] systemd[1]: Starting templated-simple-restart-service@instance.service...2981machine # [ 108.413216] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2982machine # [ 108.414442] systemd[1]: Stopped templated-simple-service@instance.service.2983machine # [ 108.415398] systemd[1]: Stopping templated-simple-service@instance.service...2984machine # [ 108.423260] systemd[1]: Starting templated-simple-service@instance.service...2985machine # [ 108.425008] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2986machine # [ 108.426011] systemd[1]: Finished simple-restart-service.service.2987machine # [ 108.426828] systemd[1]: Finished simple-service.service.2988machine # [ 108.427578] systemd[1]: Finished reload-triggers-and-restart.service.2989machine # [ 108.428570] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2990machine # [ 108.429745] systemd[1]: Finished templated-simple-service@instance.service.2991machine # [ 108.430674] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2992machine # [ 108.431799] systemd[1]: Finished templated-simple-restart-service@instance.service.2993machine # [ 108.433692] systemd[1]: Reached target Local File Systems.2994machine # [ 108.435211] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2995machine # [ 108.438867] systemd[1]: Starting Create SUID/SGID Wrappers...2996machine # [ 108.440330] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2997machine # [ 108.442054] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672998machine # [ 108.444714] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2999machine # [ 108.449055] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3000machine # [ 108.450335] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3001machine # [ 108.451503] systemd[1]: Reached target Remote File Systems.3002machine # [ 108.455013] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os3003machine # [ 108.456629] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki3004machine # [ 108.606993] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.3005machine # [ 108.612002] systemd[1]: Finished Create SUID/SGID Wrappers.3006machine # [ 108.614240] systemd[1]: Starting linger-users.service...3007machine # [ 108.657982] systemd[1]: linger-users.service: Deactivated successfully.3008machine # [ 108.661148] systemd[1]: Finished linger-users.service.3009machine # [ 108.922621] nixos[7207]: finished switching to system configuration /nix/store/xc4kgfbawhn1qwrbaxwmsc3s09c5h3bk-nixos-system-machine-test3010machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.34 seconds)3011machine: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&13012machine: (finished: must succeed: /nix/store/rqi0af139nm66xrkr3q352an2jgn7ifx-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.41 seconds)3013(finished: subtest: restart and reload by activation script, in 9.20 seconds)3014(finished: run the VM test script, in 110.21 seconds)3015test script finished in 110.26s3016cleanup3017kill QemuMachine (pid 45)3018machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14)3019machine # [2026-09-16T02:59:22Z INFO virtiofsd] Client disconnected, shutting down3020machine # [2026-09-16T02:59:22Z INFO virtiofsd] Client disconnected, shutting down3021machine # [2026-09-16T02:59:22Z INFO virtiofsd] Client disconnected, shutting down3022(finished: cleanup, in 0.20 seconds)3023additionally exposed symbols:3024 machine, other,3025 vlan1,3026 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh