vm-test-run-switch-test-services
checks.aarch64-linux.switchTest
· build #23
· 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.6ZquObYRCR', 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: caa6b769-555d-4b32-ad4a-9d1c25c4b85917machine # Superblock backups stored on blocks:18machine # 32768, 98304, 163840, 22937619machine # 20machine # Allocating group tables: 0/8 done21machine # Writing inode tables: 0/8 done22machine # Creating journal (8192 blocks): done23machine # Writing superblocks and filesystem accounting information: 0/8 done24machine # 25machine # Virtualisation disk image created.26machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]27machine # [ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Sep 2 12:31:51 UTC 202628machine # [ 0.000000] KASLR enabled29machine # [ 0.000000] random: crng init done30machine # [ 0.000000] Machine model: linux,dummy-virt31machine # [ 0.000000] efi: UEFI not found.32machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT33machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]34machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f]35machine # [ 0.000000] Zone ranges:36machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]37machine # [ 0.000000] DMA32 empty38machine # [ 0.000000] Normal empty39machine # [ 0.000000] Device empty40machine # [ 0.000000] Movable zone start for each node41machine # [ 0.000000] Early memory node ranges42machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]43machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]44machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc0000045machine # [ 0.000000] psci: probing for conduit method from DT.46machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.47machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs48machine # [ 0.000000] psci: Trusted OS migration not required49machine # [ 0.000000] psci: SMC Calling Convention v1.150machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)51machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u31129652machine # [ 0.000000] Detected PIPT I-cache on CPU053machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)54machine # [ 0.000000] CPU features: detected: GICv3 CPU interface55machine # [ 0.000000] CPU features: detected: Spectre-v456machine # [ 0.000000] CPU features: detected: Spectre-BHB57machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_3858machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_2359machine # [ 0.000000] alternatives: applying boot alternatives60machine # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/init regInfo=/nix/store/vqa32604sbyfh1sa5ngr6wy1nic7123y-closure-info/registration console=ttyAMA0,115200n8 console=tty061machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/vqa32604sbyfh1sa5ngr6wy1nic7123y-closure-info/registration", will be passed to user space.62machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes63machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)64machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)65machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB66machine # [ 0.000000] software IO TLB: area num 1.67machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)68machine # [ 0.000000] Fallback order for Node 0: 069machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 26214470machine # [ 0.000000] Policy zone: DMA71machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off72machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=173machine # [ 0.000000] allocated 2097152 bytes of page_ext74machine # [ 0.000000] ftrace: allocating 74886 entries in 294 pages75machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups76machine # [ 0.000000] rcu: Hierarchical RCU implementation.77machine # [ 0.000000] rcu: RCU event tracing is enabled.78machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.79machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.80machine # [ 0.000000] Rude variant of Tasks RCU enabled.81machine # [ 0.000000] Tracing variant of Tasks RCU enabled.82machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.83machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=184machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.85machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.86machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.87machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 088machine # [ 0.000000] GICv3: 256 SPIs implemented89machine # [ 0.000000] GICv3: 0 Extended SPIs implemented90machine # [ 0.000000] Root IRQ handler: gic_handle_irq91machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI92machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=093machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a000094machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]95machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)96machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)97machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d1000098machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d2000099machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.100machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns101machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).102machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns103machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns104machine # [ 0.000030] arm-pv: using stolen time PV105machine # [ 0.000390] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)106machine # [ 0.000562] Console: colour dummy device 80x25107machine # [ 0.000570] printk: legacy console [tty0] enabled108machine # [ 0.000767] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)109machine # [ 0.000775] pid_max: default: 32768 minimum: 301110machine # [ 0.000854] LSM: initializing lsm=capability,landlock,yama,bpf,ima111machine # [ 0.001220] landlock: Up and running.112machine # [ 0.001223] Yama: becoming mindful.113machine # [ 0.001700] LSM support for eBPF active114machine # [ 0.001824] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)115machine # [ 0.001843] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)116machine # [ 0.003020] cacheinfo: Unable to detect cache hierarchy for CPU 0117machine # [ 0.003719] rcu: Hierarchical SRCU implementation.118machine # [ 0.003723] rcu: Max phase no-delay instances is 1000.119machine # [ 0.004953] fsl-mc MSI: its@8080000 domain created120machine # [ 0.005047] EFI services will not be available.121machine # [ 0.005122] smp: Bringing up secondary CPUs ...122machine # [ 0.005130] smp: Brought up 1 node, 1 CPU123machine # [ 0.005133] SMP: Total of 1 processors activated.124machine # [ 0.005136] CPU: All CPU(s) started at EL1125machine # [ 0.005151] CPU features: detected: Branch Target Identification126machine # [ 0.005156] CPU features: detected: ARMv8.4 Translation Table Level127machine # [ 0.005159] CPU features: detected: Instruction cache invalidation not required for I/D coherence128machine # [ 0.005162] CPU features: detected: Data cache clean to the PoU not required for I/D coherence129machine # [ 0.005166] CPU features: detected: Common not Private translations130machine # [ 0.005169] CPU features: detected: CRC32 instructions131machine # [ 0.005172] CPU features: detected: Data cache clean to Point of Deep Persistence132machine # [ 0.005176] CPU features: detected: Data cache clean to Point of Persistence133machine # [ 0.005179] CPU features: detected: Data independent timing control (DIT)134machine # [ 0.005182] CPU features: detected: E0PD135machine # [ 0.005185] CPU features: detected: Enhanced Counter Virtualization136machine # [ 0.005188] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)137machine # [ 0.005191] CPU features: detected: Enhanced Virtualization Traps138machine # [ 0.005195] CPU features: detected: Fine Grained Traps139machine # [ 0.005199] CPU features: detected: Generic authentication (architected QARMA5 algorithm)140machine # [ 0.005204] CPU features: detected: RCpc load-acquire (LDAPR)141machine # [ 0.005208] CPU features: detected: LSE atomic instructions142machine # [ 0.005211] CPU features: detected: Privileged Access Never143machine # [ 0.005213] CPU features: detected: PMUv3144machine # [ 0.005216] CPU features: detected: RAS Extension Support145machine # [ 0.005219] CPU features: detected: RASv1p1 Extension Support146machine # [ 0.005221] CPU features: detected: Random Number Generator147machine # [ 0.005224] CPU features: detected: Speculation barrier (SB)148machine # [ 0.005227] CPU features: detected: Stage-2 Force Write-Back149machine # [ 0.005230] CPU features: detected: TLB range maintenance instructions150machine # [ 0.005235] CPU features: detected: Speculative Store Bypassing Safe (SSBS)151machine # [ 0.005291] alternatives: applying system-wide alternatives152machine # [ 0.008283] CPU features: detected: BBM Level 2 without TLB conflict abort153machine # [ 0.008443] Memory: 894300K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 112964K reserved, 32768K cma-reserved)154machine # [ 0.008798] devtmpfs: initialized155machine # [ 0.010547] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)156machine # [ 0.010570] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).157machine # [ 0.010757] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL158machine # [ 0.010762] 0 pages in range for non-PLT usage159machine # [ 0.010763] 508288 pages in range for PLT usage160machine # [ 0.010879] pinctrl core: initialized pinctrl subsystem161machine # [ 0.011622] DMI not present or invalid.162machine # [ 0.014814] NET: Registered PF_NETLINK/PF_ROUTE protocol family163machine # [ 0.017109] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations164machine # [ 0.017275] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations165machine # [ 0.017446] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations166machine # [ 0.017470] audit: initializing netlink subsys (disabled)167machine # [ 0.018034] thermal_sys: Registered thermal governor 'fair_share'168machine # [ 0.018036] thermal_sys: Registered thermal governor 'bang_bang'169machine # [ 0.018040] thermal_sys: Registered thermal governor 'step_wise'170machine # [ 0.018043] thermal_sys: Registered thermal governor 'user_space'171machine # [ 0.018048] thermal_sys: Registered thermal governor 'power_allocator'172machine # [ 0.018082] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1173machine # [ 0.018090] cpuidle: using governor ladder174machine # [ 0.018096] cpuidle: using governor menu175machine # [ 0.018302] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.176machine # [ 0.018318] ASID allocator initialised with 65536 entries177machine # [ 0.019512] Serial: AMBA PL011 UART driver178machine # [ 0.024746] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1179machine # [ 0.024869] printk: console [ttyAMA0] enabled180machine # [ 0.148967] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages181machine # [ 0.148988] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page182machine # [ 0.148994] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages183machine # [ 0.148998] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page184machine # [ 0.149002] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages185machine # [ 0.149007] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page186machine # [ 0.149011] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages187machine # [ 0.149015] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page188machine # [ 0.156579] fbcon: Taking over console189machine # [ 0.156595] ACPI: Interpreter disabled.190machine # [ 0.158531] iommu: Default domain type: Translated191machine # [ 0.158542] iommu: DMA domain TLB invalidation policy: strict mode192machine # [ 0.164734] SCSI subsystem initialized193machine # [ 0.165472] usbcore: registered new interface driver usbfs194machine # [ 0.165503] usbcore: registered new interface driver hub195machine # [ 0.165520] usbcore: registered new device driver usb196machine # [ 0.165814] pps_core: LinuxPPS API ver. 1 registered197machine # [ 0.165820] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>198machine # [ 0.165830] PTP clock support registered199machine # [ 0.165877] EDAC MC: Ver: 3.0.0200machine # [ 0.170631] scmi_core: SCMI protocol bus registered201machine # [ 0.171591] FPGA manager framework202machine # [ 0.172574] vgaarb: loaded203machine # [ 0.173224] clocksource: Switched to clocksource arch_sys_counter204machine # [ 0.179678] VFS: Disk quotas dquot_6.6.0205machine # [ 0.179726] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)206machine # [ 0.181431] netfs: FS-Cache loaded207machine # [ 0.181559] pnp: PnP ACPI: disabled208machine # [ 0.185515] NET: Registered PF_INET protocol family209machine # [ 0.185681] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)210machine # [ 0.215869] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)211machine # [ 0.215928] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)212machine # [ 0.215955] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)213machine # [ 0.216002] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)214machine # [ 0.216076] TCP: Hash tables configured (established 8192 bind 8192)215machine # [ 0.216167] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)216machine # [ 0.216211] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)217machine # [ 0.216237] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)218machine # [ 0.216318] NET: Registered PF_UNIX/PF_LOCAL protocol family219machine # [ 0.216340] NET: Registered PF_XDP protocol family220machine # [ 0.216364] PCI: CLS 0 bytes, default 64221machine # [ 0.216625] Trying to unpack rootfs image as initramfs...222machine # [ 0.235083] kvm [1]: HYP mode not available223machine # [ 0.348970] Initialise system trusted keyrings224machine # [ 0.349837] workingset: timestamp_bits=42 max_order=18 bucket_order=0225machine # [ 0.351097] squashfs: version 4.0 (2009/01/31) Phillip Lougher226machine # [ 0.351897] 9p: Installing v9fs 9p2000 file system support227machine # [ 0.375951] Key type asymmetric registered228machine # [ 0.375981] Asymmetric key parser 'x509' registered229machine # [ 0.376064] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)230machine # [ 0.381325] io scheduler mq-deadline registered231machine # [ 0.381347] io scheduler kyber registered232machine # [ 0.393444] pl061_gpio 9030000.pl061: PL061 GPIO chip registered233machine # [ 0.394917] ledtrig-cpu: registered to indicate activity on CPUs234machine # [ 0.395352] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:235machine # [ 0.395371] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000236machine # [ 0.395388] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000237machine # [ 0.395397] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000238machine # [ 0.395427] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits239machine # [ 0.395457] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]240machine # [ 0.395539] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00241machine # [ 0.395548] pci_bus 0000:00: root bus resource [bus 00-ff]242machine # [ 0.395555] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]243machine # [ 0.395560] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]244machine # [ 0.395565] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]245machine # [ 0.395639] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint246machine # [ 0.396080] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint247machine # [ 0.396263] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]248machine # [ 0.396280] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]249machine # [ 0.396309] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]250machine # [ 0.396325] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]251machine # [ 0.396782] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint252machine # [ 0.396963] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]253machine # [ 0.396979] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]254machine # [ 0.397011] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]255machine # [ 0.397504] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint256machine # [ 0.397686] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]257machine # [ 0.397702] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]258machine # [ 0.397733] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]259machine # [ 0.398185] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint260machine # [ 0.398375] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]261machine # [ 0.398391] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]262machine # [ 0.398422] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]263machine # [ 0.398874] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint264machine # [ 0.399053] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]265machine # [ 0.399069] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]266machine # [ 0.399098] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]267machine # [ 0.399572] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint268machine # [ 0.399764] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]269machine # [ 0.399780] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]270machine # [ 0.399815] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]271machine # [ 0.400262] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint272machine # [ 0.400443] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]273machine # [ 0.400459] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]274machine # [ 0.400489] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]275machine # [ 0.400505] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]276machine # [ 0.400952] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint277machine # [ 0.401137] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]278machine # [ 0.401167] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]279machine # [ 0.445798] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint280machine # [ 0.446010] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]281machine # [ 0.446041] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]282machine # [ 0.446448] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint283machine # [ 0.446633] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]284machine # [ 0.446886] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint285machine # [ 0.447205] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]286machine # [ 0.447223] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]287machine # [ 0.447254] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]288machine # [ 0.447713] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint289machine # [ 0.447896] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]290machine # [ 0.447912] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]291machine # [ 0.447940] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]292machine # [ 0.448534] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned293machine # [ 0.448546] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned294machine # [ 0.448552] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned295machine # [ 0.448600] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned296machine # [ 0.448651] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned297machine # [ 0.448699] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned298machine # [ 0.448745] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned299machine # [ 0.448791] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned300machine # [ 0.448839] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned301machine # [ 0.448887] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned302machine # [ 0.448937] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned303machine # [ 0.448982] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned304machine # [ 0.449054] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned305machine # [ 0.449099] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned306machine # [ 0.449120] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned307machine # [ 0.449142] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned308machine # [ 0.449163] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned309machine # [ 0.449185] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned310machine # [ 0.449210] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned311machine # [ 0.485347] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned312machine # [ 0.485397] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned313machine # [ 0.485422] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned314machine # [ 0.485446] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned315machine # [ 0.485471] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned316machine # [ 0.485495] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned317machine # [ 0.485518] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned318machine # [ 0.485540] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned319machine # [ 0.485563] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned320machine # [ 0.485587] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned321machine # [ 0.485610] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned322machine # [ 0.485633] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned323machine # [ 0.485656] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned324machine # [ 0.485685] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned325machine # [ 0.485707] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned326machine # [ 0.485744] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]327machine # [ 0.485754] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]328machine # [ 0.485759] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]329machine # [ 0.486928] pci 0000:00:0a.0: enabling device (0000 -> 0002)330machine # [ 0.522605] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)331machine # [ 0.524778] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)332machine # [ 0.535842] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)333machine # [ 0.541965] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)334machine # [ 0.544043] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)335machine # [ 0.554816] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)336machine # [ 0.556946] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)337machine # [ 0.568644] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)338machine # [ 0.571883] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)339machine # [ 0.581902] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)340machine # [ 0.584342] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)341machine # [ 0.594657] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled342machine # [ 0.602642] msm_serial: driver initialized343machine # [ 0.602799] SuperH (H)SCI(F) driver initialized344machine # [ 0.602853] STM32 USART driver initialized345machine # [ 0.634167] loop: module loaded346machine # [ 0.634373] virtio_blk virtio5: 1/0/0 default/read/poll queues347machine # [ 0.635165] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)348machine # [ 0.646094] megasas: 07.734.00.00-rc1349machine # [ 0.646868] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]350machine # [ 0.648808] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000351machine # [ 0.648837] Intel/Sharp Extended Query Table at 0x0031352machine # [ 0.653839] Using buffer write method353machine # [ 0.653926] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]354machine # [ 0.655757] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000355machine # [ 0.655782] Intel/Sharp Extended Query Table at 0x0031356machine # [ 0.673898] Using buffer write method357machine # [ 0.673946] Concatenating MTD devices:358machine # [ 0.673951] (0): "0.flash"359machine # [ 0.673956] (1): "0.flash"360machine # [ 0.673959] into device "0.flash"361machine # [ 0.946729] Freeing initrd memory: 26104K362machine # [ 0.952815] tun: Universal TUN/TAP device driver, 1.6363machine # [ 0.956037] thunder_xcv, ver 1.0364machine # [ 0.956075] thunder_bgx, ver 1.0365machine # [ 0.956097] nicpf, ver 1.0366machine # [ 0.956648] e1000: Intel(R) PRO/1000 Network Driver367machine # [ 0.956656] e1000: Copyright (c) 1999-2006 Intel Corporation.368machine # [ 0.956684] e1000e: Intel(R) PRO/1000 Network Driver369machine # [ 0.956693] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.370machine # [ 0.956739] igb: Intel(R) Gigabit Ethernet Network Driver371machine # [ 0.956744] igb: Copyright (c) 2007-2014 Intel Corporation.372machine # [ 0.956767] igbvf: Intel(R) Gigabit Virtual Function Network Driver373machine # [ 0.956772] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.374machine # [ 0.956906] sky2: driver version 1.30375machine # [ 0.966364] usbcore: registered new interface driver usb-storage376machine # [ 0.966419] usbcore: registered new interface driver usbserial_generic377machine # [ 0.966432] usbserial: USB Serial support registered for generic378machine # [ 0.967029] hv_vmbus: registering driver hyperv_keyboard379machine # [ 0.968730] ehci-pci 0000:00:0a.0: EHCI Host Controller380machine # [ 0.968760] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1381machine # [ 0.969054] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000382machine # [ 0.974810] rtc-pl031 9010000.pl031: registered as rtc0383machine # [ 0.974845] rtc-pl031 9010000.pl031: setting system clock to 2026-09-06T02:30:19 UTC (1788661819)384machine # [ 0.975240] i2c_dev: i2c /dev entries driver385machine # [ 0.978350] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00386machine # [ 0.978676] hub 1-0:1.0: USB hub found387machine # [ 0.978696] hub 1-0:1.0: 6 ports detected388machine # [ 0.982687] sdhci: Secure Digital Host Controller Interface driver389machine # [ 0.982703] sdhci: Copyright(c) Pierre Ossman390machine # [ 0.982991] Synopsys Designware Multimedia Card Interface Driver391machine # [ 0.983360] sdhci-pltfm: SDHCI platform and OF driver helper392machine # [ 0.985062] hid: raw HID events driver (C) Jiri Kosina393machine # [ 0.988690] usbcore: registered new interface driver usbhid394machine # [ 0.988699] usbhid: USB HID core driver395machine # [ 0.990997] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available396machine # [ 0.992522] drop_monitor: Initializing network drop monitor service397machine # [ 0.992732] NET: Registered PF_INET6 protocol family398machine # [ 0.995847] Segment Routing with IPv6399machine # [ 0.995867] In-situ OAM (IOAM) with IPv6400machine # [ 0.995895] NET: Registered PF_PACKET protocol family401machine # [ 0.997624] 9pnet: Installing 9P2000 support402machine # [ 0.999846] Key type dns_resolver registered403machine # [ 1.006856] registered taskstats version 1404machine # [ 1.007003] Loading compiled-in X.509 certificates405machine # [ 1.015582] Demotion targets for Node 0: null406machine # [ 1.015701] Key type .fscrypt registered407machine # [ 1.015709] Key type fscrypt-provisioning registered408machine # [ 1.015810] ima: No TPM chip found, activating TPM-bypass!409machine # [ 1.015829] ima: Allocated hash algorithm: sha1410machine # [ 1.015850] ima: No architecture policies found411machine # [ 1.020054] input: gpio-keys as /devices/platform/gpio-keys/input/input0412machine # [ 1.038439] clk: Disabling unused clocks413machine # [ 1.038471] PM: genpd: Disabling unused power domains414machine # [ 1.042814] Freeing unused kernel memory: 4736K415machine # [ 1.043014] Run /init as init process416machine # [ 1.059543] systemd[1]: Successfully made /usr/ read-only.417machine # [ 1.225344] usb 1-1: new high-speed USB device number 2 using ehci-pci418machine # [ 1.377164] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1419machine # [ 1.394246] systemd[1]: systemd 262-9457f81 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)420machine # [ 1.398075] systemd[1]: Detected virtualization qemu.421machine # [ 1.398737] systemd[1]: Detected architecture arm64.422machine # [ 1.399367] systemd[1]: Running in initrd.423machine # [ 1.400366] systemd[1]: Initializing machine ID from random generator.424machine # [ 1.401466] systemd[1]: Hostname set to <machine>.425machine # [ 1.461453] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0426machine # [ 1.505589] systemd[1]: bpf-restrict-fs: LSM BPF program attached427machine # [ 1.560357] systemd[1]: Queued start job for default target Initrd Default Target.428machine # [ 1.571214] systemd[1]: Created slice Slice /system/modprobe.429machine # [ 1.572168] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.430machine # [ 1.573157] systemd[1]: Expecting device /dev/disk/by-label/nixos...431machine # [ 1.574058] systemd[1]: Reached target Path Units.432machine # [ 1.574672] systemd[1]: Reached target Slice Units.433machine # [ 1.575295] systemd[1]: Reached target Swaps.434machine # [ 1.575854] systemd[1]: Reached target Timer Units.435machine # [ 1.576616] systemd[1]: Listening on D-Bus System Message Bus Socket.436machine # [ 1.577634] systemd[1]: Listening on Journal Socket (/dev/log).437machine # [ 1.578561] systemd[1]: Listening on Journal Sockets.438machine # [ 1.579284] systemd[1]: Listening on udev Kernel Socket.439machine # [ 1.579968] systemd[1]: Reached target Socket Units.440machine # [ 1.581297] usb 1-2: new high-speed USB device number 3 using ehci-pci441machine # [ 1.583187] systemd[1]: Starting Create List of Static Device Nodes...442machine # [ 1.592765] systemd[1]: Starting Load Kernel Module 9pnet_virtio...443machine # [ 1.593918] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs444machine # [ 1.609656] systemd[1]: Mounting Kernel Configuration File System...445machine # [ 1.625434] systemd[1]: Starting Journal Service...446machine # [ 1.627797] systemd[1]: Starting Load Kernel Modules...447machine # [ 1.628602] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os448machine # [ 1.642740] systemd[1]: Starting Coldplug All udev Devices...449machine # [ 1.661419] systemd[1]: Finished Create List of Static Device Nodes.450machine # [ 1.662707] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.451machine # [ 1.663024] systemd[1]: Finished Load Kernel Module 9pnet_virtio.452machine # [ 1.663283] systemd[1]: Mounted Kernel Configuration File System.453machine # [ 1.673810] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...454machine # [ 1.700099] systemd-journald[73]: Collecting audit messages is disabled.455machine # [ 1.706880] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.456machine # [ 1.729403] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev457machine # [ 1.737830] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0458machine # [ 1.738092] [drm] features: -virgl +edid -resource_blob -host_visible459machine # [ 1.738102] [drm] features: -context_init460machine # [ 1.738850] [drm] number of scanouts: 1461machine # [ 1.738869] [drm] number of cap sets: 0462machine # [ 1.743351] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.463machine # [ 1.753554] systemd[1]: Starting Create Static Device Nodes in /dev...464machine # [ 1.757659] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2465machine # [ 1.757819] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0466machine # [ 1.765092] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic467machine # [ 1.765119] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0468machine # [ 1.817996] systemd[1]: Finished Create Static Device Nodes in /dev.469machine # [ 1.818214] systemd[1]: Reached target Preparation for Local File Systems.470machine # [ 1.818242] systemd[1]: Reached target Local File Systems.471machine # [ 1.825621] systemd[1]: Starting Rule-based Manager for Device Events and Files...472machine # [ 1.833306] Console: switching to colour frame buffer device 160x50473machine # [ 1.834005] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device474machine # [ 1.857568] systemd[1]: Finished Load Kernel Modules.475machine # [ 1.865655] systemd[1]: Starting Apply Kernel Variables...476machine # [ 1.896410] systemd-modules-load[74]: Inserted module 'dm_mod'477machine # [ 1.910904] systemd[1]: Started Journal Service.478machine # [ 1.904338] systemd-modules-load[74]: Module 'virtio_balloon' is built in479machine # [ 1.905512] systemd-modules-load[74]: Module 'virtio_console' is built in480machine # [ 1.906609] systemd-modules-load[74]: Inserted module 'virtio_gpu'481machine # [ 1.907669] systemd-modules-load[74]: Module 'virtio_rng' is built in482machine # [ 1.922557] systemd[1]: Starting Create System Files and Directories...483machine # [ 1.928502] systemd-udevd[80]: Using default interface naming scheme 'v261'.484machine # [ 1.941771] systemd[1]: Finished Apply Kernel Variables.485machine # [ 1.968681] systemd[1]: Finished Create System Files and Directories.486machine # [ 1.979048] systemd[1]: Started Rule-based Manager for Device Events and Files.487machine # [ 2.080152] systemd[1]: Starting Virtual Console Setup...488machine # [ 2.140621] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.489machine # [ 2.148585] systemd[1]: Finished Virtual Console Setup.490machine # [ 2.758014] systemd[1]: Finished Coldplug All udev Devices.491machine # [ 2.761167] systemd[1]: Reached target System Initialization.492machine # [ 2.764318] systemd[1]: Reached target Basic System.493machine # [ 2.927770] (udev-worker)[94]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.494machine # [ 2.932645] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.495machine # [ 2.959172] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.496machine # [ 3.016641] systemd[1]: Found device /dev/disk/by-label/nixos.497machine # [ 3.020939] systemd[1]: Reached target Initrd Root Device.498machine # [ 3.023656] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...499machine # [ 3.081056] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks500machine # [ 3.091577] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.501machine # [ 3.096193] systemd[1]: Mounting /sysroot...502machine # [ 3.150619] EXT4-fs (vda): mounted filesystem caa6b769-555d-4b32-ad4a-9d1c25c4b859 r/w with ordered data mode. Quota mode: none.503machine # [ 3.143374] systemd[1]: Mounted /sysroot.504machine # [ 3.145987] systemd[1]: Reached target Initrd Root File System.505machine # [ 3.151823] systemd[1]: Starting Mountpoints Configured in the Real Root...506machine # [ 3.187673] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload.507machine # [ 3.196794] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)...508machine # [ 3.200155] systemd[1]: Reloading...509machine # [ 3.404243] systemd[1]: Reloading finished in 208 ms.510machine # [ 3.427337] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace...511machine # [ 3.432268] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace...512machine # [ 3.441535] systemd[1]: Starting Load Kernel Module 9pnet_virtio...513machine # [ 3.444212] systemd[1]: initrd-parse-etc.service: Deactivated successfully.514machine # [ 3.447444] systemd[1]: Finished Mountpoints Configured in the Real Root.515machine # [ 3.453661] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.516machine # [ 3.482630] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.517machine # [ 3.485256] systemd[1]: Finished Load Kernel Module 9pnet_virtio.518machine # [ 3.642592] systemd[1]: Mounting /sysroot/nix/.ro-store...519machine # [ 3.659356] systemd[1]: Mounting /sysroot/nix/.rw-store...520machine # [ 3.667263] systemd[1]: Mounting /sysroot/run...521machine # [ 3.698339] systemd[1]: Mounting /sysroot/tmp/shared...522machine # [ 3.726899] systemd[1]: Mounting /sysroot/tmp/xchg...523machine # [ 3.771898] systemd[1]: Mounted /sysroot/nix/.ro-store.524machine # [ 3.774722] systemd[1]: Mounted /sysroot/nix/.rw-store.525machine # [ 3.782248] systemd[1]: Mounted /sysroot/run.526machine # [ 3.802055] systemd[1]: Starting rw-sysroot-nix-store.service...527machine # [ 3.807990] systemd[1]: Mounted /sysroot/tmp/shared.528machine # [ 3.826501] systemd[1]: Mounted /sysroot/tmp/xchg.529machine # [ 3.852191] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.530machine # [ 3.853637] systemd[1]: Finished rw-sysroot-nix-store.service.531machine # [ 4.405478] (udev-worker)[100]: mtd0ro: Failed to find and pin callout binary "/nix/store/x4i8f5p0japrw9j9zrdx7z9lf5387qn3-systemd-262-9457f81/lib/udev/mtd_probe": No such file or directory532machine # [ 4.411465] (udev-worker)[100]: mtd0ro: /nix/store/x4i8f5p0japrw9j9zrdx7z9lf5387qn3-systemd-262-9457f81/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory533machine # [ 4.436692] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.534machine # [ 4.441486] systemd[1]: Stopped Virtual Console Setup.535machine # [ 4.443339] systemd[1]: Stopping Virtual Console Setup...536machine # [ 4.448296] systemd[1]: Starting Virtual Console Setup...537machine # [ 4.456686] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.538machine # [ 4.458123] systemd[1]: Stopped Virtual Console Setup.539machine # [ 4.461817] systemd[1]: Starting Virtual Console Setup...540machine # [ 4.489406] systemd-vconsole-setup[155]: Configuration of first virtual console was skipped, ignoring remaining ones.541machine # [ 4.491951] systemd[1]: Finished Virtual Console Setup.542machine # [ 4.641155] systemd[1]: Mounting /sysroot/nix/store...543machine # [ 4.676700] systemd[1]: Mounted /sysroot/nix/store.544machine # [ 4.680307] systemd[1]: Reached target Initrd File Systems.545machine # [ 4.684328] systemd[1]: Starting Find NixOS closure...546machine # [ 4.689621] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...547machine # [ 4.723941] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.548machine # [ 4.728740] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.549machine # [ 4.738116] systemd[1]: Finished Find NixOS closure.550machine # [ 4.740190] systemd[1]: Reached target Initrd Default Target.551machine # [ 4.742404] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...552machine # [ 4.763757] systemd[1]: Stopped target Initrd Default Target.553machine # [ 4.765734] systemd[1]: Stopped target Basic System.554machine # [ 4.766723] systemd[1]: Stopped target Initrd Root Device.555machine # [ 4.767783] systemd[1]: Stopped target Path Units.556machine # [ 4.772140] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.557machine # [ 4.773280] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.558machine # [ 4.775011] systemd[1]: Stopped target Slice Units.559machine # [ 4.777272] systemd[1]: Stopped target Socket Units.560machine # [ 4.778323] systemd[1]: Stopped target System Initialization.561machine # [ 4.780148] systemd[1]: Stopped target Swaps.562machine # [ 4.784157] systemd[1]: Stopped target Timer Units.563machine # [ 4.784970] systemd[1]: dbus.socket: Deactivated successfully.564machine # [ 4.785807] systemd[1]: Closed D-Bus System Message Bus Socket.565machine # [ 4.786936] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.566machine # [ 4.792739] systemd[1]: Stopped Find NixOS closure.567machine # [ 4.794323] systemd[1]: Starting Load Kernel Module 9pnet_virtio...568machine # [ 4.796250] systemd[1]: Starting rw-sysroot-nix-store.service...569machine # [ 4.799674] systemd[1]: systemd-sysctl.service: Deactivated successfully.570machine # [ 4.804283] systemd[1]: Stopped Apply Kernel Variables.571machine # [ 4.806227] systemd[1]: systemd-modules-load.service: Deactivated successfully.572machine # [ 4.810827] systemd[1]: Stopped Load Kernel Modules.573machine # [ 4.811738] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.574machine # [ 4.824118] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.575machine # [ 4.825344] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.576machine # [ 4.826489] systemd[1]: Stopped Create System Files and Directories.577machine # [ 4.827438] systemd[1]: Stopped target Local File Systems.578machine # [ 4.838233] systemd[1]: Stopped target Preparation for Local File Systems.579machine # [ 4.840433] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.580machine # [ 4.842570] systemd[1]: Stopped Coldplug All udev Devices.581machine # [ 4.844594] systemd[1]: Stopping Rule-based Manager for Device Events and Files...582machine # [ 4.849835] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.583machine # [ 4.851775] systemd[1]: Stopped Virtual Console Setup.584machine # [ 4.856348] systemd[1]: initrd-cleanup.service: Deactivated successfully.585machine # [ 4.857347] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.586machine # [ 4.858272] systemd[1]: systemd-udevd.service: Deactivated successfully.587machine # [ 4.859175] systemd[1]: Stopped Rule-based Manager for Device Events and Files.588machine # [ 4.861004] systemd[1]: systemd-udevd.service: Consumed 1.535s CPU time over 3.020s wall clock time, 22.1M memory peak.589machine # [ 4.862444] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.590machine # [ 4.863451] systemd[1]: Finished rw-sysroot-nix-store.service.591machine # [ 4.864462] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.592machine # [ 4.865458] systemd[1]: Finished Load Kernel Module 9pnet_virtio.593machine # [ 4.866296] systemd[1]: Starting Cleanup udev Database...594machine # [ 4.867061] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.595machine # [ 4.872276] systemd[1]: Stopped Create Static Device Nodes in /dev.596machine # [ 4.876297] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.597machine # [ 4.877786] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.598machine # [ 4.880241] systemd[1]: kmod-static-nodes.service: Deactivated successfully.599machine # [ 4.881275] systemd[1]: Stopped Create List of Static Device Nodes.600machine # [ 4.912533] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.601machine # [ 4.915801] systemd[1]: Finished Cleanup udev Database.602machine # [ 4.920313] systemd[1]: Reached target Switch Root.603machine # [ 4.921124] systemd[1]: Starting NixOS Activation...604machine # [ 5.112399] initrd-nixos-activation-start[180]: booting system configuration /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test605machine # [ 5.179865] initrd-nixos-activation-start[180]: running activation script...606machine # [ 5.696997] initrd-nixos-activation-start[203]: setting up /etc...607machine # [ 5.984307] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.608machine # [ 5.987136] systemd[1]: Finished NixOS Activation.609machine # [ 5.992313] systemd[1]: Starting Switch Root...610machine # [ 6.013193] systemd[1]: Switching root.611machine # [ 6.192300] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).612machine # [ 6.781841] systemd[1]: systemd 262-9457f81 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)613machine # [ 6.787052] systemd[1]: Detected virtualization qemu.614machine # [ 6.789100] systemd[1]: Detected architecture arm64.615machine # [ 6.792920] systemd[1]: Detected first boot.616machine # [ 6.803754] systemd[1]: Initializing machine ID from random generator.617machine # [ 6.957783] systemd[1]: bpf-restrict-fs: LSM BPF program attached618machine # [ 7.143785] systemd[1]: Applying preset policy.619machine # [ 7.658321] systemd[1]: Populated /etc with preset unit settings.620machine # [ 8.203908] systemd[1]: initrd-switch-root.service: Deactivated successfully.621machine # [ 8.205702] systemd[1]: Stopped initrd-switch-root.service.622machine # [ 8.208631] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.623machine # [ 8.211488] systemd[1]: Created slice Slice /system/getty.624machine # [ 8.213369] systemd[1]: Created slice User and Session Slice.625machine # [ 8.215640] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.626machine # [ 8.218245] systemd[1]: Started Forward Password Requests to Wall Directory Watch.627machine # [ 8.219645] systemd[1]: Expecting device /dev/hvc0...628machine # [ 8.222451] systemd[1]: Expecting device /dev/ttyAMA0...629machine # [ 8.223670] systemd[1]: Reached target Local Encrypted Volumes.630machine # [ 8.225504] systemd[1]: Stopped target initrd-fs.target.631machine # [ 8.227957] systemd[1]: Stopped target initrd-root-fs.target.632machine # [ 8.229160] systemd[1]: Stopped target initrd-switch-root.target.633machine # [ 8.230958] systemd[1]: Reached target Virtual Machines and Containers.634machine # [ 8.232563] systemd[1]: Reached target Path Units.635machine # [ 8.234645] systemd[1]: Reached target Remote File Systems.636machine # [ 8.236658] systemd[1]: Reached target Slice Units.637machine # [ 8.239060] systemd[1]: Reached target Swaps.638machine # [ 8.246937] systemd[1]: Listening on Query the User Interactively for a Password.639machine # [ 8.254712] systemd[1]: Listening on Process Core Dump Socket.640machine # [ 8.259356] systemd[1]: Listening on Credential Encryption/Decryption.641machine # [ 8.263515] systemd[1]: Listening on Factory Reset Management.642machine # [ 8.265031] systemd[1]: Listening on Hostname Service Socket.643machine # [ 8.280019] systemd[1]: Starting Journal Log Access Socket...644machine # [ 8.284034] systemd[1]: Listening on Journal Audit Socket.645machine # [ 8.291417] systemd[1]: Listening on Console Output Muting Service Socket.646machine # [ 8.294784] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.647machine # [ 8.297432] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os648machine # [ 8.301129] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki649machine # [ 8.323333] systemd[1]: Listening on Disk Repartitioning Service Socket.650machine # [ 8.326284] systemd[1]: Listening on udev Varlink Socket.651machine # [ 8.332016] systemd[1]: Mounting Huge Pages File System...652machine # [ 8.338325] systemd[1]: Mounting POSIX Message Queue File System...653machine # [ 8.351162] systemd[1]: Mounting Kernel Debug File System...654machine # [ 8.363115] systemd[1]: Mounting Kernel Trace File System...655machine # [ 8.376774] systemd[1]: Starting Create List of Static Device Nodes...656machine # [ 8.389546] systemd[1]: Starting Load Kernel Module 9pnet_virtio...657machine # [ 8.393438] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs658machine # [ 8.422228] systemd[1]: Mounting Kernel Configuration File System...659machine # [ 8.433607] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm660machine # [ 8.436462] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore661machine # [ 8.488327] systemd[1]: Starting Load Kernel Module fuse...662machine # [ 8.493549] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67663machine # [ 8.542843] systemd[1]: Starting Journal Service...664machine # [ 8.567259] systemd[1]: Starting Load Kernel Modules...665machine # [ 8.616631] fuse: init (API version 7.45)666machine # [ 8.617605] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...667machine # [ 8.636953] systemd[1]: Starting Remount Root and Kernel File Systems...668machine # [ 8.649815] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os669machine # [ 8.657364] systemd-journald[275]: Collecting audit messages is enabled.670machine # [ 8.657863] systemd[1]: Queued start job for default target Multi-User System.671machine # [ 8.661308] systemd[1]: systemd-journald.service: Deactivated successfully.672machine # [ 8.691387] systemd[1]: Starting Coldplug All udev Devices...673machine # [ 8.682866] systemd-modules-load[276]: Module 'atkbd' is built in674machine # [ 8.684779] systemd-modules-load[276]: Module 'loop' is built in675machine # [ 8.704283] systemd[1]: Started Journal Service.676machine # [ 8.715040] systemd[1]: Listening on Journal Log Access Socket.677machine # [ 8.723507] systemd[1]: Mounted Huge Pages File System.678machine # [ 8.726690] systemd[1]: Mounted POSIX Message Queue File System.679machine # [ 8.734017] systemd[1]: Mounted Kernel Debug File System.680machine # [ 8.741691] systemd[1]: Mounted Kernel Trace File System.681machine # [ 8.742803] systemd[1]: Finished Create List of Static Device Nodes.682machine # [ 8.743746] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.683machine # [ 8.752902] systemd[1]: Finished Load Kernel Module 9pnet_virtio.684machine # [ 8.758023] systemd[1]: modprobe@fuse.service: Deactivated successfully.685machine # [ 8.762864] systemd[1]: Finished Load Kernel Module fuse.686machine # [ 8.768973] systemd[1]: Mounted Kernel Configuration File System.687machine # [ 8.770896] systemd[1]: Finished Load Kernel Modules.688machine # [ 8.789728] systemd-oomd[278]: No swap; memory pressure usage will be degraded689machine # [ 8.800222] systemd[1]: Mounting FUSE Control File System...690machine # [ 8.809813] systemd[1]: Starting Firewall...691machine # [ 8.824765] systemd[1]: Starting Apply Kernel Variables...692machine # [ 8.841367] EXT4-fs (vda): re-mounted caa6b769-555d-4b32-ad4a-9d1c25c4b859.693machine # [ 8.854833] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...694machine # [ 8.860150] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.695machine # [ 8.863760] systemd[1]: Finished Remount Root and Kernel File Systems.696machine # [ 8.890101] systemd[1]: Listening on Disk Image Download Service Socket.697machine # [ 8.908490] systemd[1]: Starting Flush Journal to Persistent Storage...698machine # [ 8.911454] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore699machine # [ 8.940932] systemd[1]: Starting Load/Save OS Random Seed...700machine # [ 8.946046] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os701machine # [ 9.010117] systemd[1]: Finished Apply Kernel Variables.702machine # [ 9.022653] systemd[1]: Mounted FUSE Control File System.703machine # [ 9.073884] systemd-journald[275]: Received client request to flush runtime journal.704machine # [ 9.132699] systemd[1]: Finished Load/Save OS Random Seed.705machine # [ 9.143239] systemd[1]: Reached target First Boot Complete.706machine # [ 9.144888] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.707machine # [ 9.148378] systemd[1]: Starting Create Static Device Nodes in /dev...708machine # [ 9.153185] systemd[1]: Finished Flush Journal to Persistent Storage.709machine # [ 9.275554] systemd[1]: Finished Create Static Device Nodes in /dev.710machine # [ 9.277142] systemd[1]: Reached target Preparation for Local File Systems.711machine # [ 9.287807] systemd[1]: Mounting /run/wrappers...712machine # [ 9.290334] systemd[1]: Starting Rule-based Manager for Device Events and Files...713machine # [ 9.372146] systemd[1]: Mounted /run/wrappers.714machine # [ 9.373198] systemd[1]: Reached target Local File Systems.715machine # [ 9.377556] systemd[1]: Listening on Boot Loader Control Service Socket.716machine # [ 9.380926] systemd[1]: Starting register-nix-paths.service...717machine # [ 9.394427] systemd[1]: Starting Create SUID/SGID Wrappers...718machine # [ 9.395679] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.719machine # [ 9.420970] systemd[1]: Starting Save Transient machine-id to Disk...720machine # [ 9.458714] systemd[1]: Starting Create System Files and Directories...721machine # [ 9.501185] systemd-udevd[320]: Using default interface naming scheme 'v261'.722machine # [ 9.565689] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.723machine # [ 9.577848] systemd[1]: Finished Save Transient machine-id to Disk.724machine # [ 9.738833] systemd[1]: Finished Create System Files and Directories.725machine # [ 9.756348] systemd[1]: Starting Rebuild Journal Catalog...726machine # [ 9.769391] systemd[1]: Starting Record System Boot/Shutdown in UTMP...727machine # [ 9.921099] systemd[1]: Started Rule-based Manager for Device Events and Files.728machine # [ 9.973739] systemd[1]: Finished Record System Boot/Shutdown in UTMP.729machine # [ 10.047567] systemd[1]: Finished Rebuild Journal Catalog.730machine # [ 10.057152] systemd[1]: Starting Update is Completed...731machine # [ 10.181982] systemd[1]: Finished Update is Completed.732machine # [ 10.496988] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.733machine # [ 10.500400] systemd[1]: Finished Create SUID/SGID Wrappers.734machine # [ 11.048385] systemd[1]: Finished Coldplug All udev Devices.735machine # [ 11.124507] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs736machine # [ 11.344233] systemd[1]: Finished register-nix-paths.service.737machine # [ 11.345936] systemd[1]: Reached target System Initialization.738machine # [ 11.351074] systemd[1]: Started Discard unused filesystem blocks once a week.739machine # [ 11.355208] systemd[1]: Started Daily Cleanup of Temporary Directories.740machine # [ 11.360756] systemd[1]: Reached target Timer Units.741machine # [ 11.364441] systemd[1]: Listening on D-Bus System Message Bus Socket.742machine # [ 11.367575] systemd[1]: Listening on Nix Daemon Socket.743machine # [ 11.374063] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.744machine # [ 11.378557] systemd[1]: Reached target Socket Units.745machine # [ 11.383095] systemd[1]: Reached target Basic System.746machine # [ 11.388803] systemd[1]: Starting Import lastlog data into lastlog2 database...747machine # [ 11.393151] systemd[1]: Starting Name Service Cache Daemon (nsncd)...748machine # [ 11.415363] systemd[1]: Starting Post-Boot Actions...749machine # [ 11.452888] systemd[1]: Started Reset console on configuration changes.750machine # [ 11.482192] systemd[1]: Starting resolvconf update...751machine # [ 11.500959] systemd[1]: Finished Firewall.752machine # [ 11.566675] systemd[1]: Finished Post-Boot Actions.753machine # [ 11.577287] nsncd[478]: Sep 06 02:30:30.112 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"754machine # [ 11.586746] systemd[1]: Started Name Service Cache Daemon (nsncd).755machine # [ 11.619982] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.756machine # [ 11.626785] systemd[1]: Reached target Host and Network Name Lookups.757machine # [ 11.632636] systemd[1]: Reached target User and Group Name Lookups.758machine # [ 11.640220] systemd[1]: Starting D-Bus System Message Bus...759machine # [ 11.662463] systemd[1]: Starting User Login Management...760machine # [ 11.678656] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.761machine # [ 11.701317] systemd[1]: Finished Import lastlog data into lastlog2 database.762machine # [ 11.732188] systemd[1]: Started backdoor.service.763machine # connecting to host...764machine # [ 11.949230] systemd-logind[504]: New seat seat0.765machine # [ 11.958606] dbus-broker-launch[503]: Looking up NSS user entry for 'systemd-timesync'...766machine: Guest shell says: b'Spawning backdoor root shell...\n'767machine: connected to guest root shell768machine # [ 11.967663] systemd[1]: Started User Login Management.769machine: (connecting took 12.24 seconds)770machine # [ 11.974517] dbus-broker-launch[503]: NSS returned no entry for 'systemd-timesync'771machine: (finished: waiting for the VM to finish booting, in 12.76 seconds)772machine # [ 11.982701] dbus-broker-launch[503]: Invalid user-name in /nix/store/q9kni4k6lchfc3fafb6a1yk6yvf86s3s-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"773machine # [ 11.994271] systemd[1]: Starting linger-users.service...774machine # [ 12.029113] systemd[1]: Started D-Bus System Message Bus.775machine # [ 12.056440] systemd[1]: Stopped target Host and Network Name Lookups.776machine # [ 12.057494] systemd[1]: Stopping Host and Network Name Lookups...777machine # [ 12.058342] systemd[1]: Stopped target User and Group Name Lookups.778machine # [ 12.059213] systemd[1]: Stopping User and Group Name Lookups...779machine # [ 12.080266] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...780machine # [ 12.088400] systemd[1]: nscd.service: Deactivated successfully.781machine # [ 12.089365] systemd[1]: Stopped Name Service Cache Daemon (nsncd).782machine # [ 12.113349] dbus-broker-launch[503]: Ready783machine # [ 12.139158] systemd[1]: Starting Name Service Cache Daemon (nsncd)...784machine # [ 12.241785] nsncd[567]: Sep 06 02:30:30.778 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"785machine # [ 12.276573] systemd[1]: Started Name Service Cache Daemon (nsncd).786machine # [ 12.316363] (udev-worker)[381]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.787machine # [ 12.327155] (udev-worker)[389]: Network interface NamePolicy= disabled on kernel command line.788machine # [ 12.333670] (udev-worker)[381]: Network interface NamePolicy= disabled on kernel command line.789machine # [ 12.348525] systemd[1]: Finished resolvconf update.790machine # [ 12.349460] systemd[1]: linger-users.service: Deactivated successfully.791machine # [ 12.350398] systemd[1]: Finished linger-users.service.792machine # [ 12.383509] systemd[1]: Created slice Slice /user/1001.793machine # [ 12.394733] systemd[1]: Reached target Preparation for Network.794machine # [ 12.425897] systemd[1]: Reached target Host and Network Name Lookups.795machine # [ 12.462241] systemd[1]: Reached target User and Group Name Lookups.796machine # [ 12.463285] systemd[1]: Starting DHCP Client...797machine # [ 12.493522] systemd[1]: Starting Extra networking commands....798machine # [ 12.494490] systemd[1]: Starting User Runtime Directory /run/user/1001...799machine # [ 12.523673] systemd[1]: Finished User Runtime Directory /run/user/1001.800machine # [ 12.542457] systemd[1]: Starting User Manager for UID 1001...801machine # [ 12.561190] systemd[1]: Condition check resulted in Virtio network device being skipped.802machine # [ 12.580859] systemd[1]: Starting Address configuration of eth1...803machine # [ 12.642270] (systemd)[603]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0)804machine # [ 12.658174] systemd-logind[504]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'.805machine # [ 12.720719] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy806machine # [ 12.947068] network-addresses-eth1-start[604]: adding address 192.168.1.1/24... done807machine # [ 12.985895] systemd-logind[504]: Watching system buttons on /dev/input/event0 (gpio-keys)808machine # [ 13.042924] network-addresses-eth1-start[604]: adding address 2001:db8:1::1/64... done809machine # [ 13.066985] systemd[603]: Queued start job for default target Main User Target.810machine # [ 13.106057] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy811machine # [ 13.107671] systemd[603]: Created slice User Application Slice.812machine # [ 13.170578] systemd[603]: Started Daily Cleanup of User's Temporary Directories.813machine # [ 13.190516] systemd[603]: Reached target Paths.814machine # [ 13.208999] systemd[603]: Reached target Timers.815machine # [ 13.247403] systemd[603]: Starting D-Bus User Message Bus Socket...816machine # [ 13.264848] systemd[603]: Starting Create User Files and Directories...817machine # [ 13.292104] systemd[603]: Finished Create User Files and Directories.818machine # [ 13.309466] mousedev: PS/2 mouse device common for all mice819machine # [ 13.319438] systemd[1]: Finished Address configuration of eth1.820machine # [ 13.335404] systemd[603]: Listening on D-Bus User Message Bus Socket.821machine # [ 13.356207] systemd[603]: Reached target Sockets.822machine # [ 13.357093] systemd[603]: Reached target Basic System.823machine # [ 13.357797] systemd[1]: Started User Manager for UID 1001.824machine # [ 13.358576] systemd[603]: Starting Run user-specific NixOS activation...825machine # [ 13.359496] systemd[603]: Finished Run user-specific NixOS activation.826machine # [ 13.405612] systemd[603]: Reached target Main User Target.827machine # [ 13.406470] systemd[603]: Startup finished in 619ms.828machine # [ 13.407164] systemd-logind[504]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)829machine # [ 13.477200] dhcpcd[612]: dhcpcd-10.3.2 starting830machine # [ 13.532395] dhcpcd[685]: dev: loaded udev831machine # [ 13.603030] 8021q: 802.1Q VLAN Support v1.8832machine # [ 13.603427] 8021q: adding VLAN 0 to HW filter on device eth1833machine # [ 13.703028] cfg80211: Loading compiled-in X.509 certificates for regulatory database834machine # [ 13.737191] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'835machine # [ 13.740277] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'836machine # [ 13.745054] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2837machine # [ 13.745448] cfg80211: failed to load regulatory.db838machine # [ 13.765078] systemd[1]: Finished Extra networking commands..839machine # [ 13.776527] systemd[1]: Reached target Network.840machine # [ 13.789681] systemd[1]: Starting Permit User Sessions...841machine # [ 14.047654] systemd[1]: Finished Permit User Sessions.842machine # [ 14.063888] systemd[1]: Started Getty on tty1.843machine # [ 14.078422] systemd[1]: Reached target Login Prompts.844machine # [ 14.264088] 8021q: adding VLAN 0 to HW filter on device eth0845machine # [ 14.260059] dhcpcd[685]: eth0: waiting for carrier846machine # [ 14.277623] dhcpcd[685]: libudev: received NULL device847machine # [ 14.286962] dhcpcd[685]: libudev: received NULL device848machine # [ 14.287898] dhcpcd[685]: eth0: carrier acquired849machine # [ 14.347687] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3850machine # [ 14.420104] dhcpcd[685]: DUID 00:01:00:01:32:2f:8c:c8:52:54:00:12:34:56851machine # [ 14.421171] dhcpcd[685]: eth0: IAID 00:12:34:56852machine # [ 14.421814] dhcpcd[685]: eth0: adding address fe80::5054:ff:fe12:3456853machine # [ 14.655507] systemd[1]: Starting Virtual Console Setup...854machine # [ 14.678088] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.855machine # [ 14.709568] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.856machine # [ 14.711008] systemd[1]: Stopped Virtual Console Setup.857machine # [ 14.715433] systemd[1]: Starting Virtual Console Setup...858machine # [ 14.718376] systemd-logind[504]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)859machine # [ 15.196481] systemd-vconsole-setup[723]: Configuration of first virtual console was skipped, ignoring remaining ones.860machine # [ 15.206343] systemd[1]: Finished Virtual Console Setup.861machine # [ 15.469841] dhcpcd[685]: eth0: soliciting a DHCP lease862machine # [ 15.481314] dhcpcd[685]: eth0: offered 10.0.2.15 from 10.0.2.2863machine # [ 15.484432] dhcpcd[685]: eth0: probing address 10.0.2.15/24864machine # [ 16.814008] dhcpcd[685]: eth0: soliciting an IPv6 router865machine # [ 16.817525] dhcpcd[685]: eth0: Router Advertisement from fe80::2866machine # [ 16.820412] dhcpcd[685]: eth0: adding address fec0::5054:ff:fe12:3456/64867machine # [ 16.823271] dhcpcd[685]: eth0: adding route to fec0::/64868machine # [ 16.825730] dhcpcd[685]: eth0: adding default route via fe80::2869machine # [ 20.548705] dhcpcd[685]: eth0: leased 10.0.2.15 for 86400 seconds870machine # [ 20.550761] dhcpcd[685]: eth0: adding route to 10.0.2.0/24871machine # [ 20.552647] dhcpcd[685]: eth0: adding default route via 10.0.2.2872machine # [ 20.675299] systemd[1]: Started DHCP Client.873machine # [ 20.677658] systemd[1]: Reached target Multi-User System.874machine # [ 20.678497] systemd[1]: Startup finished in 1.034s (kernel) + 5.240s (initrd) + 14.402s (userspace) = 20.677s.875machine: (finished: waiting for unit multi-user.target, in 21.56 seconds)876machine: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/bin/switch-to-configuration test877machine # Checking switch inhibitors... done878machine # [ 21.357194] nixos[840]: switching to system configuration /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test879machine # [ 21.359604] systemd[1]: Stopped target Local File Systems.880machine # activating the configuration...881machine # [ 21.362455] systemd[1]: Stopped target Remote File Systems.882machine # setting up /etc...883machine # [ 21.847089] systemd[1]: Reload requested from client PID 840 ('.switch-to-conf') (unit backdoor.service)...884machine # [ 21.849304] systemd[1]: Reloading...885machine # [ 22.469221] systemd[1]: Reloading finished in 618 ms.886machine # reloading user units for usertest...887machine # [ 22.523525] systemd[603]: Created slice User Core Session Slice.888machine # [ 22.528320] systemd[603]: Starting D-Bus User Message Bus...889machine # [ 22.610062] dbus-broker-launch[910]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/q9kni4k6lchfc3fafb6a1yk6yvf86s3s-system-path/share/dbus-1/services/org.freedesktop.import1.service'890machine # [ 22.613303] dbus-broker-launch[910]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/q9kni4k6lchfc3fafb6a1yk6yvf86s3s-system-path/share/dbus-1/services/org.freedesktop.machine1.service'891machine # [ 22.616614] dbus-broker-launch[910]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/q9kni4k6lchfc3fafb6a1yk6yvf86s3s-system-path/share/dbus-1/services/org.freedesktop.portable1.service'892machine # [ 22.620119] dbus-broker-launch[910]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/q9kni4k6lchfc3fafb6a1yk6yvf86s3s-system-path/share/dbus-1/services/org.freedesktop.systemd1.service'893machine # [ 22.624064] dbus-broker-launch[910]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored894machine # [ 22.627178] dbus-broker-launch[910]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored895machine # [ 22.629450] systemd[603]: Started D-Bus User Message Bus.896machine # [ 22.636849] dbus-broker-launch[910]: Ready897machine # [ 22.757525] systemd[603]: Reexecution requested from client PID 909 ('switch-to-confi')...898machine # [ 22.761384] systemd[603]: Reexecuting.899machine # [ 22.819008] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy900machine # [ 23.050663] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy901machine # [ 23.059988] systemd[603]: Reload requested from client PID 909 ('switch-to-confi')...902machine # [ 23.062817] systemd[603]: Reloading...903machine # [ 23.301633] systemd[603]: Reloading finished in 237 ms.904machine # [ 23.320197] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy905machine # restarting the following user units: nixos-activation.service906machine # [ 23.332614] systemd[603]: Stopped Run user-specific NixOS activation.907machine # [ 23.335389] systemd[603]: Stopping Run user-specific NixOS activation...908machine # [ 23.339222] systemd[603]: Starting Run user-specific NixOS activation...909machine # [ 23.390935] systemd[603]: Finished Run user-specific NixOS activation.910machine # restarting sysinit-reactivation.target911machine # [ 23.410658] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....912machine # [ 23.556478] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..913machine # [ 23.561767] systemd[1]: Reached target Reactivate sysinit units.914machine # [ 23.566379] systemd[1]: Reached target Local File Systems.915machine # [ 23.571715] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore916machine # [ 23.577402] systemd[1]: Starting Create SUID/SGID Wrappers...917machine # [ 23.578394] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.918machine # [ 23.579611] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67919machine # [ 23.587122] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore920machine # [ 23.596942] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os921machine # [ 23.603174] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os922machine # [ 23.604707] systemd[1]: Reached target Remote File Systems.923machine # [ 23.605518] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os924machine # [ 23.606767] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki925machine # [ 24.001330] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.926machine # [ 24.006593] systemd[1]: Finished Create SUID/SGID Wrappers.927machine # [ 24.010545] systemd[1]: Starting linger-users.service...928machine # [ 24.079561] systemd[1]: linger-users.service: Deactivated successfully.929machine # [ 24.083780] systemd[1]: Finished linger-users.service.930machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service931machine # [ 24.353144] nixos[840]: finished switching to system configuration /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test932machine: (finished: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/bin/switch-to-configuration test, in 3.60 seconds)933machine: must succeed: rm /etc/NIXOS934machine: (finished: must succeed: rm /etc/NIXOS, in 0.07 seconds)935machine: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/7prbf4wwajd81mn77q9y0xvvg807vm95-nixos-system-other-test/bin/switch-to-configuration test936machine # this should succeed (config: /nix/store/7prbf4wwajd81mn77q9y0xvvg807vm95-nixos-system-other-test, action: test)937machine # Checking switch inhibitors... done938machine # [ 25.184937] nixos[988]: switching to system configuration /nix/store/7prbf4wwajd81mn77q9y0xvvg807vm95-nixos-system-other-test939machine # [ 25.188210] systemd[1]: Stopped target Remote File Systems.940machine # [ 25.190084] systemd[1]: Stopped target Local File Systems.941machine # activating the configuration...942machine # removing user ‘usertest’943machine # setting up /etc...944machine # [ 25.785689] systemd[1]: Reload requested from client PID 988 ('.switch-to-conf') (unit backdoor.service)...945machine # [ 25.787600] systemd[1]: Reloading...946machine # [ 26.526913] systemd[1]: Reloading finished in 736 ms.947machine # reloading user units for usertest...948machine # [ 26.716223] systemd[603]: Reexecution requested from client PID 1059 ('switch-to-confi')...949machine # [ 26.721085] systemd[603]: Reexecuting.950machine # [ 26.779035] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy951machine # [ 27.018125] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy952machine # [ 27.025823] systemd[603]: Reload requested from client PID 1059 ('switch-to-confi')...953machine # [ 27.028914] systemd[603]: Reloading...954machine # [ 27.293464] systemd[603]: Reloading finished in 262 ms.955machine # [ 27.308184] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy956machine # restarting the following user units: nixos-activation.service957machine # [ 27.319608] systemd[603]: Stopped Run user-specific NixOS activation.958machine # [ 27.322369] systemd[603]: Stopping Run user-specific NixOS activation...959machine # [ 27.325714] systemd[603]: Starting Run user-specific NixOS activation...960machine # [ 27.381126] systemd[603]: Finished Run user-specific NixOS activation.961machine # restarting sysinit-reactivation.target962machine # [ 27.386611] systemd[1]: Stopped target Reactivate sysinit units.963machine # [ 27.388894] systemd[1]: Stopping Reactivate sysinit units...964machine # [ 27.389829] systemd[1]: Reached target Reactivate sysinit units.965machine # reloading the following units: dbus-broker.service966machine # [ 27.394095] systemd[1]: Reloading D-Bus System Message Bus...967machine # [ 27.395447] dbus-broker-launch[503]: Caught SIGHUP, trigger reload.968machine # [ 27.417984] dbus-broker-launch[503]: Looking up NSS user entry for 'systemd-timesync'...969machine # [ 27.420647] dbus-broker-launch[503]: NSS returned no entry for 'systemd-timesync'970machine # [ 27.421953] dbus-broker-launch[503]: Invalid user-name in /nix/store/2d37a0ag8593x6bsc14irprkj2vpg80c-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"971machine # [ 27.459242] systemd[1]: Reloaded D-Bus System Message Bus.972machine # restarting the following units: network-addresses-eth1.service973machine # [ 27.467961] systemd[1]: Stopping Address configuration of eth1...974machine # [ 27.531733] network-addresses-eth1-pre-stop[1072]: deleting address 192.168.1.1/24... done975machine # [ 27.548145] network-addresses-eth1-pre-stop[1072]: deleting address 2001:db8:1::1/64... done976machine # [ 27.561294] systemd[1]: network-addresses-eth1.service: Deactivated successfully.977machine # [ 27.564129] systemd[1]: Stopped Address configuration of eth1.978machine # [ 27.570405] systemd[1]: Starting Address configuration of eth1...979machine # [ 27.654916] network-addresses-eth1-start[1077]: adding address 192.168.1.2/24... done980machine # [ 27.668086] network-addresses-eth1-start[1077]: adding address 2001:db8:1::2/64... done981machine # [ 27.684699] systemd[1]: Finished Address configuration of eth1.982machine # [ 27.693411] systemd[1]: Reached target Remote File Systems.983machine # [ 27.699701] systemd[1]: Starting linger-users.service...984machine # [ 27.703992] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os985machine # [ 27.708406] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki986machine # [ 27.716412] systemd[1]: Reached target Local File Systems.987machine # [ 27.717415] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore988machine # [ 27.720450] systemd[1]: Starting Create SUID/SGID Wrappers...989machine # [ 27.728925] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.990machine # [ 27.730274] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67991machine # [ 27.741829] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore992machine # [ 27.745563] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os993machine # [ 27.748301] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os994machine # [ 27.793903] linger-users-start[1092]: id: ‘usertest’: no such user995machine # [ 27.796731] linger-users-start[1088]: Removing linger for missing user usertest996machine # [ 27.814166] systemd[1]: linger-users.service: Deactivated successfully.997machine # [ 27.815363] systemd[1]: Finished linger-users.service.998machine # [ 28.198745] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.999machine # [ 28.202915] systemd[1]: Finished Create SUID/SGID Wrappers.1000machine # [ 28.463837] nixos[988]: finished switching to system configuration /nix/store/7prbf4wwajd81mn77q9y0xvvg807vm95-nixos-system-other-test1001machine: (finished: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/7prbf4wwajd81mn77q9y0xvvg807vm95-nixos-system-other-test/bin/switch-to-configuration test, in 4.04 seconds)1002subtest: services1003machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/bin/switch-to-configuration test 2>&11004machine # [ 29.141010] nixos[1155]: switching to system configuration /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test1005machine # [ 29.145147] systemd[1]: Stopped target Local File Systems.1006machine # [ 29.146638] systemd[1]: Stopped target Remote File Systems.1007machine # [ 29.701638] systemd[1]: Reload requested from client PID 1155 ('.switch-to-conf') (unit backdoor.service)...1008machine # [ 29.703669] systemd[1]: Reloading...1009machine # [ 30.373302] systemd[1]: Reloading finished in 666 ms.1010machine # [ 30.588357] systemd[603]: Reexecution requested from client PID 1224 ('switch-to-confi')...1011machine # [ 30.589835] systemd[603]: Reexecuting.1012machine # [ 30.659094] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1013machine # [ 30.882569] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1014machine # [ 30.891233] systemd[603]: Reload requested from client PID 1224 ('switch-to-confi')...1015machine # [ 30.894341] systemd[603]: Reloading...1016machine # [ 31.109432] systemd[603]: Reloading finished in 214 ms.1017machine # [ 31.124199] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1018machine # [ 31.135503] systemd[603]: Stopped Run user-specific NixOS activation.1019machine # [ 31.138401] systemd[603]: Stopping Run user-specific NixOS activation...1020machine # [ 31.141448] systemd[603]: Starting Run user-specific NixOS activation...1021machine # [ 31.197252] systemd[603]: Finished Run user-specific NixOS activation.1022machine # [ 31.201753] systemd[1]: Stopped target Reactivate sysinit units.1023machine # [ 31.206845] systemd[1]: Stopping Reactivate sysinit units...1024machine # [ 31.207970] systemd[1]: Reached target Reactivate sysinit units.1025machine # [ 31.209559] dbus-broker-launch[503]: Caught SIGHUP, trigger reload.1026machine # [ 31.210731] systemd[1]: Reloading D-Bus System Message Bus...1027machine # [ 31.222997] dbus-broker-launch[503]: Looking up NSS user entry for 'systemd-timesync'...1028machine # [ 31.225336] dbus-broker-launch[503]: NSS returned no entry for 'systemd-timesync'1029machine # [ 31.226590] dbus-broker-launch[503]: Invalid user-name in /nix/store/q9kni4k6lchfc3fafb6a1yk6yvf86s3s-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1030machine # [ 31.257742] systemd[1]: Reloaded D-Bus System Message Bus.1031machine # [ 31.265460] systemd[1]: Stopping Address configuration of eth1...1032machine # [ 31.324978] network-addresses-eth1-pre-stop[1237]: deleting address 192.168.1.2/24... done1033machine # [ 31.338070] network-addresses-eth1-pre-stop[1237]: deleting address 2001:db8:1::2/64... done1034machine # [ 31.349397] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1035machine # [ 31.352224] systemd[1]: Stopped Address configuration of eth1.1036machine # [ 31.356874] systemd[1]: Starting Address configuration of eth1...1037machine # [ 31.433090] network-addresses-eth1-start[1242]: adding address 192.168.1.1/24... done1038machine # [ 31.444517] network-addresses-eth1-start[1242]: adding address 2001:db8:1::1/64... done1039machine # [ 31.460176] systemd[1]: Finished Address configuration of eth1.1040machine # [ 31.463002] systemd[1]: Reached target Remote File Systems.1041machine # [ 31.467467] systemd[1]: Reached target Local File Systems.1042machine # [ 31.471561] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1043machine # [ 31.476683] systemd[1]: Starting Create SUID/SGID Wrappers...1044machine # [ 31.477631] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1045machine # [ 31.478874] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671046machine # [ 31.492484] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1047machine # [ 31.495543] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1048machine # [ 31.497374] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1049machine # [ 31.499066] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1050machine # [ 31.502281] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1051machine # [ 31.826787] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1052machine # [ 31.829317] systemd[1]: Finished Create SUID/SGID Wrappers.1053machine # [ 31.834776] systemd[1]: Starting linger-users.service...1054machine # [ 31.884488] systemd[1]: linger-users.service: Deactivated successfully.1055machine # [ 31.887622] systemd[1]: Finished linger-users.service.1056machine # [ 32.147943] nixos[1155]: finished switching to system configuration /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test1057machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.69 seconds)1058machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/bin/switch-to-configuration test 2>&11059machine # [ 32.809911] nixos[1311]: switching to system configuration /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test1060machine # [ 32.813461] systemd[1]: Stopped target Local File Systems.1061machine # [ 32.814902] systemd[1]: Stopped target Remote File Systems.1062machine # [ 33.303430] systemd[1]: Reload requested from client PID 1311 ('.switch-to-conf') (unit backdoor.service)...1063machine # [ 33.305730] systemd[1]: Reloading...1064machine # [ 33.889806] systemd[1]: Reloading finished in 580 ms.1065machine # [ 34.056449] systemd[603]: Reexecution requested from client PID 1380 ('switch-to-confi')...1066machine # [ 34.059813] systemd[603]: Reexecuting.1067machine # [ 34.121869] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1068machine # [ 34.290036] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1069machine # [ 34.296832] systemd[603]: Reload requested from client PID 1380 ('switch-to-confi')...1070machine # [ 34.299205] systemd[603]: Reloading...1071machine # [ 34.492974] systemd[603]: Reloading finished in 192 ms.1072machine # [ 34.508198] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1073machine # [ 34.519115] systemd[603]: Stopped Run user-specific NixOS activation.1074machine # [ 34.520302] systemd[603]: Stopping Run user-specific NixOS activation...1075machine # [ 34.523254] systemd[603]: Starting Run user-specific NixOS activation...1076machine # [ 34.564468] systemd[603]: Finished Run user-specific NixOS activation.1077machine # [ 34.569203] systemd[1]: Stopped target Reactivate sysinit units.1078machine # [ 34.572338] systemd[1]: Stopping Reactivate sysinit units...1079machine # [ 34.573239] systemd[1]: Reached target Reactivate sysinit units.1080machine # [ 34.575348] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1081machine # [ 34.578742] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1082machine # [ 34.581900] systemd[1]: Reached target Local File Systems.1083machine # [ 34.586191] systemd[1]: Reached target Remote File Systems.1084machine # [ 34.591872] systemd[1]: Starting linger-users.service...1085machine # [ 34.595790] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1086machine # [ 34.606218] systemd[1]: Starting Create SUID/SGID Wrappers...1087machine # [ 34.607111] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1088machine # [ 34.610643] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671089machine # [ 34.614466] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1090machine # [ 34.620228] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1091machine # [ 34.623711] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1092machine # [ 34.680768] systemd[1]: linger-users.service: Deactivated successfully.1093machine # [ 34.682482] systemd[1]: Finished linger-users.service.1094machine # [ 34.932907] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1095machine # [ 34.936130] systemd[1]: Finished Create SUID/SGID Wrappers.1096machine # [ 35.193381] nixos[1311]: finished switching to system configuration /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test1097machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.04 seconds)1098machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11099machine # [ 35.778491] nixos[1452]: switching to system configuration /nix/store/pl2am5s3lbqd2zsyjh8ls885a80l7g54-nixos-system-machine-test1100machine # [ 35.781140] systemd[1]: Stopped target Local File Systems.1101machine # [ 35.783300] systemd[1]: Stopped target Remote File Systems.1102machine # [ 36.300840] systemd[1]: Reload requested from client PID 1452 ('.switch-to-conf') (unit backdoor.service)...1103machine # [ 36.302837] systemd[1]: Reloading...1104machine # [ 36.986742] systemd[1]: Reloading finished in 681 ms.1105machine # [ 37.161254] systemd[603]: Reexecution requested from client PID 1521 ('switch-to-confi')...1106machine # [ 37.166358] systemd[603]: Reexecuting.1107machine # [ 37.230708] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1108machine # [ 37.430596] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1109machine # [ 37.437935] systemd[603]: Reload requested from client PID 1521 ('switch-to-confi')...1110machine # [ 37.440566] systemd[603]: Reloading...1111machine # [ 37.637812] systemd[603]: Reloading finished in 196 ms.1112machine # [ 37.652354] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1113machine # [ 37.662797] systemd[603]: Stopped Run user-specific NixOS activation.1114machine # [ 37.665922] systemd[603]: Stopping Run user-specific NixOS activation...1115machine # [ 37.669325] systemd[603]: Starting Run user-specific NixOS activation...1116machine # [ 37.723635] systemd[603]: Finished Run user-specific NixOS activation.1117machine # [ 37.728701] systemd[1]: Stopped target Reactivate sysinit units.1118machine # [ 37.732448] systemd[1]: Stopping Reactivate sysinit units...1119machine # [ 37.733439] systemd[1]: Reached target Reactivate sysinit units.1120machine # [ 37.734275] systemd[1]: Reached target Local File Systems.1121machine # [ 37.740490] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1122machine # [ 37.741854] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1123machine # [ 37.744634] systemd[1]: Reached target Remote File Systems.1124machine # [ 37.752287] systemd[1]: Starting linger-users.service...1125machine # [ 37.756686] systemd[1]: Starting test.service...1126machine # [ 37.763483] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1127machine # [ 37.776734] systemd[1]: Starting Create SUID/SGID Wrappers...1128machine # [ 37.777656] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1129machine # [ 37.778841] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671130machine # [ 37.790728] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1131machine # [ 37.794851] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1132machine # [ 37.798366] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1133machine # [ 37.832312] systemd[1]: Finished test.service.1134machine # [ 37.869700] systemd[1]: linger-users.service: Deactivated successfully.1135machine # [ 37.873591] systemd[1]: Finished linger-users.service.1136machine # [ 38.176448] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1137machine # [ 38.179955] systemd[1]: Finished Create SUID/SGID Wrappers.1138machine # [ 38.438995] nixos[1452]: finished switching to system configuration /nix/store/pl2am5s3lbqd2zsyjh8ls885a80l7g54-nixos-system-machine-test1139machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 3.24 seconds)1140machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&11141machine # [ 39.074809] nixos[1595]: switching to system configuration /nix/store/pl2am5s3lbqd2zsyjh8ls885a80l7g54-nixos-system-machine-test1142machine # [ 39.077715] systemd[1]: Stopped target Remote File Systems.1143machine # [ 39.080224] systemd[1]: Stopped target Local File Systems.1144machine # [ 39.579552] systemd[1]: Reload requested from client PID 1595 ('.switch-to-conf') (unit backdoor.service)...1145machine # [ 39.582168] systemd[1]: Reloading...1146machine # [ 40.229721] systemd[1]: Reloading finished in 643 ms.1147machine # [ 40.392116] systemd[603]: Reexecution requested from client PID 1664 ('switch-to-confi')...1148machine # [ 40.393523] systemd[603]: Reexecuting.1149machine # [ 40.477249] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1150machine # [ 40.718090] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1151machine # [ 40.726704] systemd[603]: Reload requested from client PID 1664 ('switch-to-confi')...1152machine # [ 40.729968] systemd[603]: Reloading...1153machine # [ 40.940975] systemd[603]: Reloading finished in 210 ms.1154machine # [ 40.957719] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1155machine # [ 40.965954] systemd[603]: Stopped Run user-specific NixOS activation.1156machine # [ 40.968582] systemd[603]: Stopping Run user-specific NixOS activation...1157machine # [ 40.972200] systemd[603]: Starting Run user-specific NixOS activation...1158machine # [ 41.021654] systemd[603]: Finished Run user-specific NixOS activation.1159machine # [ 41.026567] systemd[1]: Stopped target Reactivate sysinit units.1160machine # [ 41.029932] systemd[1]: Stopping Reactivate sysinit units...1161machine # [ 41.035512] systemd[1]: Reached target Reactivate sysinit units.1162machine # [ 41.037204] systemd[1]: Reached target Local File Systems.1163machine # [ 41.038430] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1164machine # [ 41.044430] systemd[1]: Starting Create SUID/SGID Wrappers...1165machine # [ 41.046843] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1166machine # [ 41.052868] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671167machine # [ 41.055387] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1168machine # [ 41.066544] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1169machine # [ 41.070667] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1170machine # [ 41.073172] systemd[1]: Reached target Remote File Systems.1171machine # [ 41.074122] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1172machine # [ 41.075926] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1173machine # [ 41.436892] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1174machine # [ 41.440935] systemd[1]: Finished Create SUID/SGID Wrappers.1175machine # [ 41.446101] systemd[1]: Starting linger-users.service...1176machine # [ 41.511846] systemd[1]: linger-users.service: Deactivated successfully.1177machine # [ 41.514681] systemd[1]: Finished linger-users.service.1178machine # [ 41.771242] nixos[1595]: finished switching to system configuration /nix/store/pl2am5s3lbqd2zsyjh8ls885a80l7g54-nixos-system-machine-test1179machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 3.33 seconds)1180machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&11181machine # [ 42.371751] nixos[1736]: switching to system configuration /nix/store/1pl13kblzmh2q7xw3nkykzxm06qbq0lh-nixos-system-machine-test1182machine # [ 42.374387] systemd[1]: Stopped target Local File Systems.1183machine # [ 42.376765] systemd[1]: Stopped target Remote File Systems.1184machine # [ 42.906957] systemd[1]: Reload requested from client PID 1736 ('.switch-to-conf') (unit backdoor.service)...1185machine # [ 42.909224] systemd[1]: Reloading...1186machine # [ 43.540106] systemd[1]: Reloading finished in 628 ms.1187machine # [ 43.692511] systemd[603]: Reexecution requested from client PID 1805 ('switch-to-confi')...1188machine # [ 43.693918] systemd[603]: Reexecuting.1189machine # [ 43.767262] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1190machine # [ 44.020166] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1191machine # [ 44.027088] systemd[603]: Reload requested from client PID 1805 ('switch-to-confi')...1192machine # [ 44.030030] systemd[603]: Reloading...1193machine # [ 44.239796] systemd[603]: Reloading finished in 208 ms.1194machine # [ 44.256177] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1195machine # [ 44.265775] systemd[603]: Stopped Run user-specific NixOS activation.1196machine # [ 44.268146] systemd[603]: Stopping Run user-specific NixOS activation...1197machine # [ 44.271849] systemd[603]: Starting Run user-specific NixOS activation...1198machine # [ 44.333591] systemd[603]: Finished Run user-specific NixOS activation.1199machine # [ 44.338899] systemd[1]: Stopped target Reactivate sysinit units.1200machine # [ 44.341363] systemd[1]: Stopping Reactivate sysinit units...1201machine # [ 44.343021] systemd[1]: Reached target Reactivate sysinit units.1202machine # [ 44.346812] systemd[1]: Reached target Local File Systems.1203machine # [ 44.350786] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1204machine # [ 44.356214] systemd[1]: Starting Create SUID/SGID Wrappers...1205machine # [ 44.357222] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1206machine # [ 44.358445] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671207machine # [ 44.374895] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1208machine # [ 44.379394] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1209machine # [ 44.380933] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1210machine # [ 44.382126] systemd[1]: Reached target Remote File Systems.1211machine # [ 44.382961] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1212machine # [ 44.385153] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1213machine # [ 44.740204] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1214machine # [ 44.744583] systemd[1]: Finished Create SUID/SGID Wrappers.1215machine # [ 44.749326] systemd[1]: Starting linger-users.service...1216machine # [ 44.818883] systemd[1]: linger-users.service: Deactivated successfully.1217machine # [ 44.822336] systemd[1]: Finished linger-users.service.1218machine # [ 45.079307] nixos[1736]: finished switching to system configuration /nix/store/1pl13kblzmh2q7xw3nkykzxm06qbq0lh-nixos-system-machine-test1219machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 3.31 seconds)1220machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11221machine # [ 45.776355] nixos[1877]: switching to system configuration /nix/store/34wr58kgh4jvxi46ql47qackvp2l37vf-nixos-system-machine-test1222machine # [ 45.781102] systemd[1]: Stopped target Local File Systems.1223machine # [ 45.782039] systemd[1]: Stopped target Remote File Systems.1224machine # [ 45.782825] systemd[1]: test.service: Deactivated successfully.1225machine # [ 45.783640] systemd[1]: Stopped Test unit.1226machine # [ 46.327294] systemd[1]: Reload requested from client PID 1877 ('.switch-to-conf') (unit backdoor.service)...1227machine # [ 46.329795] systemd[1]: Reloading...1228machine # [ 47.679624] systemd[1]: Reloading finished in 1347 ms.1229machine # [ 47.877640] systemd[603]: Reexecution requested from client PID 1946 ('switch-to-confi')...1230machine # [ 47.882290] systemd[603]: Reexecuting.1231machine # [ 47.944003] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1232machine # [ 48.165761] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1233machine # [ 48.173019] systemd[603]: Reload requested from client PID 1946 ('switch-to-confi')...1234machine # [ 48.175596] systemd[603]: Reloading...1235machine # [ 48.389757] systemd[603]: Reloading finished in 212 ms.1236machine # [ 48.404229] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1237machine # [ 48.414350] systemd[603]: Stopped Run user-specific NixOS activation.1238machine # [ 48.417436] systemd[603]: Stopping Run user-specific NixOS activation...1239machine # [ 48.420868] systemd[603]: Starting Run user-specific NixOS activation...1240machine # [ 48.474225] systemd[603]: Finished Run user-specific NixOS activation.1241machine # [ 48.478715] systemd[1]: Stopped target Reactivate sysinit units.1242machine # [ 48.481864] systemd[1]: Stopping Reactivate sysinit units...1243machine # [ 48.482784] systemd[1]: Reached target Reactivate sysinit units.1244machine # [ 48.483572] systemd[1]: Reached target Remote File Systems.1245machine # [ 48.486573] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1246machine # [ 48.489047] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1247machine # [ 48.492958] systemd[1]: Reached target Local File Systems.1248machine # [ 48.493791] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1249machine # [ 48.500697] systemd[1]: Starting Create SUID/SGID Wrappers...1250machine # [ 48.503904] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1251machine # [ 48.506889] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671252machine # [ 48.515328] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1253machine # [ 48.520183] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1254machine # [ 48.522279] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1255machine # [ 48.837165] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1256machine # [ 48.841706] systemd[1]: Finished Create SUID/SGID Wrappers.1257machine # [ 48.844353] systemd[1]: Starting linger-users.service...1258machine # [ 48.848847] systemd[1]: Starting test.service...1259machine # [ 48.894522] systemd[1]: Finished test.service.1260machine # [ 48.923388] systemd[1]: linger-users.service: Deactivated successfully.1261machine # [ 48.926405] systemd[1]: Finished linger-users.service.1262machine # [ 49.183769] nixos[1877]: finished switching to system configuration /nix/store/34wr58kgh4jvxi46ql47qackvp2l37vf-nixos-system-machine-test1263machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 4.10 seconds)1264machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&11265machine # [ 49.936521] nixos[2020]: switching to system configuration /nix/store/21hfw8sh6q8izq23jfphrq020id5dlkc-nixos-system-machine-test1266machine # [ 49.939262] systemd[1]: Stopped target Remote File Systems.1267machine # [ 49.941801] systemd[1]: Stopped target Local File Systems.1268machine # [ 50.566955] systemd[1]: Reload requested from client PID 2020 ('.switch-to-conf') (unit backdoor.service)...1269machine # [ 50.568758] systemd[1]: Reloading...1270machine # [ 52.517886] systemd[1]: Reloading finished in 1944 ms.1271machine # [ 52.668352] systemd[603]: Reexecution requested from client PID 2089 ('switch-to-confi')...1272machine # [ 52.669809] systemd[603]: Reexecuting.1273machine # [ 52.743108] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1274machine # [ 52.959976] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1275machine # [ 52.967004] systemd[603]: Reload requested from client PID 2089 ('switch-to-confi')...1276machine # [ 52.969434] systemd[603]: Reloading...1277machine # [ 53.174389] systemd[603]: Reloading finished in 203 ms.1278machine # [ 53.188216] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1279machine # [ 53.198703] systemd[603]: Stopped Run user-specific NixOS activation.1280machine # [ 53.201354] systemd[603]: Stopping Run user-specific NixOS activation...1281machine # [ 53.204603] systemd[603]: Starting Run user-specific NixOS activation...1282machine # [ 53.257258] systemd[603]: Finished Run user-specific NixOS activation.1283machine # [ 53.261784] systemd[1]: Stopped target Reactivate sysinit units.1284machine # [ 53.263945] systemd[1]: Stopping Reactivate sysinit units...1285machine # [ 53.265709] systemd[1]: Reached target Reactivate sysinit units.1286machine # [ 53.268313] systemd[1]: test.service: Deactivated successfully.1287machine # [ 53.269209] systemd[1]: Stopped test.service.1288machine # [ 53.269861] systemd[1]: Stopping test.service...1289machine # [ 53.273738] systemd[1]: Starting test.service...1290machine # [ 53.317093] systemd[1]: Finished test.service.1291machine # [ 53.323070] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1292machine # [ 53.326384] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1293machine # [ 53.330954] systemd[1]: Reached target Local File Systems.1294machine # [ 53.334917] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1295machine # [ 53.339784] systemd[1]: Starting Create SUID/SGID Wrappers...1296machine # [ 53.342748] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1297machine # [ 53.345890] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671298machine # [ 53.356361] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1299machine # [ 53.358022] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1300machine # [ 53.359263] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1301machine # [ 53.361727] systemd[1]: Reached target Remote File Systems.1302machine # [ 53.734368] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1303machine # [ 53.739077] systemd[1]: Finished Create SUID/SGID Wrappers.1304machine # [ 53.742394] systemd[1]: Starting linger-users.service...1305machine # [ 53.810515] systemd[1]: linger-users.service: Deactivated successfully.1306machine # [ 53.813810] systemd[1]: Finished linger-users.service.1307machine # [ 54.071737] nixos[2020]: finished switching to system configuration /nix/store/21hfw8sh6q8izq23jfphrq020id5dlkc-nixos-system-machine-test1308machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 4.89 seconds)1309machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&11310machine # [ 54.758420] nixos[2162]: switching to system configuration /nix/store/ji4y94m7gmiwi658hkfd0fa8rd5dy4cp-nixos-system-machine-test1311machine # [ 54.761400] systemd[1]: Stopped target Local File Systems.1312machine # [ 54.763872] systemd[1]: Stopped target Remote File Systems.1313machine # [ 55.337396] systemd[1]: Reload requested from client PID 2162 ('.switch-to-conf') (unit backdoor.service)...1314machine # [ 55.339470] systemd[1]: Reloading...1315machine # [ 56.981462] systemd[1]: Reloading finished in 1639 ms.1316machine # [ 57.126193] systemd[603]: Reexecution requested from client PID 2231 ('switch-to-confi')...1317machine # [ 57.127631] systemd[603]: Reexecuting.1318machine # [ 57.190001] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1319machine # [ 57.379917] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1320machine # [ 57.386735] systemd[603]: Reload requested from client PID 2231 ('switch-to-confi')...1321machine # [ 57.388919] systemd[603]: Reloading...1322machine # [ 57.579704] systemd[603]: Reloading finished in 189 ms.1323machine # [ 57.592175] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1324machine # [ 57.601381] systemd[603]: Stopped Run user-specific NixOS activation.1325machine # [ 57.603902] systemd[603]: Stopping Run user-specific NixOS activation...1326machine # [ 57.606928] systemd[603]: Starting Run user-specific NixOS activation...1327machine # [ 57.654267] systemd[603]: Finished Run user-specific NixOS activation.1328machine # [ 57.658424] systemd[1]: Stopped target Reactivate sysinit units.1329machine # [ 57.662681] systemd[1]: Stopping Reactivate sysinit units...1330machine # [ 57.663909] systemd[1]: Reached target Reactivate sysinit units.1331machine # [ 57.666305] systemd[1]: Reloading test.service...1332machine # [ 57.707806] systemd[1]: Reloaded test.service.1333machine # [ 57.711772] systemd[1]: Reached target Remote File Systems.1334machine # [ 57.717440] systemd[1]: Reached target Local File Systems.1335machine # [ 57.719515] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1336machine # [ 57.724364] systemd[1]: Starting Create SUID/SGID Wrappers...1337machine # [ 57.725193] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1338machine # [ 57.726356] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671339machine # [ 57.738478] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1340machine # [ 57.741525] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1341machine # [ 57.742778] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1342machine # [ 57.745189] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1343machine # [ 57.746515] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1344machine # [ 58.065138] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1345machine # [ 58.068836] systemd[1]: Finished Create SUID/SGID Wrappers.1346machine # [ 58.072750] systemd[1]: Starting linger-users.service...1347machine # [ 58.139107] systemd[1]: linger-users.service: Deactivated successfully.1348machine # [ 58.141971] systemd[1]: Finished linger-users.service.1349machine # [ 58.402295] nixos[2162]: finished switching to system configuration /nix/store/ji4y94m7gmiwi658hkfd0fa8rd5dy4cp-nixos-system-machine-test1350machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 4.33 seconds)1351machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&11352machine # [ 59.038975] nixos[2304]: switching to system configuration /nix/store/nmllh5hhgdabn4zv8kb77g1f6fsmcmd1-nixos-system-machine-test1353machine # [ 59.042828] systemd[1]: Stopped target Local File Systems.1354machine # [ 59.044359] systemd[1]: Stopped target Remote File Systems.1355machine # [ 59.568126] systemd[1]: Reload requested from client PID 2304 ('.switch-to-conf') (unit backdoor.service)...1356machine # [ 59.570037] systemd[1]: Reloading...1357machine # [ 60.965857] systemd[1]: Reloading finished in 1393 ms.1358machine # [ 61.110234] systemd[603]: Reexecution requested from client PID 2373 ('switch-to-confi')...1359machine # [ 61.111698] systemd[603]: Reexecuting.1360machine # [ 61.178331] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1361machine # [ 61.382808] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1362machine # [ 61.389363] systemd[603]: Reload requested from client PID 2373 ('switch-to-confi')...1363machine # [ 61.391758] systemd[603]: Reloading...1364machine # [ 61.584544] systemd[603]: Reloading finished in 191 ms.1365machine # [ 61.601592] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1366machine # [ 61.610114] systemd[603]: Stopped Run user-specific NixOS activation.1367machine # [ 61.611179] systemd[603]: Stopping Run user-specific NixOS activation...1368machine # [ 61.614169] systemd[603]: Starting Run user-specific NixOS activation...1369machine # [ 61.662300] systemd[603]: Finished Run user-specific NixOS activation.1370machine # [ 61.666511] systemd[1]: Stopped target Reactivate sysinit units.1371machine # [ 61.668390] systemd[1]: Stopping Reactivate sysinit units...1372machine # [ 61.669937] systemd[1]: Reached target Reactivate sysinit units.1373machine # [ 61.671560] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1374machine # [ 61.674228] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1375machine # [ 61.677679] systemd[1]: Reached target Remote File Systems.1376machine # [ 61.682750] systemd[1]: Starting linger-users.service...1377machine # [ 61.687243] systemd[1]: Reached target Local File Systems.1378machine # [ 61.692574] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1379machine # [ 61.699378] systemd[1]: Starting Create SUID/SGID Wrappers...1380machine # [ 61.706157] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1381machine # [ 61.707302] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671382machine # [ 61.713904] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1383machine # [ 61.715591] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1384machine # [ 61.718480] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1385machine # [ 61.781328] systemd[1]: linger-users.service: Deactivated successfully.1386machine # [ 61.782366] systemd[1]: Finished linger-users.service.1387machine # [ 62.077945] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1388machine # [ 62.081641] systemd[1]: Finished Create SUID/SGID Wrappers.1389machine # [ 62.338741] nixos[2304]: finished switching to system configuration /nix/store/nmllh5hhgdabn4zv8kb77g1f6fsmcmd1-nixos-system-machine-test1390machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 3.94 seconds)1391machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&11392machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.79 seconds)1393machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/bin/switch-to-configuration test 2>&11394machine # [ 63.813452] nixos[2454]: switching to system configuration /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test1395machine # [ 63.817704] systemd[1]: Stopped target Local File Systems.1396machine # [ 63.819646] systemd[1]: Stopped target Remote File Systems.1397machine # [ 63.821334] systemd[1]: test.service: Deactivated successfully.1398machine # [ 63.822226] systemd[1]: Stopped test.service.1399machine # [ 64.336425] systemd[1]: Reload requested from client PID 2454 ('.switch-to-conf') (unit backdoor.service)...1400machine # [ 64.338427] systemd[1]: Reloading...1401machine # [ 65.017714] systemd[1]: Reloading finished in 676 ms.1402machine # [ 65.179281] systemd[603]: Reexecution requested from client PID 2523 ('switch-to-confi')...1403machine # [ 65.183087] systemd[603]: Reexecuting.1404machine # [ 65.250965] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1405machine # [ 65.472369] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1406machine # [ 65.479459] systemd[603]: Reload requested from client PID 2523 ('switch-to-confi')...1407machine # [ 65.482706] systemd[603]: Reloading...1408machine # [ 65.702244] systemd[603]: Reloading finished in 218 ms.1409machine # [ 65.716705] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1410machine # [ 65.730213] systemd[603]: Stopped Run user-specific NixOS activation.1411machine # [ 65.731287] systemd[603]: Stopping Run user-specific NixOS activation...1412machine # [ 65.734772] systemd[603]: Starting Run user-specific NixOS activation...1413machine # [ 65.786112] systemd[603]: Finished Run user-specific NixOS activation.1414machine # [ 65.790882] systemd[1]: Stopped target Reactivate sysinit units.1415machine # [ 65.792999] systemd[1]: Stopping Reactivate sysinit units...1416machine # [ 65.794502] systemd[1]: Reached target Reactivate sysinit units.1417machine # [ 65.797126] systemd[1]: Reached target Remote File Systems.1418machine # [ 65.804567] systemd[1]: Starting linger-users.service...1419machine # [ 65.817141] systemd[1]: Reached target Local File Systems.1420machine # [ 65.819249] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1421machine # [ 65.827339] systemd[1]: Starting Create SUID/SGID Wrappers...1422machine # [ 65.831738] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1423machine # [ 65.837596] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671424machine # [ 65.843205] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1425machine # [ 65.846271] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1426machine # [ 65.847677] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1427machine # [ 65.849087] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1428machine # [ 65.850563] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1429machine # [ 65.918534] systemd[1]: linger-users.service: Deactivated successfully.1430machine # [ 65.921738] systemd[1]: Finished linger-users.service.1431machine # [ 66.334830] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1432machine # [ 66.338530] systemd[1]: Finished Create SUID/SGID Wrappers.1433machine # [ 66.595650] nixos[2454]: finished switching to system configuration /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test1434machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.46 seconds)1435machine: must succeed: /nix/store/ic52wwm4qpvzays82bmmffyjfqs776cp-separate-activation-script/bin/switch-to-configuration test 2>&11436machine # [ 67.351654] nixos[2594]: switching to system configuration /nix/store/mfbbc6b0191xm8f53inyhbpl90k62v5n-nixos-system-machine-test1437machine # [ 67.354753] systemd[1]: Stopped target Remote File Systems.1438machine # [ 67.356188] systemd[1]: Stopped target Local File Systems.1439machine # [ 68.034819] systemd[1]: Reload requested from client PID 2594 ('.switch-to-conf') (unit backdoor.service)...1440machine # [ 68.037117] systemd[1]: Reloading...1441machine # [ 68.774010] systemd[1]: Reloading finished in 733 ms.1442machine # [ 68.965744] systemd[603]: Stopped Run user-specific NixOS activation.1443machine # [ 68.970125] systemd[603]: Reexecution requested from client PID 2663 ('switch-to-confi')...1444machine # [ 68.971720] systemd[603]: Reexecuting.1445machine # [ 69.043431] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1446machine # [ 69.269154] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1447machine # [ 69.276922] systemd[603]: Reload requested from client PID 2663 ('switch-to-confi')...1448machine # [ 69.279616] systemd[603]: Reloading...1449machine # [ 69.502703] systemd[603]: Reloading finished in 221 ms.1450machine # [ 69.520364] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1451machine # [ 69.532767] systemd[1]: Stopped target Reactivate sysinit units.1452machine # [ 69.536220] systemd[1]: Stopping Reactivate sysinit units...1453machine # [ 69.537197] systemd[1]: Reached target Reactivate sysinit units.1454machine # [ 69.538064] systemd[1]: Reached target Remote File Systems.1455machine # [ 69.546055] systemd[1]: Reached target Local File Systems.1456machine # [ 69.550382] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1457machine # [ 69.557599] systemd[1]: Starting Create SUID/SGID Wrappers...1458machine # [ 69.558621] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1459machine # [ 69.559905] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671460machine # [ 69.563199] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1461machine # [ 69.577169] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1462machine # [ 69.578679] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1463machine # [ 69.579930] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1464machine # [ 69.583436] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1465machine # [ 69.986935] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1466machine # [ 69.992472] systemd[1]: Finished Create SUID/SGID Wrappers.1467machine # [ 69.996508] systemd[1]: Starting linger-users.service...1468machine # [ 70.000896] systemd[1]: Starting test.service...1469machine # [ 70.049965] systemd[1]: Finished test.service.1470machine # [ 70.082670] systemd[1]: linger-users.service: Deactivated successfully.1471machine # [ 70.086023] systemd[1]: Finished linger-users.service.1472machine # [ 70.345019] nixos[2594]: finished switching to system configuration /nix/store/mfbbc6b0191xm8f53inyhbpl90k62v5n-nixos-system-machine-test1473machine: (finished: must succeed: /nix/store/ic52wwm4qpvzays82bmmffyjfqs776cp-separate-activation-script/bin/switch-to-configuration test 2>&1, in 3.75 seconds)1474machine: must succeed: ! test -e /run/current-system/activate1475machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.03 seconds)1476machine: must succeed: ! test -e /run/current-system/dry-activate1477machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.03 seconds)1478machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration1479machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.03 seconds)1480machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&11481machine # [ 71.225492] nixos[2742]: switching to system configuration /nix/store/v84r7qrvadh7bpvfzv48vxb3dyhrk03l-nixos-system-machine-test1482machine # [ 71.230130] systemd[1]: Stopped target Local File Systems.1483machine # [ 71.232996] systemd[1]: Stopped target Remote File Systems.1484machine # [ 71.234112] systemd[1]: test.service: Deactivated successfully.1485machine # [ 71.235483] systemd[1]: Stopped test.service.1486machine # [ 71.875774] systemd[1]: Reload requested from client PID 2742 ('.switch-to-conf') (unit backdoor.service)...1487machine # [ 71.877931] systemd[1]: Reloading...1488machine # [ 72.624922] systemd[1]: Reloading finished in 744 ms.1489machine # [ 72.779107] systemd[603]: Reexecution requested from client PID 2811 ('switch-to-confi')...1490machine # [ 72.781601] systemd[603]: Reexecuting.1491machine # [ 72.842939] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1492machine # [ 73.054824] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1493machine # [ 73.061723] systemd[603]: Reload requested from client PID 2811 ('switch-to-confi')...1494machine # [ 73.064395] systemd[603]: Reloading...1495machine # [ 73.261274] systemd[603]: Reloading finished in 195 ms.1496machine # [ 73.276237] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1497machine # [ 73.287669] systemd[603]: Starting Run user-specific NixOS activation...1498machine # [ 73.339088] systemd[603]: Finished Run user-specific NixOS activation.1499machine # [ 73.343846] systemd[603]: Stopped Run user-specific NixOS activation.1500machine # [ 73.345027] systemd[603]: Stopping Run user-specific NixOS activation...1501machine # [ 73.349210] systemd[603]: Starting Run user-specific NixOS activation...1502machine # [ 73.352364] systemd[1]: Stopped target Reactivate sysinit units.1503machine # [ 73.354862] systemd[1]: Stopping Reactivate sysinit units...1504machine # [ 73.361109] systemd[1]: Reached target Reactivate sysinit units.1505machine # [ 73.363060] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1506machine # [ 73.366067] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1507machine # [ 73.377359] systemd[1]: Started test.service.1508machine # [ 73.382187] systemd[1]: Reached target Local File Systems.1509machine # [ 73.391683] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1510machine # [ 73.403008] systemd[1]: Starting Create SUID/SGID Wrappers...1511machine # [ 73.410485] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1512machine # [ 73.417385] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671513machine # [ 73.426671] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1514machine # [ 73.437103] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1515machine # [ 73.442409] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1516machine # [ 73.443831] systemd[1]: Reached target Remote File Systems.1517machine # [ 73.451968] systemd[603]: Finished Run user-specific NixOS activation.1518machine # [ 73.477700] systemd[1]: test.service: Deactivated successfully.1519machine # [ 73.813057] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1520machine # [ 73.816722] systemd[1]: Finished Create SUID/SGID Wrappers.1521machine # [ 73.821463] systemd[1]: Starting linger-users.service...1522machine # [ 73.899113] systemd[1]: linger-users.service: Deactivated successfully.1523machine # [ 73.901362] systemd[1]: Finished linger-users.service.1524machine # [ 74.163043] nixos[2742]: finished switching to system configuration /nix/store/v84r7qrvadh7bpvfzv48vxb3dyhrk03l-nixos-system-machine-test1525machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 3.73 seconds)1526machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&11527machine # [ 74.856645] nixos[2887]: switching to system configuration /nix/store/xcmcsgvhpps7kavrw95lgf7q8bzalyk1-nixos-system-machine-test1528machine # [ 74.860327] systemd[1]: Stopped target Local File Systems.1529machine # [ 74.862405] systemd[1]: Stopped target Remote File Systems.1530machine # [ 75.446165] systemd[1]: Reload requested from client PID 2887 ('.switch-to-conf') (unit backdoor.service)...1531machine # [ 75.448286] systemd[1]: Reloading...1532machine # [ 76.145763] systemd[1]: Reloading finished in 695 ms.1533machine # [ 76.298812] systemd[603]: Reexecution requested from client PID 2956 ('switch-to-confi')...1534machine # [ 76.300998] systemd[603]: Reexecuting.1535machine # [ 76.370425] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1536machine # [ 76.572712] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1537machine # [ 76.579767] systemd[603]: Reload requested from client PID 2956 ('switch-to-confi')...1538machine # [ 76.583099] systemd[603]: Reloading...1539machine # [ 76.777262] systemd[603]: Reloading finished in 194 ms.1540machine # [ 76.793616] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1541machine # [ 76.801546] systemd[603]: Stopped Run user-specific NixOS activation.1542machine # [ 76.804002] systemd[603]: Stopping Run user-specific NixOS activation...1543machine # [ 76.807197] systemd[603]: Starting Run user-specific NixOS activation...1544machine # [ 76.854423] systemd[603]: Finished Run user-specific NixOS activation.1545machine # [ 76.858507] systemd[1]: Stopped target Reactivate sysinit units.1546machine # [ 76.861505] systemd[1]: Stopping Reactivate sysinit units...1547machine # [ 76.863019] systemd[1]: Reached target Reactivate sysinit units.1548machine # [ 76.863927] systemd[1]: Reached target Local File Systems.1549machine # [ 76.866629] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1550machine # [ 76.867947] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1551machine # [ 76.874297] systemd[1]: Reached target Remote File Systems.1552machine # [ 76.880344] systemd[1]: Starting escaped\x2ddash.service...1553machine # [ 76.883319] systemd[1]: Starting linger-users.service...1554machine # [ 76.896171] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1555machine # [ 76.904843] systemd[1]: Starting Create SUID/SGID Wrappers...1556machine # [ 76.906179] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1557machine # [ 76.907709] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671558machine # [ 76.910160] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1559machine # [ 76.917636] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1560machine # [ 76.919525] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1561machine # [ 76.954156] systemd[1]: Finished escaped\x2ddash.service.1562machine # [ 76.991019] systemd[1]: linger-users.service: Deactivated successfully.1563machine # [ 76.993640] systemd[1]: Finished linger-users.service.1564machine # [ 77.293718] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1565machine # [ 77.296924] systemd[1]: Finished Create SUID/SGID Wrappers.1566machine # [ 77.554080] nixos[2887]: finished switching to system configuration /nix/store/xcmcsgvhpps7kavrw95lgf7q8bzalyk1-nixos-system-machine-test1567machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 3.39 seconds)1568machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&11569machine # [ 78.210181] nixos[3029]: switching to system configuration /nix/store/54phmzckxhc22as6m32xb5ppy8mpyd1h-nixos-system-machine-test1570machine # [ 78.213864] systemd[1]: Stopped target Local File Systems.1571machine # [ 78.215657] systemd[1]: Stopped target Remote File Systems.1572machine # [ 78.217149] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1573machine # [ 78.218133] systemd[1]: Stopped escaped\x2ddash.service.1574machine # [ 78.731807] systemd[1]: Reload requested from client PID 3029 ('.switch-to-conf') (unit backdoor.service)...1575machine # [ 78.733889] systemd[1]: Reloading...1576machine # [ 79.365390] systemd[1]: Reloading finished in 628 ms.1577machine # [ 79.515319] systemd[603]: Reexecution requested from client PID 3098 ('switch-to-confi')...1578machine # [ 79.519040] systemd[603]: Reexecuting.1579machine # [ 79.574655] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1580machine # [ 79.766917] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1581machine # [ 79.773652] systemd[603]: Reload requested from client PID 3098 ('switch-to-confi')...1582machine # [ 79.776144] systemd[603]: Reloading...1583machine # [ 79.971489] systemd[603]: Reloading finished in 194 ms.1584machine # [ 79.984169] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1585machine # [ 79.994454] systemd[603]: Stopped Run user-specific NixOS activation.1586machine # [ 79.995537] systemd[603]: Stopping Run user-specific NixOS activation...1587machine # [ 79.998614] systemd[603]: Starting Run user-specific NixOS activation...1588machine # [ 80.048109] systemd[603]: Finished Run user-specific NixOS activation.1589machine # [ 80.052449] systemd[1]: Stopped target Reactivate sysinit units.1590machine # [ 80.055747] systemd[1]: Stopping Reactivate sysinit units...1591machine # [ 80.057611] systemd[1]: Reached target Reactivate sysinit units.1592machine # [ 80.060334] systemd[1]: Reached target Remote File Systems.1593machine # [ 80.065740] systemd[1]: Starting escaped\x2ddash.service...1594machine # [ 80.069016] systemd[1]: Starting linger-users.service...1595machine # [ 80.081240] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1596machine # [ 80.082668] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1597machine # [ 80.091679] systemd[1]: Reached target Local File Systems.1598machine # [ 80.092906] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1599machine # [ 80.100991] systemd[1]: Starting Create SUID/SGID Wrappers...1600machine # [ 80.101950] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1601machine # [ 80.103324] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671602machine # [ 80.110718] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1603machine # [ 80.112721] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1604machine # [ 80.114492] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1605machine # [ 80.149949] systemd[1]: Finished escaped\x2ddash.service.1606machine # [ 80.193818] systemd[1]: linger-users.service: Deactivated successfully.1607machine # [ 80.196706] systemd[1]: Finished linger-users.service.1608machine # [ 80.511984] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1609machine # [ 80.515769] systemd[1]: Finished Create SUID/SGID Wrappers.1610machine # [ 80.772860] nixos[3029]: finished switching to system configuration /nix/store/54phmzckxhc22as6m32xb5ppy8mpyd1h-nixos-system-machine-test1611machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 3.22 seconds)1612machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&11613machine # [ 81.431813] nixos[3171]: switching to system configuration /nix/store/jf8hnhyv37d4xsv6g3pijf0iy62cl8ak-nixos-system-machine-test1614machine # [ 81.435844] systemd[1]: Stopped target Local File Systems.1615machine # [ 81.437573] systemd[1]: Stopped target Remote File Systems.1616machine # [ 81.438425] systemd[1]: escaped\x2ddash.service: Deactivated successfully.1617machine # [ 81.439374] systemd[1]: Stopped escaped\x2ddash.service.1618machine # [ 81.953067] systemd[1]: Reload requested from client PID 3171 ('.switch-to-conf') (unit backdoor.service)...1619machine # [ 81.954995] systemd[1]: Reloading...1620machine # [ 82.619938] systemd[1]: Reloading finished in 662 ms.1621machine # [ 82.764843] systemd[603]: Reexecution requested from client PID 3240 ('switch-to-confi')...1622machine # [ 82.768586] systemd[603]: Reexecuting.1623machine # [ 82.829871] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1624machine # [ 83.022641] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1625machine # [ 83.030219] systemd[603]: Reload requested from client PID 3240 ('switch-to-confi')...1626machine # [ 83.032698] systemd[603]: Reloading...1627machine # [ 83.230041] systemd[603]: Reloading finished in 195 ms.1628machine # [ 83.244197] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1629machine # [ 83.253220] systemd[603]: Stopped Run user-specific NixOS activation.1630machine # [ 83.255809] systemd[603]: Stopping Run user-specific NixOS activation...1631machine # [ 83.258853] systemd[603]: Starting Run user-specific NixOS activation...1632machine # [ 83.305673] systemd[603]: Finished Run user-specific NixOS activation.1633machine # [ 83.309797] systemd[1]: Stopped target Reactivate sysinit units.1634machine # [ 83.313184] systemd[1]: Stopping Reactivate sysinit units...1635machine # [ 83.314049] systemd[1]: Reached target Reactivate sysinit units.1636machine # [ 83.314880] systemd[1]: Reached target Remote File Systems.1637machine # [ 83.318605] systemd[1]: Reached target Local File Systems.1638machine # [ 83.322213] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1639machine # [ 83.326503] systemd[1]: Starting Create SUID/SGID Wrappers...1640machine # [ 83.327411] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1641machine # [ 83.332387] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671642machine # [ 83.340372] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1643machine # [ 83.341953] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1644machine # [ 83.343164] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1645machine # [ 83.347952] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1646machine # [ 83.349675] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1647machine # [ 83.657203] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1648machine # [ 83.661716] systemd[1]: Finished Create SUID/SGID Wrappers.1649machine # [ 83.664313] systemd[1]: Starting -.service...1650machine # [ 83.668396] systemd[1]: Starting linger-users.service...1651machine # [ 83.711579] systemd[1]: Finished -.service.1652machine # [ 83.736987] systemd[1]: linger-users.service: Deactivated successfully.1653machine # [ 83.739386] systemd[1]: Finished linger-users.service.1654machine # [ 83.998314] nixos[3171]: finished switching to system configuration /nix/store/jf8hnhyv37d4xsv6g3pijf0iy62cl8ak-nixos-system-machine-test1655machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 3.23 seconds)1656machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&11657machine # [ 84.631032] nixos[3313]: switching to system configuration /nix/store/ypy2c8qpa44q68lbarp4knj20czy30k3-nixos-system-machine-test1658machine # [ 84.634180] systemd[1]: Stopped target Local File Systems.1659machine # [ 84.635560] systemd[1]: Stopped target Remote File Systems.1660machine # [ 85.153502] systemd[1]: Reload requested from client PID 3313 ('.switch-to-conf') (unit backdoor.service)...1661machine # [ 85.155454] systemd[1]: Reloading...1662machine # [ 85.782442] systemd[1]: Reloading finished in 624 ms.1663machine # [ 85.935761] systemd[603]: Reexecution requested from client PID 3382 ('switch-to-confi')...1664machine # [ 85.939881] systemd[603]: Reexecuting.1665machine # [ 86.006689] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1666machine # [ 86.206409] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1667machine # [ 86.213968] systemd[603]: Reload requested from client PID 3382 ('switch-to-confi')...1668machine # [ 86.216749] systemd[603]: Reloading...1669machine # [ 86.400069] systemd[603]: Reloading finished in 182 ms.1670machine # [ 86.416185] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1671machine # [ 86.425808] systemd[603]: Stopped Run user-specific NixOS activation.1672machine # [ 86.428141] systemd[603]: Stopping Run user-specific NixOS activation...1673machine # [ 86.431414] systemd[603]: Starting Run user-specific NixOS activation...1674machine # [ 86.480600] systemd[603]: Finished Run user-specific NixOS activation.1675machine # [ 86.485356] systemd[1]: Stopped target Reactivate sysinit units.1676machine # [ 86.489890] systemd[1]: Stopping Reactivate sysinit units...1677machine # [ 86.491164] systemd[1]: Reached target Reactivate sysinit units.1678machine # [ 86.493805] systemd[1]: Reloading -.service...1679machine # [ 86.533546] systemd[1]: Reloaded -.service.1680machine # [ 86.537397] systemd[1]: Reached target Local File Systems.1681machine # [ 86.542340] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1682machine # [ 86.550011] systemd[1]: Starting Create SUID/SGID Wrappers...1683machine # [ 86.551026] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1684machine # [ 86.557157] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671685machine # [ 86.562987] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1686machine # [ 86.568415] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1687machine # [ 86.569712] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1688machine # [ 86.570868] systemd[1]: Reached target Remote File Systems.1689machine # [ 86.571652] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1690machine # [ 86.574277] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1691machine # [ 86.901111] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1692machine # [ 86.905742] systemd[1]: Finished Create SUID/SGID Wrappers.1693machine # [ 86.908508] systemd[1]: Starting linger-users.service...1694machine # [ 86.967562] systemd[1]: linger-users.service: Deactivated successfully.1695machine # [ 86.969904] systemd[1]: Finished linger-users.service.1696machine # [ 87.227734] nixos[3313]: finished switching to system configuration /nix/store/ypy2c8qpa44q68lbarp4knj20czy30k3-nixos-system-machine-test1697machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 3.23 seconds)1698machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&11699machine # [ 87.861473] nixos[3455]: switching to system configuration /nix/store/80pg31aaqmvzfy003blm6b5b4mbq7n4s-nixos-system-machine-test1700machine # [ 87.865426] systemd[1]: Stopped target Local File Systems.1701machine # [ 87.867136] systemd[1]: Stopped target Remote File Systems.1702machine # [ 87.867991] systemd[1]: -.service: Deactivated successfully.1703machine # [ 87.869600] systemd[1]: Stopped -.service.1704machine # [ 88.367536] systemd[1]: Reload requested from client PID 3455 ('.switch-to-conf') (unit backdoor.service)...1705machine # [ 88.369619] systemd[1]: Reloading...1706machine # [ 89.013111] systemd[1]: Reloading finished in 641 ms.1707machine # [ 89.156429] systemd[603]: Reexecution requested from client PID 3523 ('switch-to-confi')...1708machine # [ 89.159910] systemd[603]: Reexecuting.1709machine # [ 89.222559] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1710machine # [ 89.413696] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1711machine # [ 89.420436] systemd[603]: Reload requested from client PID 3523 ('switch-to-confi')...1712machine # [ 89.422705] systemd[603]: Reloading...1713machine # [ 89.619965] systemd[603]: Reloading finished in 196 ms.1714machine # [ 89.636176] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1715machine # [ 89.645698] systemd[603]: Stopped Run user-specific NixOS activation.1716machine # [ 89.648066] systemd[603]: Stopping Run user-specific NixOS activation...1717machine # [ 89.650869] systemd[603]: Starting Run user-specific NixOS activation...1718machine # [ 89.698028] systemd[603]: Finished Run user-specific NixOS activation.1719machine # [ 89.702244] systemd[1]: Stopped target Reactivate sysinit units.1720machine # [ 89.704684] systemd[1]: Stopping Reactivate sysinit units...1721machine # [ 89.705575] systemd[1]: Reached target Reactivate sysinit units.1722machine # [ 89.706392] systemd[1]: Reached target Remote File Systems.1723machine # [ 89.709166] systemd[1]: Reached target Local File Systems.1724machine # [ 89.711689] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1725machine # [ 89.719248] systemd[1]: Starting Create SUID/SGID Wrappers...1726machine # [ 89.720577] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1727machine # [ 89.725224] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671728machine # [ 89.727387] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1729machine # [ 89.729832] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1730machine # [ 89.736349] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1731machine # [ 89.737552] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1732machine # [ 89.738770] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1733machine # [ 90.035027] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1734machine # [ 90.037351] systemd[1]: Finished Create SUID/SGID Wrappers.1735machine # [ 90.043164] systemd[1]: Starting linger-users.service...1736machine # [ 90.047051] systemd[1]: Starting required-service.service...1737machine # [ 90.050125] systemd[1]: Starting test-service.service...1738machine # [ 90.098081] systemd[1]: Finished test-service.service.1739machine # [ 90.103441] systemd[1]: Finished required-service.service.1740machine # [ 90.131579] systemd[1]: linger-users.service: Deactivated successfully.1741machine # [ 90.134426] systemd[1]: Finished linger-users.service.1742machine # [ 90.394002] nixos[3455]: finished switching to system configuration /nix/store/80pg31aaqmvzfy003blm6b5b4mbq7n4s-nixos-system-machine-test1743machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 3.16 seconds)1744machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&11745machine # [ 91.050470] nixos[3599]: switching to system configuration /nix/store/3gd7mnncw2zpczkn8sxl3br68zg81ks8-nixos-system-machine-test1746machine # [ 91.054592] systemd[1]: Stopped target Local File Systems.1747machine # [ 91.056720] systemd[1]: Stopped target Remote File Systems.1748machine # [ 91.057608] systemd[1]: required-service.service: Deactivated successfully.1749machine # [ 91.058535] systemd[1]: Stopped required-service.service.1750machine # [ 91.059283] systemd[1]: test-service.service: Deactivated successfully.1751machine # [ 91.061058] systemd[1]: Stopped test-service.service.1752machine # [ 91.600240] systemd[1]: Reload requested from client PID 3599 ('.switch-to-conf') (unit backdoor.service)...1753machine # [ 91.602313] systemd[1]: Reloading...1754machine # [ 92.299144] systemd[1]: Reloading finished in 693 ms.1755machine # [ 92.447559] systemd[603]: Reexecution requested from client PID 3668 ('switch-to-confi')...1756machine # [ 92.451312] systemd[603]: Reexecuting.1757machine # [ 92.514037] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1758machine # [ 92.707981] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1759machine # [ 92.714586] systemd[603]: Reload requested from client PID 3668 ('switch-to-confi')...1760machine # [ 92.717204] systemd[603]: Reloading...1761machine # [ 92.905585] systemd[603]: Reloading finished in 187 ms.1762machine # [ 92.920188] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1763machine # [ 92.931322] systemd[603]: Stopped Run user-specific NixOS activation.1764machine # [ 92.933960] systemd[603]: Stopping Run user-specific NixOS activation...1765machine # [ 92.937038] systemd[603]: Starting Run user-specific NixOS activation...1766machine # [ 92.989284] systemd[603]: Finished Run user-specific NixOS activation.1767machine # [ 92.993985] systemd[1]: Stopped target Reactivate sysinit units.1768machine # [ 92.996250] systemd[1]: Stopping Reactivate sysinit units...1769machine # [ 92.997162] systemd[1]: Reached target Reactivate sysinit units.1770machine # [ 93.002613] systemd[1]: Reached target Remote File Systems.1771machine # [ 93.009808] systemd[1]: Starting required-service.service...1772machine # [ 93.018359] systemd[1]: Reached target Local File Systems.1773machine # [ 93.019352] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1774machine # [ 93.027156] systemd[1]: Starting Create SUID/SGID Wrappers...1775machine # [ 93.030383] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1776machine # [ 93.031723] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671777machine # [ 93.044209] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1778machine # [ 93.045827] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1779machine # [ 93.047008] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1780machine # [ 93.051852] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1781machine # [ 93.053999] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1782machine # [ 93.080716] systemd[1]: Finished required-service.service.1783machine # [ 93.367800] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1784machine # [ 93.373033] systemd[1]: Finished Create SUID/SGID Wrappers.1785machine # [ 93.376310] systemd[1]: Starting linger-users.service...1786machine # [ 93.380562] systemd[1]: Starting test-service.service...1787machine # [ 93.427715] systemd[1]: Finished test-service.service.1788machine # [ 93.453152] systemd[1]: linger-users.service: Deactivated successfully.1789machine # [ 93.455708] systemd[1]: Finished linger-users.service.1790machine # [ 93.714870] nixos[3599]: finished switching to system configuration /nix/store/3gd7mnncw2zpczkn8sxl3br68zg81ks8-nixos-system-machine-test1791machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 3.32 seconds)1792machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&11793machine # [ 94.351844] nixos[3743]: switching to system configuration /nix/store/5hv4apzv6d1d0i2w9wccz3rr7jzijmzh-nixos-system-machine-test1794machine # [ 94.355816] systemd[1]: Stopped target Local File Systems.1795machine # [ 94.357818] systemd[1]: Stopped target Remote File Systems.1796machine # [ 94.358648] systemd[1]: required-service.service: Deactivated successfully.1797machine # [ 94.359615] systemd[1]: Stopped required-service.service.1798machine # [ 94.361315] systemd[1]: test-service.service: Deactivated successfully.1799machine # [ 94.362380] systemd[1]: Stopped test-service.service.1800machine # [ 94.880412] systemd[1]: Reload requested from client PID 3743 ('.switch-to-conf') (unit backdoor.service)...1801machine # [ 94.882325] systemd[1]: Reloading...1802machine # [ 95.540789] systemd[1]: Reloading finished in 656 ms.1803machine # [ 95.689817] systemd[603]: Reexecution requested from client PID 3812 ('switch-to-confi')...1804machine # [ 95.691240] systemd[603]: Reexecuting.1805machine # [ 95.754081] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1806machine # [ 95.950112] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1807machine # [ 95.956694] systemd[603]: Reload requested from client PID 3812 ('switch-to-confi')...1808machine # [ 95.958964] systemd[603]: Reloading...1809machine # [ 96.149211] systemd[603]: Reloading finished in 188 ms.1810machine # [ 96.164157] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1811machine # [ 96.174234] systemd[603]: Stopped Run user-specific NixOS activation.1812machine # [ 96.176631] systemd[603]: Stopping Run user-specific NixOS activation...1813machine # [ 96.179530] systemd[603]: Starting Run user-specific NixOS activation...1814machine # [ 96.224819] systemd[603]: Finished Run user-specific NixOS activation.1815machine # [ 96.229090] systemd[1]: Stopped target Reactivate sysinit units.1816machine # [ 96.232271] systemd[1]: Stopping Reactivate sysinit units...1817machine # [ 96.234919] systemd[1]: Reached target Reactivate sysinit units.1818machine # [ 96.235810] systemd[1]: Reached target Local File Systems.1819machine # [ 96.237720] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1820machine # [ 96.238987] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1821machine # [ 96.242734] systemd[1]: Reached target Remote File Systems.1822machine # [ 96.248196] systemd[1]: Starting linger-users.service...1823machine # [ 96.252195] systemd[1]: Starting required-service.service...1824machine # [ 96.255465] systemd[1]: Starting test-service.service...1825machine # [ 96.264332] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1826machine # [ 96.275518] systemd[1]: Starting Create SUID/SGID Wrappers...1827machine # [ 96.287170] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1828machine # [ 96.291437] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671829machine # [ 96.297056] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1830machine # [ 96.300651] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1831machine # [ 96.305597] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1832machine # [ 96.345539] systemd[1]: Finished required-service.service.1833machine # [ 96.349993] systemd[1]: Finished test-service.service.1834machine # [ 96.389566] systemd[1]: linger-users.service: Deactivated successfully.1835machine # [ 96.393386] systemd[1]: Finished linger-users.service.1836machine # [ 96.672952] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1837machine # [ 96.676902] systemd[1]: Finished Create SUID/SGID Wrappers.1838machine # [ 96.934891] nixos[3743]: finished switching to system configuration /nix/store/5hv4apzv6d1d0i2w9wccz3rr7jzijmzh-nixos-system-machine-test1839machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 3.22 seconds)1840machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&11841machine # [ 97.556512] nixos[3887]: switching to system configuration /nix/store/1lh7v1b2cdaxkjg9ksbk35h53lmkw0nf-nixos-system-machine-test1842machine # [ 97.559362] systemd[1]: Stopped target Local File Systems.1843machine # [ 97.562853] systemd[1]: required-service.service: Deactivated successfully.1844machine # [ 97.563847] systemd[1]: Stopped required-service.service.1845machine # [ 97.565694] systemd[1]: test-service.service: Deactivated successfully.1846machine # [ 97.566596] systemd[1]: Stopped test-service.service.1847machine # [ 97.567302] systemd[1]: Stopped target Remote File Systems.1848machine # [ 98.084656] systemd[1]: Reload requested from client PID 3887 ('.switch-to-conf') (unit backdoor.service)...1849machine # [ 98.086585] systemd[1]: Reloading...1850machine # [ 98.748233] systemd[1]: Reloading finished in 659 ms.1851machine # [ 98.892399] systemd[603]: Reexecution requested from client PID 3956 ('switch-to-confi')...1852machine # [ 98.893827] systemd[603]: Reexecuting.1853machine # [ 98.962514] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1854machine # [ 99.162767] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1855machine # [ 99.169530] systemd[603]: Reload requested from client PID 3956 ('switch-to-confi')...1856machine # [ 99.172098] systemd[603]: Reloading...1857machine # [ 99.362092] systemd[603]: Reloading finished in 189 ms.1858machine # [ 99.376152] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1859machine # [ 99.386108] systemd[603]: Stopped Run user-specific NixOS activation.1860machine # [ 99.387161] systemd[603]: Stopping Run user-specific NixOS activation...1861machine # [ 99.390008] systemd[603]: Starting Run user-specific NixOS activation...1862machine # [ 99.438292] systemd[603]: Finished Run user-specific NixOS activation.1863machine # [ 99.442453] systemd[1]: Stopped target Reactivate sysinit units.1864machine # [ 99.444585] systemd[1]: Stopping Reactivate sysinit units...1865machine # [ 99.445841] systemd[1]: Reached target Reactivate sysinit units.1866machine # [ 99.449797] systemd[1]: Created slice Slice /system/instantiated.1867machine # [ 99.452332] systemd[1]: Reached target Remote File Systems.1868machine # [ 99.456266] systemd[1]: Starting instantiated@one.service...1869machine # [ 99.460277] systemd[1]: Starting instantiated@two.service...1870machine # [ 99.465923] systemd[1]: Starting linger-users.service...1871machine # [ 99.486515] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1872machine # [ 99.487913] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1873machine # [ 99.491682] systemd[1]: Reached target Local File Systems.1874machine # [ 99.493662] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1875machine # [ 99.502538] systemd[1]: Starting Create SUID/SGID Wrappers...1876machine # [ 99.505391] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1877machine # [ 99.507542] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671878machine # [ 99.511452] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1879machine # [ 99.516537] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1880machine # [ 99.520503] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1881machine # [ 99.553723] systemd[1]: Finished instantiated@two.service.1882machine # [ 99.556846] systemd[1]: Finished instantiated@one.service.1883machine # [ 99.593653] systemd[1]: linger-users.service: Deactivated successfully.1884machine # [ 99.596661] systemd[1]: Finished linger-users.service.1885machine # [ 99.886422] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1886machine # [ 99.889918] systemd[1]: Finished Create SUID/SGID Wrappers.1887machine # [ 100.149009] nixos[3887]: finished switching to system configuration /nix/store/1lh7v1b2cdaxkjg9ksbk35h53lmkw0nf-nixos-system-machine-test1888machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 3.21 seconds)1889machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&11890machine # [ 100.839812] nixos[4031]: switching to system configuration /nix/store/m3kwbblaadkysx03z5pd2ngpsjc5x4hs-nixos-system-machine-test1891machine # [ 100.844524] systemd[1]: Stopped target Local File Systems.1892machine # [ 100.847706] systemd[1]: Stopped target Remote File Systems.1893machine # [ 100.849170] systemd[1]: instantiated@one.service: Deactivated successfully.1894machine # [ 100.850485] systemd[1]: Stopped instantiated@one.service.1895machine # [ 100.851544] systemd[1]: instantiated@two.service: Deactivated successfully.1896machine # [ 100.852958] systemd[1]: Stopped instantiated@two.service.1897machine # [ 101.399060] systemd[1]: Reload requested from client PID 4031 ('.switch-to-conf') (unit backdoor.service)...1898machine # [ 101.401349] systemd[1]: Reloading...1899machine # [ 102.100488] systemd[1]: Reloading finished in 696 ms.1900machine # [ 102.252721] systemd[603]: Reexecution requested from client PID 4100 ('switch-to-confi')...1901machine # [ 102.255694] systemd[603]: Reexecuting.1902machine # [ 102.318217] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1903machine # [ 102.513420] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1904machine # [ 102.520448] systemd[603]: Reload requested from client PID 4100 ('switch-to-confi')...1905machine # [ 102.522280] systemd[603]: Reloading...1906machine # [ 102.714973] systemd[603]: Reloading finished in 191 ms.1907machine # [ 102.728159] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1908machine # [ 102.738282] systemd[603]: Stopped Run user-specific NixOS activation.1909machine # [ 102.739299] systemd[603]: Stopping Run user-specific NixOS activation...1910machine # [ 102.742152] systemd[603]: Starting Run user-specific NixOS activation...1911machine # [ 102.790412] systemd[603]: Finished Run user-specific NixOS activation.1912machine # [ 102.794983] systemd[1]: Stopped target Reactivate sysinit units.1913machine # [ 102.796533] systemd[1]: Stopping Reactivate sysinit units...1914machine # [ 102.797413] systemd[1]: Reached target Reactivate sysinit units.1915machine # [ 102.799629] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1916machine # [ 102.802609] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1917machine # [ 102.805639] systemd[1]: Reached target Remote File Systems.1918machine # [ 102.811368] systemd[1]: Starting instantiated@one.service...1919machine # [ 102.815255] systemd[1]: Starting instantiated@two.service...1920machine # [ 102.819077] systemd[1]: Starting linger-users.service...1921machine # [ 102.833250] systemd[1]: Reached target Local File Systems.1922machine # [ 102.839994] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1923machine # [ 102.845703] systemd[1]: Starting Create SUID/SGID Wrappers...1924machine # [ 102.846603] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1925machine # [ 102.847849] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671926machine # [ 102.860612] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1927machine # [ 102.865154] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1928machine # [ 102.869771] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1929machine # [ 102.902232] systemd[1]: Finished instantiated@one.service.1930machine # [ 102.907945] systemd[1]: Finished instantiated@two.service.1931machine # [ 102.940454] systemd[1]: linger-users.service: Deactivated successfully.1932machine # [ 102.943627] systemd[1]: Finished linger-users.service.1933machine # [ 103.206047] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1934machine # [ 103.209150] systemd[1]: Finished Create SUID/SGID Wrappers.1935machine # [ 103.466962] nixos[4031]: finished switching to system configuration /nix/store/m3kwbblaadkysx03z5pd2ngpsjc5x4hs-nixos-system-machine-test1936machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 3.32 seconds)1937(finished: subtest: services, in 75.00 seconds)1938subtest: failing units1939machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&11940machine # [ 104.050203] nixos[4175]: switching to system configuration /nix/store/34wr58kgh4jvxi46ql47qackvp2l37vf-nixos-system-machine-test1941machine # [ 104.053653] systemd[1]: instantiated@one.service: Deactivated successfully.1942machine # [ 104.054688] systemd[1]: Stopped instantiated@one.service.1943machine # [ 104.056378] systemd[1]: instantiated@two.service: Deactivated successfully.1944machine # [ 104.058818] systemd[1]: Stopped instantiated@two.service.1945machine # [ 104.059654] systemd[1]: Stopped target Remote File Systems.1946machine # [ 104.061710] systemd[1]: Stopped target Local File Systems.1947machine # [ 104.509135] systemd[1]: Reload requested from client PID 4175 ('.switch-to-conf') (unit backdoor.service)...1948machine # [ 104.511128] systemd[1]: Reloading...1949machine # [ 105.099798] systemd[1]: Reloading finished in 586 ms.1950machine # [ 105.242652] systemd[603]: Reexecution requested from client PID 4244 ('switch-to-confi')...1951machine # [ 105.246434] systemd[603]: Reexecuting.1952machine # [ 105.310374] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1953machine # [ 105.505781] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1954machine # [ 105.512881] systemd[603]: Reload requested from client PID 4244 ('switch-to-confi')...1955machine # [ 105.515420] systemd[603]: Reloading...1956machine # [ 105.713771] systemd[603]: Reloading finished in 197 ms.1957machine # [ 105.728173] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1958machine # [ 105.738826] systemd[603]: Stopped Run user-specific NixOS activation.1959machine # [ 105.741506] systemd[603]: Stopping Run user-specific NixOS activation...1960machine # [ 105.744933] systemd[603]: Starting Run user-specific NixOS activation...1961machine # [ 105.794356] systemd[603]: Finished Run user-specific NixOS activation.1962machine # [ 105.798896] systemd[1]: Stopped target Reactivate sysinit units.1963machine # [ 105.801492] systemd[1]: Stopping Reactivate sysinit units...1964machine # [ 105.802402] systemd[1]: Reached target Reactivate sysinit units.1965machine # [ 105.805312] systemd[1]: Reached target Local File Systems.1966machine # [ 105.809184] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1967machine # [ 105.813695] systemd[1]: Starting Create SUID/SGID Wrappers...1968machine # [ 105.816460] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1969machine # [ 105.817667] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671970machine # [ 105.819830] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1971machine # [ 105.821771] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1972machine # [ 105.830535] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1973machine # [ 105.831769] systemd[1]: Reached target Remote File Systems.1974machine # [ 105.835355] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1975machine # [ 105.839225] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1976machine # [ 106.139892] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1977machine # [ 106.144571] systemd[1]: Finished Create SUID/SGID Wrappers.1978machine # [ 106.148478] systemd[1]: Starting linger-users.service...1979machine # [ 106.151573] systemd[1]: Starting test.service...1980machine # [ 106.197031] systemd[1]: Finished test.service.1981machine # [ 106.224847] systemd[1]: linger-users.service: Deactivated successfully.1982machine # [ 106.227122] systemd[1]: Finished linger-users.service.1983machine # [ 106.486370] nixos[4175]: finished switching to system configuration /nix/store/34wr58kgh4jvxi46ql47qackvp2l37vf-nixos-system-machine-test1984machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 3.02 seconds)1985machine: must fail: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&11986machine # [ 107.141265] nixos[4317]: switching to system configuration /nix/store/8bh94w6vlxfl8c720pvr4s3ngam70l4f-nixos-system-machine-test1987machine # [ 107.145903] systemd[1]: Stopped target Local File Systems.1988machine # [ 107.148867] systemd[1]: Stopped target Remote File Systems.1989machine # [ 107.149987] systemd[1]: test.service: Deactivated successfully.1990machine # [ 107.150931] systemd[1]: Stopped test.service.1991machine # [ 107.658149] systemd[1]: Reload requested from client PID 4317 ('.switch-to-conf') (unit backdoor.service)...1992machine # [ 107.660204] systemd[1]: Reloading...1993machine # [ 108.293291] systemd[1]: Reloading finished in 630 ms.1994machine # [ 108.437610] systemd[603]: Reexecution requested from client PID 4386 ('switch-to-confi')...1995machine # [ 108.441799] systemd[603]: Reexecuting.1996machine # [ 108.506048] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1997machine # [ 108.701066] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1998machine # [ 108.708470] systemd[603]: Reload requested from client PID 4386 ('switch-to-confi')...1999machine # [ 108.711013] systemd[603]: Reloading...2000machine # [ 108.902128] systemd[603]: Reloading finished in 190 ms.2001machine # [ 108.916165] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2002machine # [ 108.925572] systemd[603]: Stopped Run user-specific NixOS activation.2003machine # [ 108.927944] systemd[603]: Stopping Run user-specific NixOS activation...2004machine # [ 108.930620] systemd[603]: Starting Run user-specific NixOS activation...2005machine # [ 108.977207] systemd[603]: Finished Run user-specific NixOS activation.2006machine # [ 108.981196] systemd[1]: Stopped target Reactivate sysinit units.2007machine # [ 108.983626] systemd[1]: Stopping Reactivate sysinit units...2008machine # [ 108.985205] systemd[1]: Reached target Reactivate sysinit units.2009machine # [ 108.989585] systemd[1]: Reached target Local File Systems.2010machine # [ 108.992158] systemd[1]: Reached target Remote File Systems.2011machine # [ 108.999011] systemd[1]: Starting linger-users.service...2012machine # [ 109.001365] systemd[1]: Starting test.service...2013machine # [ 109.010510] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2014machine # [ 109.020549] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2015machine # [ 109.021885] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2016machine # [ 109.027221] systemd[1]: Starting Create SUID/SGID Wrappers...2017machine # [ 109.030160] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2018machine # [ 109.031602] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672019machine # [ 109.035864] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2020machine # [ 109.040443] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2021machine # [ 109.044786] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2022machine # [ 109.074347] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE2023machine # [ 109.075761] systemd[1]: test.service: Failed with result 'exit-code'.2024machine # [ 109.079507] systemd[1]: Failed to start test.service.2025machine # [ 109.112279] systemd[1]: linger-users.service: Deactivated successfully.2026machine # [ 109.115226] systemd[1]: Finished linger-users.service.2027machine # [ 109.393822] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2028machine # [ 109.397055] systemd[1]: Finished Create SUID/SGID Wrappers.2029machine # [ 109.710854] nixos[4317]: switching to system configuration /nix/store/8bh94w6vlxfl8c720pvr4s3ngam70l4f-nixos-system-machine-test failed (status 4)2030machine: (finished: must fail: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 3.22 seconds)2031machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12032machine # [ 110.332716] nixos[4460]: switching to system configuration /nix/store/scxwdiaxg8wl6zciq16ch5f1kprp9hx9-nixos-system-machine-test2033machine # [ 110.335471] systemd[1]: Stopped target Local File Systems.2034machine # [ 110.337204] systemd[1]: Stopped target Remote File Systems.2035machine # [ 110.843708] systemd[1]: Reload requested from client PID 4460 ('.switch-to-conf') (unit backdoor.service)...2036machine # [ 110.845829] systemd[1]: Reloading...2037machine # [ 111.522308] systemd[1]: Reloading finished in 674 ms.2038machine # [ 111.668429] systemd[603]: Reexecution requested from client PID 4529 ('switch-to-confi')...2039machine # [ 111.669822] systemd[603]: Reexecuting.2040machine # [ 111.734294] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2041machine # [ 111.937587] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2042machine # [ 111.943907] systemd[603]: Reload requested from client PID 4529 ('switch-to-confi')...2043machine # [ 111.946814] systemd[603]: Reloading...2044machine # [ 112.142270] systemd[603]: Reloading finished in 194 ms.2045machine # [ 112.156204] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2046machine # [ 112.165984] systemd[603]: Stopped Run user-specific NixOS activation.2047machine # [ 112.168854] systemd[603]: Stopping Run user-specific NixOS activation...2048machine # [ 112.171864] systemd[603]: Starting Run user-specific NixOS activation...2049machine # [ 112.220276] systemd[603]: Finished Run user-specific NixOS activation.2050machine # [ 112.224884] systemd[1]: Stopped target Reactivate sysinit units.2051machine # [ 112.227016] systemd[1]: Stopping Reactivate sysinit units...2052machine # [ 112.228932] systemd[1]: Reached target Reactivate sysinit units.2053machine # [ 112.233602] systemd[1]: Reached target Local File Systems.2054machine # [ 112.236803] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2055machine # [ 112.241768] systemd[1]: Starting Create SUID/SGID Wrappers...2056machine # [ 112.242669] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2057machine # [ 112.243950] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672058machine # [ 112.248655] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2059machine # [ 112.254486] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2060machine # [ 112.261491] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2061machine # [ 112.262732] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2062machine # [ 112.266615] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2063machine # [ 112.267938] systemd[1]: Reached target Remote File Systems.2064machine # [ 112.591653] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2065machine # [ 112.596219] systemd[1]: Finished Create SUID/SGID Wrappers.2066machine # [ 112.600493] systemd[1]: Started autorestart.service.2067machine # [ 112.604773] systemd[1]: Starting linger-users.service...2068machine # [ 112.649790] systemd[1]: autorestart.service: Deactivated successfully.2069machine # [ 112.679055] systemd[1]: linger-users.service: Deactivated successfully.2070machine # [ 112.681358] systemd[1]: Finished linger-users.service.2071machine # [ 112.942320] nixos[4460]: finished switching to system configuration /nix/store/scxwdiaxg8wl6zciq16ch5f1kprp9hx9-nixos-system-machine-test2072machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 3.23 seconds)2073machine # [ 113.038589] systemd[1]: Stopped autorestart.service.2074machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&12075machine # [ 113.619062] nixos[4607]: switching to system configuration /nix/store/scxwdiaxg8wl6zciq16ch5f1kprp9hx9-nixos-system-machine-test2076machine # [ 113.623005] systemd[1]: Stopped target Local File Systems.2077machine # [ 113.624147] systemd[1]: Stopped target Remote File Systems.2078machine # [ 114.101496] systemd[1]: Reload requested from client PID 4607 ('.switch-to-conf') (unit backdoor.service)...2079machine # [ 114.103581] systemd[1]: Reloading...2080machine # [ 114.718894] systemd[1]: Reloading finished in 612 ms.2081machine # [ 114.863430] systemd[603]: Reexecution requested from client PID 4676 ('switch-to-confi')...2082machine # [ 114.865730] systemd[603]: Reexecuting.2083machine # [ 114.917702] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2084machine # [ 115.109447] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2085machine # [ 115.116726] systemd[603]: Reload requested from client PID 4676 ('switch-to-confi')...2086machine # [ 115.119375] systemd[603]: Reloading...2087machine # [ 115.306309] systemd[603]: Reloading finished in 185 ms.2088machine # [ 115.320186] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2089machine # [ 115.329306] systemd[603]: Stopped Run user-specific NixOS activation.2090machine # [ 115.331684] systemd[603]: Stopping Run user-specific NixOS activation...2091machine # [ 115.334441] systemd[603]: Starting Run user-specific NixOS activation...2092machine # [ 115.381389] systemd[603]: Finished Run user-specific NixOS activation.2093machine # [ 115.385441] systemd[1]: Stopped target Reactivate sysinit units.2094machine # [ 115.388631] systemd[1]: Stopping Reactivate sysinit units...2095machine # [ 115.389491] systemd[1]: Reached target Reactivate sysinit units.2096machine # [ 115.390357] systemd[1]: Reached target Local File Systems.2097machine # [ 115.394859] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2098machine # [ 115.402327] systemd[1]: Starting Create SUID/SGID Wrappers...2099machine # [ 115.405002] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2100machine # [ 115.408781] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672101machine # [ 115.412463] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2102machine # [ 115.420401] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2103machine # [ 115.421708] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2104machine # [ 115.422867] systemd[1]: Reached target Remote File Systems.2105machine # [ 115.423665] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2106machine # [ 115.426239] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2107machine # [ 115.737402] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2108machine # [ 115.739507] systemd[1]: Finished Create SUID/SGID Wrappers.2109machine # [ 115.744582] systemd[1]: Started autorestart.service.2110machine # [ 115.749225] systemd[1]: Starting linger-users.service...2111machine # [ 115.794054] systemd[1]: autorestart.service: Deactivated successfully.2112machine # [ 115.820759] systemd[1]: linger-users.service: Deactivated successfully.2113machine # [ 115.823384] systemd[1]: Finished linger-users.service.2114machine # [ 116.084673] nixos[4607]: finished switching to system configuration /nix/store/scxwdiaxg8wl6zciq16ch5f1kprp9hx9-nixos-system-machine-test2115machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 3.05 seconds)2116machine # [ 116.170225] systemd[1]: Stopped autorestart.service.2117machine: must fail: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&12118machine # [ 116.785135] nixos[4754]: switching to system configuration /nix/store/r68wy6m6ibyl1qb75bp56wxfxzrnv0rx-nixos-system-machine-test2119machine # [ 116.787791] systemd[1]: Stopped target Local File Systems.2120machine # [ 116.790238] systemd[1]: Stopped target Remote File Systems.2121machine # [ 117.329070] systemd[1]: Reload requested from client PID 4754 ('.switch-to-conf') (unit backdoor.service)...2122machine # [ 117.331102] systemd[1]: Reloading...2123machine # [ 118.090241] systemd[1]: Reloading finished in 756 ms.2124machine # [ 118.240569] systemd[603]: Reexecution requested from client PID 4823 ('switch-to-confi')...2125machine # [ 118.242063] systemd[603]: Reexecuting.2126machine # [ 118.311325] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2127machine # [ 118.522589] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2128machine # [ 118.529410] systemd[603]: Reload requested from client PID 4823 ('switch-to-confi')...2129machine # [ 118.532357] systemd[603]: Reloading...2130machine # [ 118.735497] systemd[603]: Reloading finished in 202 ms.2131machine # [ 118.748189] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2132machine # [ 118.758575] systemd[603]: Stopped Run user-specific NixOS activation.2133machine # [ 118.761315] systemd[603]: Stopping Run user-specific NixOS activation...2134machine # [ 118.765116] systemd[603]: Starting Run user-specific NixOS activation...2135machine # [ 118.818806] systemd[603]: Finished Run user-specific NixOS activation.2136machine # [ 118.823342] systemd[1]: Stopped target Reactivate sysinit units.2137machine # [ 118.826210] systemd[1]: Stopping Reactivate sysinit units...2138machine # [ 118.827099] systemd[1]: Reached target Reactivate sysinit units.2139machine # [ 118.829702] systemd[1]: Reached target Local File Systems.2140machine # [ 118.833685] systemd[1]: Reached target Remote File Systems.2141machine # [ 118.840412] systemd[1]: Started autorestart.service.2142machine # [ 118.844460] systemd[1]: Starting linger-users.service...2143machine # [ 118.856178] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2144machine # [ 118.857588] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2145machine # [ 118.867026] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2146machine # [ 118.871626] systemd[1]: Starting Create SUID/SGID Wrappers...2147machine # [ 118.881625] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2148machine # [ 118.882916] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672149machine # [ 118.891596] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2150machine # [ 118.895911] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2151machine # [ 118.898171] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2152machine # [ 118.928235] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE2153machine # [ 118.929683] systemd[1]: autorestart.service: Failed with result 'exit-code'.2154machine # [ 118.969798] systemd[1]: linger-users.service: Deactivated successfully.2155machine # [ 118.973711] systemd[1]: Finished linger-users.service.2156machine # [ 119.277067] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2157machine # [ 119.280399] systemd[1]: Finished Create SUID/SGID Wrappers.2158machine # [ 119.586507] nixos[4754]: switching to system configuration /nix/store/r68wy6m6ibyl1qb75bp56wxfxzrnv0rx-nixos-system-machine-test failed (status 4)2159machine: (finished: must fail: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 3.41 seconds)2160(finished: subtest: failing units, in 16.11 seconds)2161subtest: unit file parser2162machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12163machine # [ 120.172487] nixos[4897]: switching to system configuration /nix/store/21hfw8sh6q8izq23jfphrq020id5dlkc-nixos-system-machine-test2164machine # [ 120.174993] systemd[1]: Stopped target Remote File Systems.2165machine # [ 120.178334] systemd[1]: Stopped target Local File Systems.2166machine # [ 120.179397] systemd[1]: Stopped autorestart.service.2167machine # [ 120.651801] systemd[1]: Reload requested from client PID 4897 ('.switch-to-conf') (unit backdoor.service)...2168machine # [ 120.654023] systemd[1]: Reloading...2169machine # [ 121.273027] systemd[1]: Reloading finished in 617 ms.2170machine # [ 121.428555] systemd[603]: Reexecution requested from client PID 4966 ('switch-to-confi')...2171machine # [ 121.429952] systemd[603]: Reexecuting.2172machine # [ 121.478270] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2173machine # [ 121.669608] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2174machine # [ 121.677137] systemd[603]: Reload requested from client PID 4966 ('switch-to-confi')...2175machine # [ 121.678507] systemd[603]: Reloading...2176machine # [ 121.863827] systemd[603]: Reloading finished in 183 ms.2177machine # [ 121.880164] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2178machine # [ 121.892091] systemd[603]: Stopped Run user-specific NixOS activation.2179machine # [ 121.893139] systemd[603]: Stopping Run user-specific NixOS activation...2180machine # [ 121.896517] systemd[603]: Starting Run user-specific NixOS activation...2181machine # [ 121.941317] systemd[603]: Finished Run user-specific NixOS activation.2182machine # [ 121.946951] systemd[1]: Stopped target Reactivate sysinit units.2183machine # [ 121.950600] systemd[1]: Stopping Reactivate sysinit units...2184machine # [ 121.952953] systemd[1]: Reached target Reactivate sysinit units.2185machine # [ 121.953836] systemd[1]: Reached target Remote File Systems.2186machine # [ 121.956964] systemd[1]: Reached target Local File Systems.2187machine # [ 121.960534] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2188machine # [ 121.965156] systemd[1]: Starting Create SUID/SGID Wrappers...2189machine # [ 121.966092] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2190machine # [ 121.967308] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672191machine # [ 121.971668] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2192machine # [ 121.983890] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2193machine # [ 121.985503] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2194machine # [ 121.986679] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2195machine # [ 121.987944] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2196machine # [ 122.297163] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2197machine # [ 122.302164] systemd[1]: Finished Create SUID/SGID Wrappers.2198machine # [ 122.306118] systemd[1]: Starting linger-users.service...2199machine # [ 122.309276] systemd[1]: Starting test.service...2200machine # [ 122.352860] systemd[1]: Finished test.service.2201machine # [ 122.382558] systemd[1]: linger-users.service: Deactivated successfully.2202machine # [ 122.384534] systemd[1]: Finished linger-users.service.2203machine # [ 122.644886] nixos[4897]: finished switching to system configuration /nix/store/21hfw8sh6q8izq23jfphrq020id5dlkc-nixos-system-machine-test2204machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.06 seconds)2205machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&12206machine # [ 123.282256] nixos[5039]: switching to system configuration /nix/store/xsn0z04ayhiar0cg6zbial6vcy5mpmfq-nixos-system-machine-test2207machine # [ 123.285568] systemd[1]: Stopped target Local File Systems.2208machine # [ 123.287028] systemd[1]: Stopped target Remote File Systems.2209machine # [ 123.802262] systemd[1]: Reload requested from client PID 5039 ('.switch-to-conf') (unit backdoor.service)...2210machine # [ 123.804299] systemd[1]: Reloading...2211machine # [ 124.448760] systemd[1]: Reloading finished in 642 ms.2212machine # [ 124.611655] systemd[603]: Reexecution requested from client PID 5107 ('switch-to-confi')...2213machine # [ 124.615474] systemd[603]: Reexecuting.2214machine # [ 124.669895] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2215machine # [ 124.870883] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2216machine # [ 124.877552] systemd[603]: Reload requested from client PID 5107 ('switch-to-confi')...2217machine # [ 124.880131] systemd[603]: Reloading...2218machine # [ 125.071153] systemd[603]: Reloading finished in 189 ms.2219machine # [ 125.089640] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2220machine # [ 125.097796] systemd[603]: Stopped Run user-specific NixOS activation.2221machine # [ 125.100246] systemd[603]: Stopping Run user-specific NixOS activation...2222machine # [ 125.103236] systemd[603]: Starting Run user-specific NixOS activation...2223machine # [ 125.149742] systemd[603]: Finished Run user-specific NixOS activation.2224machine # [ 125.153930] systemd[1]: Stopped target Reactivate sysinit units.2225machine # [ 125.155802] systemd[1]: Stopping Reactivate sysinit units...2226machine # [ 125.157450] systemd[1]: Reached target Reactivate sysinit units.2227machine # [ 125.160506] systemd[1]: test.service: Deactivated successfully.2228machine # [ 125.161450] systemd[1]: Stopped test.service.2229machine # [ 125.162079] systemd[1]: Stopping test.service...2230machine # [ 125.165204] systemd[1]: Starting test.service...2231machine # [ 125.204228] systemd[1]: Finished test.service.2232machine # [ 125.206721] systemd[1]: Reached target Remote File Systems.2233machine # [ 125.211701] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2234machine # [ 125.214377] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2235machine # [ 125.220479] systemd[1]: Starting linger-users.service...2236machine # [ 125.222889] systemd[1]: Reached target Local File Systems.2237machine # [ 125.231244] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2238machine # [ 125.238362] systemd[1]: Starting Create SUID/SGID Wrappers...2239machine # [ 125.244246] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2240machine # [ 125.245520] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672241machine # [ 125.247653] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2242machine # [ 125.251756] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2243machine # [ 125.254847] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2244machine # [ 125.316269] systemd[1]: linger-users.service: Deactivated successfully.2245machine # [ 125.319046] systemd[1]: Finished linger-users.service.2246machine # [ 125.588197] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2247machine # [ 125.591389] systemd[1]: Finished Create SUID/SGID Wrappers.2248machine # [ 125.851325] nixos[5039]: finished switching to system configuration /nix/store/xsn0z04ayhiar0cg6zbial6vcy5mpmfq-nixos-system-machine-test2249machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 3.21 seconds)2250machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&12251machine # [ 126.516330] nixos[5181]: switching to system configuration /nix/store/p27bhc8j4brvys48m2a3aglzryghb3ys-nixos-system-machine-test2252machine # [ 126.518608] systemd[1]: Stopped target Remote File Systems.2253machine # [ 126.520936] systemd[1]: Stopped target Local File Systems.2254machine # [ 127.033229] systemd[1]: Reload requested from client PID 5181 ('.switch-to-conf') (unit backdoor.service)...2255machine # [ 127.035289] systemd[1]: Reloading...2256machine # [ 127.686320] systemd[1]: Reloading finished in 648 ms.2257machine # [ 127.848467] systemd[603]: Reexecution requested from client PID 5250 ('switch-to-confi')...2258machine # [ 127.851722] systemd[603]: Reexecuting.2259machine # [ 127.918024] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2260machine # [ 128.124248] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2261machine # [ 128.131420] systemd[603]: Reload requested from client PID 5250 ('switch-to-confi')...2262machine # [ 128.134784] systemd[603]: Reloading...2263machine # [ 128.321943] systemd[603]: Reloading finished in 188 ms.2264machine # [ 128.336154] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2265machine # [ 128.346916] systemd[603]: Stopped Run user-specific NixOS activation.2266machine # [ 128.347968] systemd[603]: Stopping Run user-specific NixOS activation...2267machine # [ 128.351021] systemd[603]: Starting Run user-specific NixOS activation...2268machine # [ 128.397237] systemd[603]: Finished Run user-specific NixOS activation.2269machine # [ 128.401457] systemd[1]: Stopped target Reactivate sysinit units.2270machine # [ 128.403181] systemd[1]: Stopping Reactivate sysinit units...2271machine # [ 128.404761] systemd[1]: Reached target Reactivate sysinit units.2272machine # [ 128.407793] systemd[1]: test.service: Deactivated successfully.2273machine # [ 128.409113] systemd[1]: Stopped test.service.2274machine # [ 128.409923] systemd[1]: Stopping test.service...2275machine # [ 128.411791] systemd[1]: Starting test.service...2276machine # [ 128.446418] systemd[1]: Finished test.service.2277machine # [ 128.450476] systemd[1]: Reached target Remote File Systems.2278machine # [ 128.455218] systemd[1]: Starting linger-users.service...2279machine # [ 128.462135] systemd[1]: Reached target Local File Systems.2280machine # [ 128.467114] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2281machine # [ 128.468877] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2282machine # [ 128.473742] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2283machine # [ 128.478215] systemd[1]: Starting Create SUID/SGID Wrappers...2284machine # [ 128.479089] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2285machine # [ 128.484731] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672286machine # [ 128.488512] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2287machine # [ 128.492184] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2288machine # [ 128.495321] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2289machine # [ 128.551530] systemd[1]: linger-users.service: Deactivated successfully.2290machine # [ 128.554495] systemd[1]: Finished linger-users.service.2291machine # [ 128.818698] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2292machine # [ 128.821804] systemd[1]: Finished Create SUID/SGID Wrappers.2293machine # [ 129.078412] nixos[5181]: finished switching to system configuration /nix/store/p27bhc8j4brvys48m2a3aglzryghb3ys-nixos-system-machine-test2294machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 3.23 seconds)2295machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12296machine # [ 129.668386] nixos[5323]: switching to system configuration /nix/store/21hfw8sh6q8izq23jfphrq020id5dlkc-nixos-system-machine-test2297machine # [ 129.671098] systemd[1]: Stopped target Local File Systems.2298machine # [ 129.673127] systemd[1]: Stopped target Remote File Systems.2299machine # [ 130.130789] systemd[1]: Reload requested from client PID 5323 ('.switch-to-conf') (unit backdoor.service)...2300machine # [ 130.133073] systemd[1]: Reloading...2301machine # [ 130.743922] systemd[1]: Reloading finished in 608 ms.2302machine # [ 130.888399] systemd[603]: Reexecution requested from client PID 5392 ('switch-to-confi')...2303machine # [ 130.891545] systemd[603]: Reexecuting.2304machine # [ 130.954428] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2305machine # [ 131.148141] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2306machine # [ 131.154536] systemd[603]: Reload requested from client PID 5392 ('switch-to-confi')...2307machine # [ 131.156886] systemd[603]: Reloading...2308machine # [ 131.349803] systemd[603]: Reloading finished in 191 ms.2309machine # [ 131.364147] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2310machine # [ 131.374334] systemd[603]: Stopped Run user-specific NixOS activation.2311machine # [ 131.376718] systemd[603]: Stopping Run user-specific NixOS activation...2312machine # [ 131.379644] systemd[603]: Starting Run user-specific NixOS activation...2313machine # [ 131.426209] systemd[603]: Finished Run user-specific NixOS activation.2314machine # [ 131.430206] systemd[1]: Stopped target Reactivate sysinit units.2315machine # [ 131.432146] systemd[1]: Stopping Reactivate sysinit units...2316machine # [ 131.433418] systemd[1]: Reached target Reactivate sysinit units.2317machine # [ 131.436389] systemd[1]: test.service: Deactivated successfully.2318machine # [ 131.437315] systemd[1]: Stopped test.service.2319machine # [ 131.437967] systemd[1]: Stopping test.service...2320machine # [ 131.440865] systemd[1]: Starting test.service...2321machine # [ 131.478550] systemd[1]: Finished test.service.2322machine # [ 131.483235] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2323machine # [ 131.485361] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2324machine # [ 131.489685] systemd[1]: Reached target Remote File Systems.2325machine # [ 131.494229] systemd[1]: Starting linger-users.service...2326machine # [ 131.502627] systemd[1]: Reached target Local File Systems.2327machine # [ 131.503512] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2328machine # [ 131.510255] systemd[1]: Starting Create SUID/SGID Wrappers...2329machine # [ 131.514473] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2330machine # [ 131.515784] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672331machine # [ 131.525392] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2332machine # [ 131.527295] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2333machine # [ 131.529036] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2334machine # [ 131.588895] systemd[1]: linger-users.service: Deactivated successfully.2335machine # [ 131.591246] systemd[1]: Finished linger-users.service.2336machine # [ 131.869125] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2337machine # [ 131.872249] systemd[1]: Finished Create SUID/SGID Wrappers.2338machine # [ 132.129106] nixos[5323]: finished switching to system configuration /nix/store/21hfw8sh6q8izq23jfphrq020id5dlkc-nixos-system-machine-test2339machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.05 seconds)2340machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&12341machine # [ 132.781370] nixos[5465]: switching to system configuration /nix/store/z6jgzw49zw88agvnfkhljbjzy7lf0q89-nixos-system-machine-test2342machine # [ 132.785160] systemd[1]: Stopped target Local File Systems.2343machine # [ 132.786710] systemd[1]: Stopped target Remote File Systems.2344machine # [ 133.291399] systemd[1]: Reload requested from client PID 5465 ('.switch-to-conf') (unit backdoor.service)...2345machine # [ 133.293547] systemd[1]: Reloading...2346machine # [ 133.932381] systemd[1]: Reloading finished in 637 ms.2347machine # [ 134.096481] systemd[603]: Reexecution requested from client PID 5534 ('switch-to-confi')...2348machine # [ 134.097879] systemd[603]: Reexecuting.2349machine # [ 134.153650] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2350machine # [ 134.346809] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2351machine # [ 134.353116] systemd[603]: Reload requested from client PID 5534 ('switch-to-confi')...2352machine # [ 134.355329] systemd[603]: Reloading...2353machine # [ 134.539455] systemd[603]: Reloading finished in 182 ms.2354machine # [ 134.552142] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2355machine # [ 134.561556] systemd[603]: Stopped Run user-specific NixOS activation.2356machine # [ 134.563720] systemd[603]: Stopping Run user-specific NixOS activation...2357machine # [ 134.566491] systemd[603]: Starting Run user-specific NixOS activation...2358machine # [ 134.612705] systemd[603]: Finished Run user-specific NixOS activation.2359machine # [ 134.617008] systemd[1]: Stopped target Reactivate sysinit units.2360machine # [ 134.618850] systemd[1]: Stopping Reactivate sysinit units...2361machine # [ 134.620467] systemd[1]: Reached target Reactivate sysinit units.2362machine # [ 134.622037] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2363machine # [ 134.623375] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2364machine # [ 134.627012] systemd[1]: Reached target Local File Systems.2365machine # [ 134.631734] systemd[1]: Reached target Remote File Systems.2366machine # [ 134.636867] systemd[1]: Starting linger-users.service...2367machine # [ 134.640833] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2368machine # [ 134.644572] systemd[1]: Starting Create SUID/SGID Wrappers...2369machine # [ 134.649321] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2370machine # [ 134.659203] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672371machine # [ 134.661661] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2372machine # [ 134.663224] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2373machine # [ 134.664624] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2374machine # [ 134.727712] systemd[1]: linger-users.service: Deactivated successfully.2375machine # [ 134.730546] systemd[1]: Finished linger-users.service.2376machine # [ 134.992649] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2377machine # [ 134.995989] systemd[1]: Finished Create SUID/SGID Wrappers.2378machine # [ 135.252896] nixos[5465]: finished switching to system configuration /nix/store/z6jgzw49zw88agvnfkhljbjzy7lf0q89-nixos-system-machine-test2379machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 3.12 seconds)2380machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&12381machine # [ 135.871578] nixos[5605]: switching to system configuration /nix/store/27c6n9kvxyrqnssprif04y25llqxa5mh-nixos-system-machine-test2382machine # [ 135.875597] systemd[1]: Stopped target Local File Systems.2383machine # [ 135.876788] systemd[1]: Stopped target Remote File Systems.2384machine # [ 136.359213] systemd[1]: Reload requested from client PID 5605 ('.switch-to-conf') (unit backdoor.service)...2385machine # [ 136.361368] systemd[1]: Reloading...2386machine # [ 137.003422] systemd[1]: Reloading finished in 640 ms.2387machine # [ 137.147600] systemd[603]: Reexecution requested from client PID 5674 ('switch-to-confi')...2388machine # [ 137.151398] systemd[603]: Reexecuting.2389machine # [ 137.201311] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2390machine # [ 137.392629] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2391machine # [ 137.398940] systemd[603]: Reload requested from client PID 5674 ('switch-to-confi')...2392machine # [ 137.401472] systemd[603]: Reloading...2393machine # [ 137.584951] systemd[603]: Reloading finished in 182 ms.2394machine # [ 137.596175] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2395machine # [ 137.605785] systemd[603]: Stopped Run user-specific NixOS activation.2396machine # [ 137.608091] systemd[603]: Stopping Run user-specific NixOS activation...2397machine # [ 137.610911] systemd[603]: Starting Run user-specific NixOS activation...2398machine # [ 137.656219] systemd[603]: Finished Run user-specific NixOS activation.2399machine # [ 137.659974] systemd[1]: Stopped target Reactivate sysinit units.2400machine # [ 137.661106] systemd[1]: Stopping Reactivate sysinit units...2401machine # [ 137.662735] systemd[1]: Reached target Reactivate sysinit units.2402machine # [ 137.666397] systemd[1]: test.service: Deactivated successfully.2403machine # [ 137.667627] systemd[1]: Stopped test.service.2404machine # [ 137.668490] systemd[1]: Stopping test.service...2405machine # [ 137.670167] systemd[1]: Starting test.service...2406machine # [ 137.702559] systemd[1]: Finished test.service.2407machine # [ 137.705640] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2408machine # [ 137.710589] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2409machine # [ 137.712405] systemd[1]: Reached target Remote File Systems.2410machine # [ 137.714637] systemd[1]: Starting linger-users.service...2411machine # [ 137.725515] systemd[1]: Reached target Local File Systems.2412machine # [ 137.729897] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2413machine # [ 137.736483] systemd[1]: Starting Create SUID/SGID Wrappers...2414machine # [ 137.737346] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2415machine # [ 137.738542] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672416machine # [ 137.741460] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2417machine # [ 137.743602] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2418machine # [ 137.745613] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2419machine # [ 137.806303] systemd[1]: linger-users.service: Deactivated successfully.2420machine # [ 137.809094] systemd[1]: Finished linger-users.service.2421machine # [ 138.087666] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2422machine # [ 138.090968] systemd[1]: Finished Create SUID/SGID Wrappers.2423machine # [ 138.347602] nixos[5605]: finished switching to system configuration /nix/store/27c6n9kvxyrqnssprif04y25llqxa5mh-nixos-system-machine-test2424machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 3.09 seconds)2425machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&12426machine # [ 138.998751] nixos[5747]: switching to system configuration /nix/store/64ciqw9gp4w8v58cy3j35anc4q14icha-nixos-system-machine-test2427machine # [ 139.001898] systemd[1]: Stopped target Local File Systems.2428machine # [ 139.003271] systemd[1]: Stopped target Remote File Systems.2429machine # [ 139.507069] systemd[1]: Reload requested from client PID 5747 ('.switch-to-conf') (unit backdoor.service)...2430machine # [ 139.509369] systemd[1]: Reloading...2431machine # [ 140.177671] systemd[1]: Reloading finished in 666 ms.2432machine # [ 140.320425] systemd[603]: Reexecution requested from client PID 5816 ('switch-to-confi')...2433machine # [ 140.323980] systemd[603]: Reexecuting.2434machine # [ 140.376973] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2435machine # [ 140.565463] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2436machine # [ 140.571750] systemd[603]: Reload requested from client PID 5816 ('switch-to-confi')...2437machine # [ 140.574346] systemd[603]: Reloading...2438machine # [ 140.760154] systemd[603]: Reloading finished in 184 ms.2439machine # [ 140.776138] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2440machine # [ 140.785659] systemd[603]: Stopped Run user-specific NixOS activation.2441machine # [ 140.786639] systemd[603]: Stopping Run user-specific NixOS activation...2442machine # [ 140.789429] systemd[603]: Starting Run user-specific NixOS activation...2443machine # [ 140.835039] systemd[603]: Finished Run user-specific NixOS activation.2444machine # [ 140.838983] systemd[1]: Stopped target Reactivate sysinit units.2445machine # [ 140.840905] systemd[1]: Stopping Reactivate sysinit units...2446machine # [ 140.844465] systemd[1]: Reached target Reactivate sysinit units.2447machine # [ 140.845729] systemd[1]: test.service: Deactivated successfully.2448machine # [ 140.847718] systemd[1]: Stopped test.service.2449machine # [ 140.848626] systemd[1]: Stopping test.service...2450machine # [ 140.849555] systemd[1]: Starting test.service...2451machine # [ 140.881550] systemd[1]: Finished test.service.2452machine # [ 140.889362] systemd[1]: Reached target Local File Systems.2453machine # [ 140.892618] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2454machine # [ 140.896326] systemd[1]: Starting Create SUID/SGID Wrappers...2455machine # [ 140.897169] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2456machine # [ 140.898381] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672457machine # [ 140.910504] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2458machine # [ 140.912278] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2459machine # [ 140.913507] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2460machine # [ 140.914680] systemd[1]: Reached target Remote File Systems.2461machine # [ 140.915445] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2462machine # [ 140.916908] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2463machine # [ 141.214775] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2464machine # [ 141.219047] systemd[1]: Finished Create SUID/SGID Wrappers.2465machine # [ 141.221536] systemd[1]: Starting linger-users.service...2466machine # [ 141.276127] systemd[1]: linger-users.service: Deactivated successfully.2467machine # [ 141.278215] systemd[1]: Finished linger-users.service.2468machine # [ 141.535973] nixos[5747]: finished switching to system configuration /nix/store/64ciqw9gp4w8v58cy3j35anc4q14icha-nixos-system-machine-test2469machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 3.19 seconds)2470machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&12471machine # [ 142.164325] nixos[5889]: switching to system configuration /nix/store/h910rr5zrfivw69svy126ifi2yra626d-nixos-system-machine-test2472machine # [ 142.168297] systemd[1]: Stopped target Local File Systems.2473machine # [ 142.169388] systemd[1]: Stopped target Remote File Systems.2474machine # [ 142.668886] systemd[1]: Reload requested from client PID 5889 ('.switch-to-conf') (unit backdoor.service)...2475machine # [ 142.670883] systemd[1]: Reloading...2476machine # [ 143.346004] systemd[1]: Reloading finished in 671 ms.2477machine # [ 143.488079] systemd[603]: Reexecution requested from client PID 5958 ('switch-to-confi')...2478machine # [ 143.489469] systemd[603]: Reexecuting.2479machine # [ 143.554007] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2480machine # [ 143.753368] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2481machine # [ 143.759736] systemd[603]: Reload requested from client PID 5958 ('switch-to-confi')...2482machine # [ 143.762072] systemd[603]: Reloading...2483machine # [ 143.958234] systemd[603]: Reloading finished in 194 ms.2484machine # [ 143.977750] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2485machine # [ 143.987233] systemd[603]: Stopped Run user-specific NixOS activation.2486machine # [ 143.988307] systemd[603]: Stopping Run user-specific NixOS activation...2487machine # [ 143.991210] systemd[603]: Starting Run user-specific NixOS activation...2488machine # [ 144.037780] systemd[603]: Finished Run user-specific NixOS activation.2489machine # [ 144.041977] systemd[1]: Stopped target Reactivate sysinit units.2490machine # [ 144.044650] systemd[1]: Stopping Reactivate sysinit units...2491machine # [ 144.045515] systemd[1]: Reached target Reactivate sysinit units.2492machine # [ 144.049003] systemd[1]: test.service: Deactivated successfully.2493machine # [ 144.050342] systemd[1]: Stopped test.service.2494machine # [ 144.051129] systemd[1]: Stopping test.service...2495machine # [ 144.052875] systemd[1]: Starting test.service...2496machine # [ 144.087666] systemd[1]: Finished test.service.2497machine # [ 144.090120] systemd[1]: Reached target Remote File Systems.2498machine # [ 144.094676] systemd[1]: Reached target Local File Systems.2499machine # [ 144.098310] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2500machine # [ 144.103244] systemd[1]: Starting Create SUID/SGID Wrappers...2501machine # [ 144.107567] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2502machine # [ 144.113541] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672503machine # [ 144.115734] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2504machine # [ 144.124847] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2505machine # [ 144.126137] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2506machine # [ 144.127314] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2507machine # [ 144.128671] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2508machine # [ 144.468460] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2509machine # [ 144.471242] systemd[1]: Finished Create SUID/SGID Wrappers.2510machine # [ 144.477371] systemd[1]: Starting linger-users.service...2511machine # [ 144.550455] systemd[1]: linger-users.service: Deactivated successfully.2512machine # [ 144.553142] systemd[1]: Finished linger-users.service.2513machine # [ 144.819801] nixos[5889]: finished switching to system configuration /nix/store/h910rr5zrfivw69svy126ifi2yra626d-nixos-system-machine-test2514machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 3.29 seconds)2515machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&12516machine # [ 145.540749] nixos[6031]: switching to system configuration /nix/store/21hfw8sh6q8izq23jfphrq020id5dlkc-nixos-system-machine-test2517machine # [ 145.544275] systemd[1]: Stopped target Local File Systems.2518machine # [ 145.545657] systemd[1]: Stopped target Remote File Systems.2519machine # [ 145.986320] systemd[1]: Reload requested from client PID 6031 ('.switch-to-conf') (unit backdoor.service)...2520machine # [ 145.988335] systemd[1]: Reloading...2521machine # [ 146.581291] systemd[1]: Reloading finished in 590 ms.2522machine # [ 146.720115] systemd[603]: Reexecution requested from client PID 6100 ('switch-to-confi')...2523machine # [ 146.723742] systemd[603]: Reexecuting.2524machine # [ 146.773489] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2525machine # [ 146.957430] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2526machine # [ 146.964446] systemd[603]: Reload requested from client PID 6100 ('switch-to-confi')...2527machine # [ 146.966672] systemd[603]: Reloading...2528machine # [ 147.150388] systemd[603]: Reloading finished in 182 ms.2529machine # [ 147.168146] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2530machine # [ 147.177889] systemd[603]: Stopped Run user-specific NixOS activation.2531machine # [ 147.178858] systemd[603]: Stopping Run user-specific NixOS activation...2532machine # [ 147.181663] systemd[603]: Starting Run user-specific NixOS activation...2533machine # [ 147.228318] systemd[603]: Finished Run user-specific NixOS activation.2534machine # [ 147.232359] systemd[1]: Stopped target Reactivate sysinit units.2535machine # [ 147.233534] systemd[1]: Stopping Reactivate sysinit units...2536machine # [ 147.234360] systemd[1]: Reached target Reactivate sysinit units.2537machine # [ 147.236664] systemd[1]: test.service: Deactivated successfully.2538machine # [ 147.239511] systemd[1]: Stopped test.service.2539machine # [ 147.241780] systemd[1]: Stopping test.service...2540machine # [ 147.243398] systemd[1]: Starting test.service...2541machine # [ 147.277842] systemd[1]: Finished test.service.2542machine # [ 147.281467] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2543machine # [ 147.283845] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2544machine # [ 147.288295] systemd[1]: Reached target Remote File Systems.2545machine # [ 147.290387] systemd[1]: Starting linger-users.service...2546machine # [ 147.294612] systemd[1]: Reached target Local File Systems.2547machine # [ 147.295749] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2548machine # [ 147.307453] systemd[1]: Starting Create SUID/SGID Wrappers...2549machine # [ 147.308691] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2550machine # [ 147.309903] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672551machine # [ 147.315557] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2552machine # [ 147.318722] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2553machine # [ 147.322457] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2554machine # [ 147.379193] systemd[1]: linger-users.service: Deactivated successfully.2555machine # [ 147.380445] systemd[1]: Finished linger-users.service.2556machine # [ 147.634822] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2557machine # [ 147.638107] systemd[1]: Finished Create SUID/SGID Wrappers.2558machine # [ 147.894520] nixos[6031]: finished switching to system configuration /nix/store/21hfw8sh6q8izq23jfphrq020id5dlkc-nixos-system-machine-test2559machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.07 seconds)2560machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&12561machine # [ 148.509431] nixos[6173]: switching to system configuration /nix/store/826zbz71lq31009wzfm8s0arcb4wag2l-nixos-system-machine-test2562machine # [ 148.512980] systemd[1]: Stopped target Remote File Systems.2563machine # [ 148.513964] systemd[1]: Stopped target Local File Systems.2564machine # [ 149.006248] systemd[1]: Reload requested from client PID 6173 ('.switch-to-conf') (unit backdoor.service)...2565machine # [ 149.008226] systemd[1]: Reloading...2566machine # [ 149.633822] systemd[1]: Reloading finished in 622 ms.2567machine # [ 149.780180] systemd[603]: Reexecution requested from client PID 6242 ('switch-to-confi')...2568machine # [ 149.781551] systemd[603]: Reexecuting.2569machine # [ 149.833782] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2570machine # [ 150.025779] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2571machine # [ 150.033389] systemd[603]: Reload requested from client PID 6242 ('switch-to-confi')...2572machine # [ 150.036208] systemd[603]: Reloading...2573machine # [ 150.223178] systemd[603]: Reloading finished in 186 ms.2574machine # [ 150.236160] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2575machine # [ 150.245431] systemd[603]: Stopped Run user-specific NixOS activation.2576machine # [ 150.247853] systemd[603]: Stopping Run user-specific NixOS activation...2577machine # [ 150.250787] systemd[603]: Starting Run user-specific NixOS activation...2578machine # [ 150.296899] systemd[603]: Finished Run user-specific NixOS activation.2579machine # [ 150.301870] systemd[1]: Stopped target Reactivate sysinit units.2580machine # [ 150.303136] systemd[1]: Stopping Reactivate sysinit units...2581machine # [ 150.303960] systemd[1]: Reached target Reactivate sysinit units.2582machine # [ 150.310227] systemd[1]: Reloading test.service...2583machine # [ 150.346150] systemd[1]: Reloaded test.service.2584machine # [ 150.351078] systemd[1]: Reached target Local File Systems.2585machine # [ 150.353454] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2586machine # [ 150.355862] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2587machine # [ 150.359019] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2588machine # [ 150.366205] systemd[1]: Starting Create SUID/SGID Wrappers...2589machine # [ 150.369529] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2590machine # [ 150.372849] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672591machine # [ 150.380064] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2592machine # [ 150.381636] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2593machine # [ 150.382880] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2594machine # [ 150.385407] systemd[1]: Reached target Remote File Systems.2595machine # [ 150.690077] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2596machine # [ 150.694134] systemd[1]: Finished Create SUID/SGID Wrappers.2597machine # [ 150.696776] systemd[1]: Starting linger-users.service...2598machine # [ 150.753761] systemd[1]: linger-users.service: Deactivated successfully.2599machine # [ 150.756214] systemd[1]: Finished linger-users.service.2600machine # [ 151.012955] nixos[6173]: finished switching to system configuration /nix/store/826zbz71lq31009wzfm8s0arcb4wag2l-nixos-system-machine-test2601machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 3.12 seconds)2602machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&12603machine # [ 151.642995] nixos[6315]: switching to system configuration /nix/store/98884919pflwqn7dlsxpf19b5w90kjj8-nixos-system-machine-test2604machine # [ 151.645706] systemd[1]: Stopped target Local File Systems.2605machine # [ 151.647950] systemd[1]: Stopped target Remote File Systems.2606machine # [ 152.150450] systemd[1]: Reload requested from client PID 6315 ('.switch-to-conf') (unit backdoor.service)...2607machine # [ 152.152454] systemd[1]: Reloading...2608machine # [ 152.810200] systemd[1]: Reloading finished in 655 ms.2609machine # [ 152.960440] systemd[603]: Reexecution requested from client PID 6384 ('switch-to-confi')...2610machine # [ 152.963587] systemd[603]: Reexecuting.2611machine # [ 153.026026] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2612machine # [ 153.227807] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2613machine # [ 153.234474] systemd[603]: Reload requested from client PID 6384 ('switch-to-confi')...2614machine # [ 153.236864] systemd[603]: Reloading...2615machine # [ 153.428883] systemd[603]: Reloading finished in 190 ms.2616machine # [ 153.445622] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2617machine # [ 153.454451] systemd[603]: Stopped Run user-specific NixOS activation.2618machine # [ 153.456932] systemd[603]: Stopping Run user-specific NixOS activation...2619machine # [ 153.459841] systemd[603]: Starting Run user-specific NixOS activation...2620machine # [ 153.506672] systemd[603]: Finished Run user-specific NixOS activation.2621machine # [ 153.510916] systemd[1]: Stopped target Reactivate sysinit units.2622machine # [ 153.515062] systemd[1]: Stopping Reactivate sysinit units...2623machine # [ 153.515951] systemd[1]: Reached target Reactivate sysinit units.2624machine # [ 153.518994] systemd[1]: Reloading test.service...2625machine # [ 153.556112] systemd[1]: Reloaded test.service.2626machine # [ 153.559753] systemd[1]: Reached target Remote File Systems.2627machine # [ 153.565074] systemd[1]: Starting linger-users.service...2628machine # [ 153.567784] systemd[1]: Reached target Local File Systems.2629machine # [ 153.578716] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2630machine # [ 153.583857] systemd[1]: Starting Create SUID/SGID Wrappers...2631machine # [ 153.586276] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2632machine # [ 153.592958] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672633machine # [ 153.595265] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2634machine # [ 153.604883] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2635machine # [ 153.606395] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2636machine # [ 153.607967] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2637machine # [ 153.609477] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2638machine # [ 153.669709] systemd[1]: linger-users.service: Deactivated successfully.2639machine # [ 153.670791] systemd[1]: Finished linger-users.service.2640machine # [ 153.929071] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2641machine # [ 153.932571] systemd[1]: Finished Create SUID/SGID Wrappers.2642machine # [ 154.190885] nixos[6315]: finished switching to system configuration /nix/store/98884919pflwqn7dlsxpf19b5w90kjj8-nixos-system-machine-test2643machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 3.18 seconds)2644machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&12645machine # [ 154.835325] nixos[6457]: switching to system configuration /nix/store/p7snjck4m0bx3d23vpvfr483xz1vac15-nixos-system-machine-test2646machine # [ 154.837802] systemd[1]: Stopped target Remote File Systems.2647machine # [ 154.840197] systemd[1]: Stopped target Local File Systems.2648machine # [ 155.362413] systemd[1]: Reload requested from client PID 6457 ('.switch-to-conf') (unit backdoor.service)...2649machine # [ 155.364482] systemd[1]: Reloading...2650machine # [ 156.019558] systemd[1]: Reloading finished in 652 ms.2651machine # [ 156.161694] systemd[603]: Reexecution requested from client PID 6526 ('switch-to-confi')...2652machine # [ 156.163131] systemd[603]: Reexecuting.2653machine # [ 156.230410] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2654machine # [ 156.422350] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2655machine # [ 156.429455] systemd[603]: Reload requested from client PID 6526 ('switch-to-confi')...2656machine # [ 156.431311] systemd[603]: Reloading...2657machine # [ 156.629109] systemd[603]: Reloading finished in 196 ms.2658machine # [ 156.644172] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2659machine # [ 156.653971] systemd[603]: Stopped Run user-specific NixOS activation.2660machine # [ 156.656416] systemd[603]: Stopping Run user-specific NixOS activation...2661machine # [ 156.659504] systemd[603]: Starting Run user-specific NixOS activation...2662machine # [ 156.706792] systemd[603]: Finished Run user-specific NixOS activation.2663machine # [ 156.711256] systemd[1]: Stopped target Reactivate sysinit units.2664machine # [ 156.713408] systemd[1]: Stopping Reactivate sysinit units...2665machine # [ 156.714282] systemd[1]: Reached target Reactivate sysinit units.2666machine # [ 156.717920] systemd[1]: test.service: Deactivated successfully.2667machine # [ 156.718848] systemd[1]: Stopped test.service.2668machine # [ 156.719474] systemd[1]: Stopping test.service...2669machine # [ 156.721930] systemd[1]: Starting test.service...2670machine # [ 156.756719] systemd[1]: Finished test.service.2671machine # [ 156.760283] systemd[1]: Reached target Remote File Systems.2672machine # [ 156.767443] systemd[1]: Starting linger-users.service...2673machine # [ 156.770994] systemd[1]: Reached target Local File Systems.2674machine # [ 156.778077] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2675machine # [ 156.779434] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2676machine # [ 156.786339] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2677machine # [ 156.791524] systemd[1]: Starting Create SUID/SGID Wrappers...2678machine # [ 156.793478] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2679machine # [ 156.795113] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672680machine # [ 156.798127] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2681machine # [ 156.804312] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2682machine # [ 156.805754] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2683machine # [ 156.869106] systemd[1]: linger-users.service: Deactivated successfully.2684machine # [ 156.873037] systemd[1]: Finished linger-users.service.2685machine # [ 157.144753] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2686machine # [ 157.147955] systemd[1]: Finished Create SUID/SGID Wrappers.2687machine # [ 157.404884] nixos[6457]: finished switching to system configuration /nix/store/p7snjck4m0bx3d23vpvfr483xz1vac15-nixos-system-machine-test2688machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 3.22 seconds)2689machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&12690machine # [ 158.009894] nixos[6599]: switching to system configuration /nix/store/27c6n9kvxyrqnssprif04y25llqxa5mh-nixos-system-machine-test2691machine # [ 158.012840] systemd[1]: Stopped target Local File Systems.2692machine # [ 158.015146] systemd[1]: Stopped target Remote File Systems.2693machine # [ 158.474230] systemd[1]: Reload requested from client PID 6599 ('.switch-to-conf') (unit backdoor.service)...2694machine # [ 158.475982] systemd[1]: Reloading...2695machine # [ 159.080040] systemd[1]: Reloading finished in 601 ms.2696machine # [ 159.229497] systemd[603]: Reexecution requested from client PID 6668 ('switch-to-confi')...2697machine # [ 159.230930] systemd[603]: Reexecuting.2698machine # [ 159.285774] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2699machine # [ 159.476703] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2700machine # [ 159.483809] systemd[603]: Reload requested from client PID 6668 ('switch-to-confi')...2701machine # [ 159.487103] systemd[603]: Reloading...2702machine # [ 159.674424] systemd[603]: Reloading finished in 188 ms.2703machine # [ 159.688173] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2704machine # [ 159.696958] systemd[603]: Stopped Run user-specific NixOS activation.2705machine # [ 159.699199] systemd[603]: Stopping Run user-specific NixOS activation...2706machine # [ 159.701923] systemd[603]: Starting Run user-specific NixOS activation...2707machine # [ 159.744605] systemd[603]: Finished Run user-specific NixOS activation.2708machine # [ 159.748545] systemd[1]: Stopped target Reactivate sysinit units.2709machine # [ 159.750367] systemd[1]: Stopping Reactivate sysinit units...2710machine # [ 159.752001] systemd[1]: Reached target Reactivate sysinit units.2711machine # [ 159.755258] systemd[1]: Reached target Remote File Systems.2712machine # [ 159.757848] systemd[1]: Starting linger-users.service...2713machine # [ 159.761399] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2714machine # [ 159.764462] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2715machine # [ 159.773054] systemd[1]: Reached target Local File Systems.2716machine # [ 159.775036] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2717machine # [ 159.781443] systemd[1]: Starting Create SUID/SGID Wrappers...2718machine # [ 159.782351] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2719machine # [ 159.783571] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672720machine # [ 159.795775] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2721machine # [ 159.798324] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2722machine # [ 159.799843] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2723machine # [ 159.850558] systemd[1]: linger-users.service: Deactivated successfully.2724machine # [ 159.853794] systemd[1]: Finished linger-users.service.2725machine # [ 160.124204] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2726machine # [ 160.126831] systemd[1]: Finished Create SUID/SGID Wrappers.2727machine # [ 160.384968] nixos[6599]: finished switching to system configuration /nix/store/27c6n9kvxyrqnssprif04y25llqxa5mh-nixos-system-machine-test2728machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 2.98 seconds)2729(finished: subtest: unit file parser, in 40.80 seconds)2730subtest: restart and reload by activation script2731machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&12732machine # [ 160.971443] nixos[6739]: switching to system configuration /nix/store/nmllh5hhgdabn4zv8kb77g1f6fsmcmd1-nixos-system-machine-test2733machine # [ 160.974057] systemd[1]: Stopped target Local File Systems.2734machine # [ 160.976326] systemd[1]: Stopped target Remote File Systems.2735machine # [ 161.406225] systemd[1]: Reload requested from client PID 6739 ('.switch-to-conf') (unit backdoor.service)...2736machine # [ 161.408224] systemd[1]: Reloading...2737machine # [ 161.985442] systemd[1]: Reloading finished in 575 ms.2738machine # [ 162.123055] systemd[603]: Reexecution requested from client PID 6808 ('switch-to-confi')...2739machine # [ 162.126486] systemd[603]: Reexecuting.2740machine # [ 162.181324] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2741machine # [ 162.367578] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2742machine # [ 162.373978] systemd[603]: Reload requested from client PID 6808 ('switch-to-confi')...2743machine # [ 162.376203] systemd[603]: Reloading...2744machine # [ 162.556844] systemd[603]: Reloading finished in 179 ms.2745machine # [ 162.572139] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2746machine # [ 162.581602] systemd[603]: Stopped Run user-specific NixOS activation.2747machine # [ 162.583836] systemd[603]: Stopping Run user-specific NixOS activation...2748machine # [ 162.586579] systemd[603]: Starting Run user-specific NixOS activation...2749machine # [ 162.631116] systemd[603]: Finished Run user-specific NixOS activation.2750machine # [ 162.635480] systemd[1]: Stopped target Reactivate sysinit units.2751machine # [ 162.636770] systemd[1]: Stopping Reactivate sysinit units...2752machine # [ 162.637565] systemd[1]: Reached target Reactivate sysinit units.2753machine # [ 162.641156] systemd[1]: Reached target Local File Systems.2754machine # [ 162.644198] systemd[1]: Reached target Remote File Systems.2755machine # [ 162.646948] systemd[1]: Starting linger-users.service...2756machine # [ 162.655833] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2757machine # [ 162.665287] systemd[1]: Starting Create SUID/SGID Wrappers...2758machine # [ 162.666129] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2759machine # [ 162.667337] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672760machine # [ 162.679469] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2761machine # [ 162.681736] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2762machine # [ 162.683354] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2763machine # [ 162.684919] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2764machine # [ 162.686464] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2765machine # [ 162.739714] systemd[1]: linger-users.service: Deactivated successfully.2766machine # [ 162.743191] systemd[1]: Finished linger-users.service.2767machine # [ 162.999912] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2768machine # [ 163.002628] systemd[1]: Finished Create SUID/SGID Wrappers.2769machine # [ 163.260521] nixos[6739]: finished switching to system configuration /nix/store/nmllh5hhgdabn4zv8kb77g1f6fsmcmd1-nixos-system-machine-test2770machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 2.88 seconds)2771machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12772machine # [ 163.874896] nixos[6879]: switching to system configuration /nix/store/xy19yz4crjpmzf5awnc5qq7ma5q0aay2-nixos-system-machine-test2773machine # [ 163.877741] systemd[1]: test.service: Deactivated successfully.2774machine # [ 163.881066] systemd[1]: Stopped test.service.2775machine # [ 163.882001] systemd[1]: Stopped target Local File Systems.2776machine # [ 163.883126] systemd[1]: Stopped target Remote File Systems.2777machine # [ 164.379081] systemd[1]: Reload requested from client PID 6879 ('.switch-to-conf') (unit backdoor.service)...2778machine # [ 164.381298] systemd[1]: Reloading...2779machine # [ 165.038613] systemd[1]: Reloading finished in 655 ms.2780machine # [ 165.162936] systemd[603]: Reexecution requested from client PID 6950 ('switch-to-confi')...2781machine # [ 165.166431] systemd[603]: Reexecuting.2782machine # [ 165.229886] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2783machine # [ 165.418877] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2784machine # [ 165.425543] systemd[603]: Reload requested from client PID 6950 ('switch-to-confi')...2785machine # [ 165.428105] systemd[603]: Reloading...2786machine # [ 165.618407] systemd[603]: Reloading finished in 189 ms.2787machine # [ 165.632169] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2788machine # [ 165.643258] systemd[603]: Stopped Run user-specific NixOS activation.2789machine # [ 165.644411] systemd[603]: Stopping Run user-specific NixOS activation...2790machine # [ 165.647518] systemd[603]: Starting Run user-specific NixOS activation...2791machine # [ 165.695799] systemd[603]: Finished Run user-specific NixOS activation.2792machine # [ 165.700169] systemd[1]: Stopped target Reactivate sysinit units.2793machine # [ 165.702108] systemd[1]: Stopping Reactivate sysinit units...2794machine # [ 165.703125] systemd[1]: Reached target Reactivate sysinit units.2795machine # [ 165.712986] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as.2796machine # [ 165.717921] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2797machine # [ 165.721295] systemd[1]: Reached target Local File Systems.2798machine # [ 165.725292] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2799machine # [ 165.734344] systemd[1]: Starting Create SUID/SGID Wrappers...2800machine # [ 165.735277] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2801machine # [ 165.736579] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672802machine # [ 165.738704] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2803machine # [ 165.744199] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2804machine # [ 165.753335] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2805machine # [ 165.769794] systemd[1]: Created slice Slice /system/templated-reload-triggers.2806machine # [ 165.776808] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart.2807machine # [ 165.778046] systemd[1]: Created slice Slice /system/templated-simple-service.2808machine # [ 165.779040] systemd[1]: Reached target Remote File Systems.2809machine # [ 165.785060] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2810machine # [ 165.787761] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2811machine # [ 165.800492] systemd[1]: Created slice Slice /system/templated-no-restart-service.2812machine # [ 165.805259] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2813machine # [ 165.821640] systemd[1]: Created slice Slice /system/templated-simple-reload-service.2814machine # [ 165.848972] systemd[1]: Created slice Slice /system/templated-simple-restart-service.2815machine # [ 166.142113] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2816machine # [ 166.147158] systemd[1]: Finished Create SUID/SGID Wrappers.2817machine # [ 166.150617] systemd[1]: Starting linger-users.service...2818machine # [ 166.156228] systemd[1]: Starting no-restart-service.service...2819machine # [ 166.162280] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2820machine # [ 166.172487] systemd[1]: Starting reload-triggers-and-restart.service...2821machine # [ 166.180571] systemd[1]: Starting reload-triggers.service...2822machine # [ 166.187995] systemd[1]: Starting simple-reload-service.service...2823machine # [ 166.200736] systemd[1]: Starting simple-restart-service.service...2824machine # [ 166.210345] systemd[1]: Starting simple-service.service...2825machine # [ 166.221495] systemd[1]: Starting templated-no-restart-service@instance.service...2826machine # [ 166.239499] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2827machine # [ 166.256659] systemd[1]: Starting templated-reload-triggers@instance.service...2828machine # [ 166.257888] systemd[1]: Starting templated-simple-reload-service@instance.service...2829machine # [ 166.299648] systemd[1]: Starting templated-simple-restart-service@instance.service...2830machine # [ 166.317772] systemd[1]: Starting templated-simple-service@instance.service...2831machine # [ 166.363284] systemd[1]: Finished reload-triggers-and-restart.service.2832machine # [ 166.373344] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2833machine # [ 166.388949] systemd[1]: Finished no-restart-service.service.2834machine # [ 166.405786] systemd[1]: Finished simple-reload-service.service.2835machine # [ 166.406734] systemd[1]: Finished simple-restart-service.service.2836machine # [ 166.430988] systemd[1]: Finished reload-triggers.service.2837machine # [ 166.436798] systemd[1]: Finished simple-service.service.2838machine # [ 166.458797] systemd[1]: Finished templated-reload-triggers@instance.service.2839machine # [ 166.459882] systemd[1]: Finished templated-simple-restart-service@instance.service.2840machine # [ 166.466851] systemd[1]: Finished templated-simple-service@instance.service.2841machine # [ 166.469828] systemd[1]: Finished templated-no-restart-service@instance.service.2842machine # [ 166.470900] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2843machine # [ 166.474604] systemd[1]: Finished templated-simple-reload-service@instance.service.2844machine # [ 166.487618] systemd[1]: linger-users.service: Deactivated successfully.2845machine # [ 166.489968] systemd[1]: Finished linger-users.service.2846machine # [ 166.748926] nixos[6879]: finished switching to system configuration /nix/store/xy19yz4crjpmzf5awnc5qq7ma5q0aay2-nixos-system-machine-test2847machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.49 seconds)2848machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&12849machine # [ 167.447252] nixos[7049]: switching to system configuration /nix/store/xy19yz4crjpmzf5awnc5qq7ma5q0aay2-nixos-system-machine-test2850machine # [ 167.450684] systemd[1]: Stopped target Local File Systems.2851machine # [ 167.452088] systemd[1]: Stopped target Remote File Systems.2852machine # [ 167.934311] systemd[1]: Reload requested from client PID 7049 ('.switch-to-conf') (unit backdoor.service)...2853machine # [ 167.936257] systemd[1]: Reloading...2854machine # [ 168.542928] systemd[1]: Reloading finished in 604 ms.2855machine # [ 168.685995] systemd[603]: Reexecution requested from client PID 7119 ('switch-to-confi')...2856machine # [ 168.687387] systemd[603]: Reexecuting.2857machine # [ 168.737360] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2858machine # [ 168.920068] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2859machine # [ 168.926779] systemd[603]: Reload requested from client PID 7119 ('switch-to-confi')...2860machine # [ 168.929211] systemd[603]: Reloading...2861machine # [ 169.111430] systemd[603]: Reloading finished in 181 ms.2862machine # [ 169.128133] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2863machine # [ 169.137651] systemd[603]: Stopped Run user-specific NixOS activation.2864machine # [ 169.138612] systemd[603]: Stopping Run user-specific NixOS activation...2865machine # [ 169.141390] systemd[603]: Starting Run user-specific NixOS activation...2866machine # [ 169.186622] systemd[603]: Finished Run user-specific NixOS activation.2867machine # [ 169.190198] systemd[1]: Stopped target Reactivate sysinit units.2868machine # [ 169.192716] systemd[1]: Stopping Reactivate sysinit units...2869machine # [ 169.193520] systemd[1]: Reached target Reactivate sysinit units.2870machine # [ 169.200307] systemd[1]: Reloading reload-triggers-and-restart.service...2871machine # [ 169.203514] systemd[1]: Reloading reload-triggers.service...2872machine # [ 169.213058] systemd[1]: Reloading simple-reload-service.service...2873machine # [ 169.221919] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service...2874machine # [ 169.229446] systemd[1]: Reloading templated-reload-triggers@instance.service...2875machine # [ 169.240304] systemd[1]: Reloading templated-simple-reload-service@instance.service...2876machine # [ 169.296323] systemd[1]: Reloaded reload-triggers-and-restart.service.2877machine # [ 169.298634] systemd[1]: Reloaded reload-triggers.service.2878machine # [ 169.302459] systemd[1]: Reloaded simple-reload-service.service.2879machine # [ 169.303698] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service.2880machine # [ 169.309940] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2881machine # [ 169.314087] systemd[1]: Reloaded templated-reload-triggers@instance.service.2882machine # [ 169.317113] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2883machine # [ 169.320422] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2884machine # [ 169.321614] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2885machine # [ 169.323911] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2886machine # [ 169.327589] systemd[1]: simple-restart-service.service: Deactivated successfully.2887machine # [ 169.330390] systemd[1]: Stopped simple-restart-service.service.2888machine # [ 169.336426] systemd[1]: Stopping simple-restart-service.service...2889machine # [ 169.337593] systemd[1]: Starting simple-restart-service.service...2890machine # [ 169.346770] systemd[1]: simple-service.service: Deactivated successfully.2891machine # [ 169.350926] systemd[1]: Stopped simple-service.service.2892machine # [ 169.351705] systemd[1]: Stopping simple-service.service...2893machine # [ 169.352643] systemd[1]: Starting simple-service.service...2894machine # [ 169.353700] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2895machine # [ 169.363840] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2896machine # [ 169.376370] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2897machine # [ 169.383415] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2898machine # [ 169.387052] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2899machine # [ 169.397468] systemd[1]: Stopped templated-simple-restart-service@instance.service.2900machine # [ 169.406433] systemd[1]: Stopping templated-simple-restart-service@instance.service...2901machine # [ 169.413396] systemd[1]: Starting templated-simple-restart-service@instance.service...2902machine # [ 169.416701] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2903machine # [ 169.418334] systemd[1]: Stopped templated-simple-service@instance.service.2904machine # [ 169.420820] systemd[1]: Stopping templated-simple-service@instance.service...2905machine # [ 169.422621] systemd[1]: Starting templated-simple-service@instance.service...2906machine # [ 169.434746] systemd[1]: Finished simple-restart-service.service.2907machine # [ 169.440682] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2908machine # [ 169.443265] systemd[1]: Finished simple-service.service.2909machine # [ 169.449061] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2910machine # [ 169.457426] systemd[1]: Finished templated-simple-service@instance.service.2911machine # [ 169.461118] systemd[1]: Finished templated-simple-restart-service@instance.service.2912machine # [ 169.464717] systemd[1]: Reached target Remote File Systems.2913machine # [ 169.468929] systemd[1]: Starting linger-users.service...2914machine # [ 169.478089] systemd[1]: Reached target Local File Systems.2915machine # [ 169.481275] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2916machine # [ 169.484905] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2917machine # [ 169.487293] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2918machine # [ 169.494939] systemd[1]: Starting Create SUID/SGID Wrappers...2919machine # [ 169.495781] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2920machine # [ 169.498856] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672921machine # [ 169.502691] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2922machine # [ 169.507773] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2923machine # [ 169.509603] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2924machine # [ 169.557737] systemd[1]: linger-users.service: Deactivated successfully.2925machine # [ 169.560341] systemd[1]: Finished linger-users.service.2926machine # [ 169.830455] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2927machine # [ 169.833757] systemd[1]: Finished Create SUID/SGID Wrappers.2928machine # [ 170.091345] nixos[7049]: finished switching to system configuration /nix/store/xy19yz4crjpmzf5awnc5qq7ma5q0aay2-nixos-system-machine-test2929machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.34 seconds)2930machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&12931machine # [ 170.849208] nixos[7215]: switching to system configuration /nix/store/b7j6pqb5bps2ni12znipfqryiv7x4m80-nixos-system-machine-test2932machine # [ 170.852502] systemd[1]: Stopped target Local File Systems.2933machine # [ 170.853806] systemd[1]: Stopped target Remote File Systems.2934machine # [ 171.391993] systemd[1]: Reload requested from client PID 7215 ('.switch-to-conf') (unit backdoor.service)...2935machine # [ 171.393985] systemd[1]: Reloading...2936machine # [ 172.066132] systemd[1]: Reloading finished in 668 ms.2937machine # [ 172.211193] systemd[603]: Reexecution requested from client PID 7286 ('switch-to-confi')...2938machine # [ 172.214751] systemd[603]: Reexecuting.2939machine # [ 172.269461] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2940machine # [ 172.454365] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2941machine # [ 172.460686] systemd[603]: Reload requested from client PID 7286 ('switch-to-confi')...2942machine # [ 172.463124] systemd[603]: Reloading...2943machine # [ 172.644743] systemd[603]: Reloading finished in 180 ms.2944machine # [ 172.660133] systemd[603]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2945machine # [ 172.668942] systemd[603]: Stopped Run user-specific NixOS activation.2946machine # [ 172.671106] systemd[603]: Stopping Run user-specific NixOS activation...2947machine # [ 172.673718] systemd[603]: Starting Run user-specific NixOS activation...2948machine # [ 172.714440] systemd[603]: Finished Run user-specific NixOS activation.2949machine # [ 172.718146] systemd[1]: Stopped target Reactivate sysinit units.2950machine # [ 172.720567] systemd[1]: Stopping Reactivate sysinit units...2951machine # [ 172.721377] systemd[1]: Reached target Reactivate sysinit units.2952machine # [ 172.726438] systemd[1]: Reloading reload-triggers.service...2953machine # [ 172.731242] systemd[1]: Reloading simple-reload-service.service...2954machine # [ 172.741874] systemd[1]: Reloading templated-reload-triggers@instance.service...2955machine # [ 172.748823] systemd[1]: Reloading templated-simple-reload-service@instance.service...2956machine # [ 172.801568] systemd[1]: Reloaded templated-reload-triggers@instance.service.2957machine # [ 172.804799] systemd[1]: Reloaded simple-reload-service.service.2958machine # [ 172.807343] systemd[1]: Reloaded templated-simple-reload-service@instance.service.2959machine # [ 172.809388] systemd[1]: Reloaded reload-triggers.service.2960machine # [ 172.811863] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully.2961machine # [ 172.815148] systemd[1]: Stopped reload-triggers-and-restart-by-as.service.2962machine # [ 172.816691] systemd[1]: Stopping reload-triggers-and-restart-by-as.service...2963machine # [ 172.818869] systemd[1]: Starting reload-triggers-and-restart-by-as.service...2964machine # [ 172.822728] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully.2965machine # [ 172.824172] systemd[1]: Stopped reload-triggers-and-restart.service.2966machine # [ 172.830305] systemd[1]: Stopping reload-triggers-and-restart.service...2967machine # [ 172.836247] systemd[1]: Starting reload-triggers-and-restart.service...2968machine # [ 172.841546] systemd[1]: simple-restart-service.service: Deactivated successfully.2969machine # [ 172.846828] systemd[1]: Stopped simple-restart-service.service.2970machine # [ 172.854883] systemd[1]: Stopping simple-restart-service.service...2971machine # [ 172.855756] systemd[1]: Starting simple-restart-service.service...2972machine # [ 172.865415] systemd[1]: simple-service.service: Deactivated successfully.2973machine # [ 172.866481] systemd[1]: Stopped simple-service.service.2974machine # [ 172.867326] systemd[1]: Stopping simple-service.service...2975machine # [ 172.872691] systemd[1]: Starting simple-service.service...2976machine # [ 172.874077] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully.2977machine # [ 172.875998] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service.2978machine # [ 172.889313] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service...2979machine # [ 172.900775] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service...2980machine # [ 172.906742] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully.2981machine # [ 172.924237] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service.2982machine # [ 172.938329] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service...2983machine # [ 172.944571] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service...2984machine # [ 172.952437] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully.2985machine # [ 172.963787] systemd[1]: Stopped templated-simple-restart-service@instance.service.2986machine # [ 172.965215] systemd[1]: Stopping templated-simple-restart-service@instance.service...2987machine # [ 172.969522] systemd[1]: Starting templated-simple-restart-service@instance.service...2988machine # [ 172.979403] systemd[1]: templated-simple-service@instance.service: Deactivated successfully.2989machine # [ 172.981054] systemd[1]: Stopped templated-simple-service@instance.service.2990machine # [ 172.982148] systemd[1]: Stopping templated-simple-service@instance.service...2991machine # [ 172.983298] systemd[1]: Starting templated-simple-service@instance.service...2992machine # [ 172.984930] systemd[1]: Finished reload-triggers-and-restart.service.2993machine # [ 172.986023] systemd[1]: Finished reload-triggers-and-restart-by-as.service.2994machine # [ 172.987109] systemd[1]: Finished simple-restart-service.service.2995machine # [ 172.988098] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service.2996machine # [ 172.989427] systemd[1]: Finished simple-service.service.2997machine # [ 172.998529] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service.2998machine # [ 173.001753] systemd[1]: Finished templated-simple-restart-service@instance.service.2999machine # [ 173.002817] systemd[1]: Finished templated-simple-service@instance.service.3000machine # [ 173.005848] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os3001machine # [ 173.008842] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki3002machine # [ 173.011811] systemd[1]: Reached target Local File Systems.3003machine # [ 173.014694] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore3004machine # [ 173.021369] systemd[1]: Starting Create SUID/SGID Wrappers...3005machine # [ 173.022212] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.3006machine # [ 173.023405] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc673007machine # [ 173.035449] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore3008machine # [ 173.037309] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3009machine # [ 173.038508] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os3010machine # [ 173.039680] systemd[1]: Reached target Remote File Systems.3011machine # [ 173.340971] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.3012machine # [ 173.344305] systemd[1]: Finished Create SUID/SGID Wrappers.3013machine # [ 173.348280] systemd[1]: Starting linger-users.service...3014machine # [ 173.404747] systemd[1]: linger-users.service: Deactivated successfully.3015machine # [ 173.407135] systemd[1]: Finished linger-users.service.3016machine # [ 173.667313] nixos[7215]: finished switching to system configuration /nix/store/b7j6pqb5bps2ni12znipfqryiv7x4m80-nixos-system-machine-test3017machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 3.57 seconds)3018machine: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&13019machine: (finished: must succeed: /nix/store/05k3gqc39xkbhi8hd8g6j587i4y4r69j-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.89 seconds)3020(finished: subtest: restart and reload by activation script, in 14.17 seconds)3021(finished: run the VM test script, in 175.36 seconds)3022test script finished in 175.41s3023cleanup3024kill QemuMachine (pid 45)3025machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)3026(finished: cleanup, in 0.19 seconds)3027additionally exposed symbols:3028 machine, other,3029 vlan1,3030 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