vm-test-run-switch-test-basics
checks.x86_64-linux.switchTest-basics
· build #65
· raw
1tribuchet: building on jamie2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7machine: waiting for unit multi-user.target8machine: waiting for the VM to finish booting9machine: starting vm10machine: QEMU running (pid 45)11machine # Disk image does not exist, creating the virtualisation disk image...12machine # Formatting '/build/vm-state-machine/tmp.30wSvJz4Mb', 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: 0404c90c-0a96-4f20-b92a-06db565c32b417machine # Superblock backups stored on blocks:18machine # 32768, 98304, 163840, 22937619machine # 20machine # Allocating group tables: 0/8 done21machine # Writing inode tables: 0/8 done22machine # Creating journal (8192 blocks): done23machine # Writing superblocks and filesystem accounting information: 0/8 done24machine # 25machine # Virtualisation disk image created.26machine # Starting virtiofs daemons...27machine # [2026-10-23T03:09:12Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)28machine # [2026-10-23T03:09:12Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether29machine # [2026-10-23T03:09:12Z INFO virtiofsd] Waiting for vhost-user socket connection...30machine # [2026-10-23T03:09:12Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)31machine # [2026-10-23T03:09:12Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether32machine # [2026-10-23T03:09:12Z INFO virtiofsd] Waiting for vhost-user socket connection...33machine # [2026-10-23T03:09:12Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)34machine # [2026-10-23T03:09:12Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether35machine # [2026-10-23T03:09:12Z INFO virtiofsd] Waiting for vhost-user socket connection...36machine # [2026-10-23T03:09:12Z INFO virtiofsd] Client connected, servicing requests37machine # [2026-10-23T03:09:12Z INFO virtiofsd] Client connected, servicing requests38machine # [2026-10-23T03:09:12Z INFO virtiofsd] Client connected, servicing requests39machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)40machine # 41machine # 42machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0043machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)...44machine # 45machine # 46machine # 47machine # 48machine # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0049machine # Press Ctrl-B to configure iPXE (PCI 00:05.0)...50machine # 51machine # 52machine # Booting from ROM...53machine # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.57 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC @179205830054machine # [ 0.000000] Command line: console=ttyS0 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/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/init regInfo=/nix/.ro-store/k611hjin13jvy6fd7dab414bhr15ks9b-closure-info/registration console=ttyS0,115200n8 console=tty055machine # [ 0.000000] BIOS-provided physical RAM map:56machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable57machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved58machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved59machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable60machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved61machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved62machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved63machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved64machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved65machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved66machine # [ 0.000000] NX (Execute Disable) protection: active67machine # [ 0.000000] APIC: Static calls initialized68machine # [ 0.000000] SMBIOS 2.8 present.69machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/201470machine # [ 0.000000] DMI: Memory slots populated: 1/171machine # [ 0.000000] Hypervisor detected: KVM72machine # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000073machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d0074machine # [ 0.000000] kvm-clock: using sched offset of 469474829 cycles75machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns76machine # [ 0.000005] tsc: Detected 2400.008 MHz processor77machine # [ 0.000768] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000078machine # [ 0.000795] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs79machine # [ 0.000799] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT80machine # [ 0.002722] found SMP MP-table at [mem 0x000f5450-0x000f545f]81machine # [ 0.002733] Using GB pages for direct mapping82machine # [ 0.002820] RAMDISK: [mem 0x3e341000-0x3ffcffff]83machine # [ 0.002838] ACPI: Early table checksum verification disabled84machine # [ 0.002841] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )85machine # [ 0.002845] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)86machine # [ 0.002850] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)87machine # [ 0.002857] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)88machine # [ 0.002859] ACPI: FACS 0x000000003FFE0000 00004089machine # [ 0.002861] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)90machine # [ 0.002862] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)91machine # [ 0.002864] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)92machine # [ 0.002865] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)93machine # [ 0.002867] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]94machine # [ 0.002868] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]95machine # [ 0.002868] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]96machine # [ 0.002869] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]97machine # [ 0.002869] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]98machine # [ 0.002870] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]99machine # [ 0.002870] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]100machine # [ 0.003101] No NUMA configuration found101machine # [ 0.003102] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]102machine # [ 0.003105] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]103machine # [ 0.005701] Zone ranges:104machine # [ 0.005702] DMA [mem 0x0000000000001000-0x0000000000ffffff]105machine # [ 0.005704] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]106machine # [ 0.005705] Normal empty107machine # [ 0.005706] Device empty108machine # [ 0.005706] Movable zone start for each node109machine # [ 0.005707] Early memory node ranges110machine # [ 0.005708] node 0: [mem 0x0000000000001000-0x000000000009efff]111machine # [ 0.005709] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]112machine # [ 0.005710] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]113machine # [ 0.005730] On node 0, zone DMA: 1 pages in unavailable ranges114machine # [ 0.005995] On node 0, zone DMA: 97 pages in unavailable ranges115machine # [ 0.023934] On node 0, zone DMA32: 40 pages in unavailable ranges116machine # [ 0.024397] ACPI: PM-Timer IO Port: 0x608117machine # [ 0.024409] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])118machine # [ 0.024438] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23119machine # [ 0.024441] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)120machine # [ 0.024443] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)121machine # [ 0.024444] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)122machine # [ 0.024445] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)123machine # [ 0.024446] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)124machine # [ 0.024448] ACPI: Using ACPI (MADT) for SMP configuration information125machine # [ 0.024449] ACPI: HPET id: 0x8086a201 base: 0xfed00000126machine # [ 0.024452] TSC deadline timer available127machine # [ 0.024457] CPU topo: Max. logical packages: 1128machine # [ 0.024457] CPU topo: Max. logical dies: 1129machine # [ 0.024458] CPU topo: Max. dies per package: 1130machine # [ 0.024461] CPU topo: Max. threads per core: 1131machine # [ 0.024462] CPU topo: Num. cores per package: 1132machine # [ 0.024462] CPU topo: Num. threads per package: 1133machine # [ 0.024462] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs134machine # [ 0.024482] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()135machine # [ 0.024522] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]136machine # [ 0.024524] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]137machine # [ 0.024525] [mem 0x40000000-0xafffffff] available for PCI devices138machine # [ 0.024527] Booting paravirtualized kernel on KVM139machine # [ 0.024530] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns140machine # [ 0.029274] setup_percpu: NR_CPUS:512 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1141machine # [ 0.031507] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152142machine # [ 0.031552] kvm-guest: PV spinlocks disabled, single CPU143machine # [ 0.031554] Kernel command line: console=ttyS0 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/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/init regInfo=/nix/.ro-store/k611hjin13jvy6fd7dab414bhr15ks9b-closure-info/registration console=ttyS0,115200n8 console=tty0144machine # [ 0.031649] Unknown kernel command line parameters "regInfo=/nix/.ro-store/k611hjin13jvy6fd7dab414bhr15ks9b-closure-info/registration", will be passed to user space.145machine # [ 0.031662] random: crng init done146machine # [ 0.031663] printk: log buffer data + meta data: 1048576 + 3670016 = 4718592 bytes147machine # [ 0.032751] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)148machine # [ 0.032765] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)149machine # [ 0.032797] Fallback order for Node 0: 0150machine # [ 0.032800] Built 1 zonelists, mobility grouping on. Total pages: 262006151machine # [ 0.032801] Policy zone: DMA32152machine # [ 0.034975] mem auto-init: stack:all(zero), heap alloc:on, heap free:off153machine # [ 0.037523] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1154machine # [ 0.040080] allocated 2097152 bytes of page_ext155machine # [ 0.049968] ftrace: allocating 48987 entries in 192 pages156machine # [ 0.049970] ftrace: allocated 192 pages with 2 groups157machine # [ 0.050842] Dynamic Preempt: lazy158machine # [ 0.050968] rcu: Preemptible hierarchical RCU implementation.159machine # [ 0.050969] rcu: RCU event tracing is enabled.160machine # [ 0.050969] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1.161machine # [ 0.050971] Trampoline variant of Tasks RCU enabled.162machine # [ 0.050971] Rude variant of Tasks RCU enabled.163machine # [ 0.050972] Tracing variant of Tasks RCU enabled.164machine # [ 0.050972] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.165machine # [ 0.050973] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1166machine # [ 0.051023] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.167machine # [ 0.051024] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.168machine # [ 0.051025] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.169machine # [ 0.055347] NR_IRQS: 33024, nr_irqs: 256, preallocated irqs: 16170machine # [ 0.055644] rcu: srcu_init: Setting srcu_struct sizes based on contention.171machine # [ 0.055652] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns172machine # [ 0.055755] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)173machine # [ 0.059462] Console: colour VGA+ 80x25174machine # [ 0.059465] printk: legacy console [tty0] enabled175machine # [ 0.089873] printk: legacy console [ttyS0] enabled176machine # [ 0.196760] ACPI: Core revision 20250807177machine # [ 0.197734] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns178machine # [ 0.199273] APIC: Switch to symmetric I/O mode setup179machine # [ 0.200316] x2apic enabled180machine # [ 0.201098] APIC: Switched APIC routing to: physical x2apic181machine # [ 0.202958] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1182machine # [ 0.203936] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns183machine # [ 0.205588] Calibrating delay loop (skipped) preset value.. 4800.01 BogoMIPS (lpj=2400008)184machine # [ 0.206672] x86/cpu: User Mode Instruction Prevention (UMIP) activated185machine # [ 0.208840] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127186machine # [ 0.209598] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0187machine # [ 0.210583] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto188machine # [ 0.210587] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl189machine # [ 0.212585] Transient Scheduler Attacks: Vulnerable: No microcode190machine # [ 0.213555] Spectre V2 : Mitigation: Enhanced / Automatic IBRS191machine # [ 0.213583] Speculative Return Stack Overflow: Mitigation: Safe RET192machine # [ 0.214587] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization193machine # [ 0.216597] Spectre V2 : Enabling IBPB for BPF194machine # [ 0.218108] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier195machine # [ 0.218586] active return thunk: srso_alias_return_thunk196machine # [ 0.220239] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'197machine # [ 0.221482] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'198machine # [ 0.222326] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'199machine # [ 0.223321] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'200machine # [ 0.224366] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'201machine # [ 0.225348] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'202machine # [ 0.226378] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'203machine # [ 0.227585] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256204machine # [ 0.228584] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64205machine # [ 0.229584] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512206machine # [ 0.230584] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024207machine # [ 0.231585] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8208machine # [ 0.232514] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.209machine # [ 0.267613] Freeing SMP alternatives memory: 48K210machine # [ 0.268411] pid_max: default: 32768 minimum: 301211machine # [ 0.269334] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima212machine # [ 0.270647] landlock: Up and running.213machine # [ 0.271302] Yama: becoming mindful.214machine # [ 0.271811] LSM support for eBPF active215machine # [ 0.272678] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)216machine # [ 0.273624] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)217machine # [ 0.275710] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)218machine # [ 0.277185] Performance Events: Fam17h+ core perfctr, AMD PMU driver.219machine # [ 0.277593] ... version: 2220machine # [ 0.278453] ... bit width: 48221machine # [ 0.279173] ... generic counters: 6222machine # [ 0.279587] ... generic bitmap: 000000000000003f223machine # [ 0.280555] ... fixed-purpose counters: 0224machine # [ 0.281168] ... fixed-purpose bitmap: 0000000000000000225machine # [ 0.281587] ... value mask: 0000ffffffffffff226machine # [ 0.282532] ... max period: 00007fffffffffff227machine # [ 0.283321] ... global_ctrl mask: 000000000000003f228machine # [ 0.283702] signal: max sigframe size: 3376229machine # [ 0.284579] rcu: Hierarchical SRCU implementation.230machine # [ 0.285224] rcu: Max phase no-delay instances is 400.231machine # [ 0.290444] smp: Bringing up secondary CPUs ...232machine # [ 0.291208] smp: Brought up 1 node, 1 CPU233machine # [ 0.291589] smpboot: Total of 1 processors activated (4800.01 BogoMIPS)234machine # [ 0.292814] Memory: 934728K/1048024K available (18186K kernel code, 5431K rwdata, 13716K rodata, 6720K init, 3992K bss, 105908K reserved, 0K cma-reserved)235machine # [ 0.293870] devtmpfs: initialized236machine # [ 0.294794] x86/mm: Memory block size: 128MB237machine # [ 0.296527] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)238machine # [ 0.297553] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).239machine # [ 0.298677] pinctrl core: initialized pinctrl subsystem240machine # [ 0.299850] PM: RTC time: 03:09:12, date: 2026-10-23241machine # [ 0.303949] NET: Registered PF_NETLINK/PF_ROUTE protocol family242machine # [ 0.304979] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations243machine # [ 0.305606] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations244machine # [ 0.306753] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations245machine # [ 0.307598] audit: initializing netlink subsys (disabled)246machine # [ 0.308829] thermal_sys: Registered thermal governor 'fair_share'247machine # [ 0.308832] thermal_sys: Registered thermal governor 'bang_bang'248machine # [ 0.309588] thermal_sys: Registered thermal governor 'step_wise'249machine # [ 0.310592] audit: type=2000 audit(1792724952.801:1): state=initialized audit_enabled=0 res=1250machine # [ 0.312592] thermal_sys: Registered thermal governor 'user_space'251machine # [ 0.312594] thermal_sys: Registered thermal governor 'power_allocator'252machine # [ 0.313600] cpuidle: using governor menu253machine # [ 0.315871] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5254machine # [ 0.316830] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]255machine # [ 0.317590] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry256machine # [ 0.318600] PCI: Using configuration type 1 for base access257machine # [ 0.319763] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.258machine # [ 0.324717] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages259machine # [ 0.325588] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page260machine # [ 0.330589] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages261machine # [ 0.331587] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page262machine # [ 0.341979] ACPI: Added _OSI(Module Device)263machine # [ 0.342589] ACPI: Added _OSI(Processor Device)264machine # [ 0.343347] ACPI: Added _OSI(Processor Aggregator Device)265machine # [ 0.351931] ACPI: 1 ACPI AML tables successfully acquired and loaded266machine # [ 0.355992] ACPI: Interpreter enabled267machine # [ 0.356603] ACPI: PM: (supports S0 S3 S4 S5)268machine # [ 0.357329] ACPI: Using IOAPIC for interrupt routing269machine # [ 0.359624] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug270machine # [ 0.360588] PCI: Using E820 reservations for host bridge windows271machine # [ 0.363731] ACPI: Enabled 2 GPEs in block 00 to 3F272machine # [ 0.369965] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])273machine # [ 0.370593] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]274machine # [ 0.371666] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]275machine # [ 0.372710] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]276machine # [ 0.373924] PCI host bridge to bus 0000:00277machine # [ 0.374592] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]278machine # [ 0.375587] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]279machine # [ 0.376587] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]280machine # [ 0.377588] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]281machine # [ 0.378588] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]282machine # [ 0.379587] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]283machine # [ 0.380587] pci_bus 0000:00: root bus resource [bus 00-ff]284machine # [ 0.381616] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint285machine # [ 0.383101] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint286machine # [ 0.385647] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]287machine # [ 0.386643] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]288machine # [ 0.387609] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]289machine # [ 0.389147] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]290machine # [ 0.390385] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint291machine # [ 0.393597] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]292machine # [ 0.394506] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]293machine # [ 0.395374] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]294machine # [ 0.396492] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]295machine # [ 0.398164] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint296machine # [ 0.399596] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]297machine # [ 0.400514] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]298machine # [ 0.401385] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]299machine # [ 0.403078] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint300machine # [ 0.405627] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]301machine # [ 0.406559] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]302machine # [ 0.407404] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]303machine # [ 0.409096] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint304machine # [ 0.411629] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]305machine # [ 0.412525] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]306machine # [ 0.413612] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]307machine # [ 0.414594] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]308machine # [ 0.416134] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint309machine # [ 0.417600] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]310machine # [ 0.418610] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]311machine # [ 0.420170] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint312machine # [ 0.421617] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]313machine # [ 0.422609] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]314machine # [ 0.424211] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint315machine # [ 0.425601] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]316machine # [ 0.426609] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]317machine # [ 0.428158] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint318machine # [ 0.429600] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]319machine # [ 0.430609] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]320machine # [ 0.432147] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint321machine # [ 0.434631] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]322machine # [ 0.435529] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]323machine # [ 0.436394] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]324machine # [ 0.438063] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint325machine # [ 0.439595] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]326machine # [ 0.440454] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]327machine # [ 0.441384] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]328machine # [ 0.443099] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint329machine # [ 0.445003] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]330machine # [ 0.445793] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint331machine # [ 0.447285] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]332machine # [ 0.447786] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint333machine # [ 0.449192] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]334machine # [ 0.449808] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint335machine # [ 0.452211] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]336machine # [ 0.453668] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint337machine # [ 0.454897] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO338machine # [ 0.455868] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint339machine # [ 0.457610] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]340machine # [ 0.458509] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]341machine # [ 0.459696] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint342machine # [ 0.461264] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]343machine # [ 0.464675] ACPI: PCI: Interrupt link LNKA configured for IRQ 10344machine # [ 0.465706] ACPI: PCI: Interrupt link LNKB configured for IRQ 10345machine # [ 0.466684] ACPI: PCI: Interrupt link LNKC configured for IRQ 11346machine # [ 0.467687] ACPI: PCI: Interrupt link LNKD configured for IRQ 11347machine # [ 0.468689] ACPI: PCI: Interrupt link LNKE configured for IRQ 10348machine # [ 0.469684] ACPI: PCI: Interrupt link LNKF configured for IRQ 10349machine # [ 0.470701] ACPI: PCI: Interrupt link LNKG configured for IRQ 11350machine # [ 0.471686] ACPI: PCI: Interrupt link LNKH configured for IRQ 11351machine # [ 0.472633] ACPI: PCI: Interrupt link GSIA configured for IRQ 16352machine # [ 0.473602] ACPI: PCI: Interrupt link GSIB configured for IRQ 17353machine # [ 0.474602] ACPI: PCI: Interrupt link GSIC configured for IRQ 18354machine # [ 0.475602] ACPI: PCI: Interrupt link GSID configured for IRQ 19355machine # [ 0.476600] ACPI: PCI: Interrupt link GSIE configured for IRQ 20356machine # [ 0.477600] ACPI: PCI: Interrupt link GSIF configured for IRQ 21357machine # [ 0.478600] ACPI: PCI: Interrupt link GSIG configured for IRQ 22358machine # [ 0.479600] ACPI: PCI: Interrupt link GSIH configured for IRQ 23359machine # [ 0.481717] iommu: Default domain type: Translated360machine # [ 0.482572] iommu: DMA domain TLB invalidation policy: lazy mode361machine # [ 0.483709] ACPI: bus type USB registered362machine # [ 0.484491] usbcore: registered new interface driver usbfs363machine # [ 0.485337] usbcore: registered new interface driver hub364machine # [ 0.485599] usbcore: registered new device driver usb365machine # [ 0.487383] NetLabel: Initializing366machine # [ 0.488068] NetLabel: domain hash size = 128367machine # [ 0.488592] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO368machine # [ 0.489670] NetLabel: unlabeled traffic allowed by default369machine # [ 0.490604] PCI: Using ACPI for IRQ routing370machine # [ 0.535475] pci 0000:00:01.0: vgaarb: setting as boot VGA device371machine # [ 0.535583] pci 0000:00:01.0: vgaarb: bridge control possible372machine # [ 0.535583] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none373machine # [ 0.535592] vgaarb: loaded374machine # [ 0.536342] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0375machine # [ 0.536587] hpet0: 3 comparators, 64-bit 100.000000 MHz counter376machine # [ 0.540680] clocksource: Switched to clocksource kvm-clock377machine # [ 0.544345] VFS: Disk quotas dquot_6.6.0378machine # [ 0.545073] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)379machine # [ 0.546507] pnp: PnP ACPI init380machine # [ 0.547357] ACPI: IRQ 4 override to edge(!), high(!)381machine # [ 0.548384] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved382machine # [ 0.549975] pnp: PnP ACPI: found 5 devices383machine # [ 0.557633] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns384machine # [ 0.559216] clocksource: Switched to clocksource acpi_pm385machine # [ 0.560254] NET: Registered PF_INET protocol family386machine # [ 0.561353] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)387machine # [ 0.579110] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)388machine # [ 0.580711] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)389machine # [ 0.582127] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)390machine # [ 0.583492] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)391machine # [ 0.584707] TCP: Hash tables configured (established 8192 bind 8192)392machine # [ 0.586025] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)393machine # [ 0.587354] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)394machine # [ 0.588496] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)395machine # [ 0.589771] NET: Registered PF_UNIX/PF_LOCAL protocol family396machine # [ 0.590797] NET: Registered PF_XDP protocol family397machine # [ 0.591672] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]398machine # [ 0.592758] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]399machine # [ 0.593862] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]400machine # [ 0.595053] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]401machine # [ 0.596205] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]402machine # [ 0.597361] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]403machine # [ 0.599254] ACPI: \_SB_.GSIA: Enabled at IRQ 16404machine # [ 0.601576] ACPI: \_SB_.GSIB: Enabled at IRQ 17405machine # [ 0.603799] ACPI: \_SB_.GSIC: Enabled at IRQ 18406machine # [ 0.605873] ACPI: \_SB_.GSID: Enabled at IRQ 19407machine # [ 0.607632] PCI: CLS 0 bytes, default 64408machine # [ 0.608576] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns409machine # [ 0.610384] Trying to unpack rootfs image as initramfs...410machine # [ 0.658408] Initialise system trusted keyrings411machine # [ 0.659318] Key type blacklist registered412machine # [ 0.662139] workingset: timestamp_bits=40 max_order=18 bucket_order=0413machine # [ 0.666252] integrity: Platform Keyring initialized414machine # [ 0.667168] integrity: Machine keyring initialized415machine # [ 0.687620] Key type asymmetric registered416machine # [ 0.689975] Asymmetric key parser 'x509' registered417machine # [ 0.690886] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)418machine # [ 0.694067] io scheduler mq-deadline registered419machine # [ 0.694864] io scheduler kyber registered420machine # [ 0.698640] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled421machine # [ 0.701975] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A422machine # [ 0.705607] Linux agpgart interface v0.103423machine # [ 0.706419] ACPI: bus type drm_connector registered424machine # [ 0.709376] usbcore: registered new interface driver usbserial_generic425machine # [ 0.710518] usbserial: USB Serial support registered for generic426machine # [ 0.713975] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.427machine # [ 0.713975] Please enable it if your BIOS has the CPPC option.428machine # [ 0.716312] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled429machine # [ 0.721125] drop_monitor: Initializing network drop monitor service430machine # [ 0.722356] NET: Registered PF_INET6 protocol family431machine # [ 0.725406] Segment Routing with IPv6432machine # [ 0.727979] In-situ OAM (IOAM) with IPv6433machine # [ 0.729086] IPI shorthand broadcast: enabled434machine # [ 0.737509] sched_clock: Marking stable (592020371, 144932478)->(813496959, -76544110)435machine # [ 0.743141] registered taskstats version 1436machine # [ 0.744174] Loading compiled-in X.509 certificates437machine # [ 0.763009] Demotion targets for Node 0: null438machine # [ 0.763925] Key type .fscrypt registered439machine # [ 0.766959] Key type fscrypt-provisioning registered440machine # [ 0.767978] ima: No TPM chip found, activating TPM-bypass!441machine # [ 0.768915] ima: Allocated hash algorithm: sha1442machine # [ 0.770993] ima: No architecture policies found443machine # [ 0.772972] PM: Magic number: 14:684:159444machine # [ 0.777016] RAS: Correctable Errors collector initialized.445machine # [ 0.786032] clk: Disabling unused clocks446machine # [ 0.786756] PM: genpd: Disabling unused power domains447machine # [ 0.966220] Freeing initrd memory: 29244K448machine # [ 0.969709] Freeing unused decrypted memory: 2028K449machine # [ 0.974404] Freeing unused kernel image (initmem) memory: 6720K450machine # [ 0.975545] Write protecting the kernel read-only data: 32768k451machine # [ 0.976821] Freeing unused kernel image (text/rodata gap) memory: 244K452machine # [ 0.978485] Freeing unused kernel image (rodata/data gap) memory: 620K453machine # [ 1.029217] x86/mm: Checked W+X mappings: passed, no W+X pages found.454machine # [ 1.030405] Run /init as init process455machine # [ 1.040381] autofs4: module verification failed: signature and/or required key missing - tainting kernel456machine # [ 1.043005] systemd[1]: Inserted module 'autofs4'457machine # [ 1.062649] fuse: init (API version 7.45)458machine # [ 1.069812] ACPI: \_SB_.GSIG: Enabled at IRQ 22459machine # [ 1.072622] ACPI: \_SB_.GSIH: Enabled at IRQ 23460machine # [ 1.075782] ACPI: \_SB_.GSIE: Enabled at IRQ 20461machine # [ 1.077818] ACPI: \_SB_.GSIF: Enabled at IRQ 21462machine # [ 1.083083] virtiofs virtio5: discovered new tag: nix-store463machine # [ 1.084669] virtiofs virtio5: virtio_fs_setup_dax: No cache capability464machine # [ 1.091199] virtiofs virtio6: discovered new tag: shared465machine # [ 1.092726] virtiofs virtio6: virtio_fs_setup_dax: No cache capability466machine # [ 1.097770] virtiofs virtio7: discovered new tag: xchg467machine # [ 1.099460] virtiofs virtio7: virtio_fs_setup_dax: No cache capability468machine # [ 1.123119] systemd[1]: Successfully made /usr/ read-only.469machine # [ 1.125151] systemd[1]: systemd 263-c676df8 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 +EXPERIMENTAL-ENVVAR)470machine # [ 1.130840] systemd[1]: Detected virtualization kvm.471machine # [ 1.131890] systemd[1]: Detected architecture x86-64.472machine # [ 1.132910] systemd[1]: Running in initrd.473machine # [ 1.134797] systemd[1]: Initializing machine ID from random generator.474machine # [ 1.136116] systemd[1]: Hostname set to <machine>.475machine # [ 1.209880] systemd[1]: bpf-restrict-fs: LSM BPF program attached476machine # [ 1.246448] systemd[1]: Queued start job for default target Initrd Default Target.477machine # [ 1.250199] systemd[1]: Created slice Slice /system/modprobe.478machine # [ 1.251394] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.479machine # [ 1.252856] systemd[1]: Expecting device /dev/disk/by-label/nixos...480machine # [ 1.254046] systemd[1]: Reached target Path Units.481machine # [ 1.254924] systemd[1]: Reached target Slice Units.482machine # [ 1.255848] systemd[1]: Reached target Swaps.483machine # [ 1.256683] systemd[1]: Reached target Timer Units.484machine # [ 1.257722] systemd[1]: Listening on D-Bus System Message Bus Socket.485machine # [ 1.259046] systemd[1]: Listening on Journal Socket (/dev/log).486machine # [ 1.260226] systemd[1]: Listening on Journal Sockets.487machine # [ 1.261233] systemd[1]: Listening on udev Kernel Socket.488machine # [ 1.273571] systemd[1]: Listening on udev Varlink Socket.489machine # [ 1.274571] systemd[1]: Reached target Socket Units.490machine # [ 1.276418] systemd[1]: Starting Create List of Static Device Nodes...491machine # [ 1.281036] systemd[1]: Starting Load Kernel Module configfs...492machine # [ 1.290587] systemd[1]: Starting Journal Service...493machine # [ 1.301089] systemd[1]: Starting Load Kernel Modules...494machine # [ 1.304055] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os495machine # [ 1.311067] systemd[1]: Starting Coldplug All udev Devices...496machine # [ 1.326094] systemd[1]: Finished Create List of Static Device Nodes.497machine # [ 1.333650] systemd[1]: modprobe@configfs.service: Deactivated successfully.498machine # [ 1.342340] systemd[1]: Finished Load Kernel Module configfs.499machine # [ 1.345438] systemd-journald[65]: Collecting audit messages is disabled.500machine # [ 1.347137] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config501machine # [ 1.357046] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...502machine # [ 1.364583] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.503machine # [ 1.374121] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev504machine # [ 1.400539] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.505machine # [ 1.411177] systemd[1]: Starting Create Static Device Nodes in /dev...506machine # [ 1.421514] systemd[1]: Finished Load Kernel Modules.507machine # [ 1.432039] systemd[1]: Starting Apply Kernel Variables...508machine # [ 1.449734] systemd[1]: Finished Create Static Device Nodes in /dev.509machine # [ 1.457225] systemd[1]: Reached target Preparation for Local File Systems.510machine # [ 1.462035] systemd[1]: Reached target Local File Systems.511machine # [ 1.323378] systemd-modules-load[66]: Inserted module 'dm_mod'512machine # [ 1.324606] systemd-modules-load[66]: Inserted module 'virtio_balloon'513machine # [ 1.471168] systemd[1]: Starting Rule-based Manager for Device Events and Files...514machine # [ 1.328336] systemd-modules-load[66]: Inserted module 'virtio_gpu'515machine # [ 1.480254] systemd[1]: Started Journal Service.516machine # [ 1.341923] systemd[1]: Finished Apply Kernel Variables.517machine # [ 1.353278] systemd[1]: Starting Create System Files and Directories...518machine # [ 1.385153] systemd[1]: Finished Create System Files and Directories.519machine # [ 1.390820] systemd-udevd[73]: Using default interface naming scheme 'v261'.520machine # [ 1.416127] systemd[1]: Started Rule-based Manager for Device Events and Files.521machine # [ 1.470359] systemd[1]: Finished Coldplug All udev Devices.522machine # [ 1.472201] systemd[1]: Reached target System Initialization.523machine # [ 1.473879] systemd[1]: Reached target Basic System.524machine # [ 1.757834] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12525machine # [ 1.770972] serio: i8042 KBD port at 0x60,0x64 irq 1526machine # [ 1.771653] serio: i8042 AUX port at 0x60,0x64 irq 12527machine # [ 1.787033] virtio_blk virtio2: 1/0/0 default/read/poll queues528machine # [ 1.794399] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)529machine # [ 1.819306] ehci-pci 0000:00:1d.7: EHCI Host Controller530machine # [ 1.820163] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1531machine # [ 1.821868] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000532machine # [ 1.828071] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00533machine # [ 1.831020] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18534machine # [ 1.832152] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1535machine # [ 1.834864] usb usb1: Product: EHCI Host Controller536machine # [ 1.835882] usb usb1: Manufacturer: Linux 6.18.57 ehci_hcd537machine # [ 1.837459] usb usb1: SerialNumber: 0000:00:1d.7538machine # [ 1.839121] hub 1-0:1.0: USB hub found539machine # [ 1.840566] hub 1-0:1.0: 6 ports detected540machine # [ 1.843904] uhci_hcd 0000:00:1d.0: UHCI Host Controller541machine # [ 1.844776] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2542machine # [ 1.863059] uhci_hcd 0000:00:1d.0: detected 2 ports543machine # [ 1.863843] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180544machine # [ 1.876190] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18545machine # [ 1.879321] SCSI subsystem initialized546machine # [ 1.738226] systemd[1]: Starting Virtual Console Setup...547machine # [ 1.744875] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.548machine # [ 1.748120] (udev-worker)[91]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.549machine # [ 1.750205] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line.550machine # [ 1.896673] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1551machine # [ 1.897798] usb usb2: Product: UHCI Host Controller552machine # [ 1.900446] usb usb2: Manufacturer: Linux 6.18.57 uhci_hcd553machine # [ 1.921236] usb usb2: SerialNumber: 0000:00:1d.0554machine # [ 1.930267] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0555machine # [ 1.790110] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones.556machine # [ 1.793091] systemd[1]: Finished Virtual Console Setup.557machine # [ 1.939140] hub 2-0:1.0: USB hub found558machine # [ 1.800983] systemd[1]: Found device /dev/disk/by-label/nixos.559machine # [ 1.801856] systemd[1]: Reached target Initrd Root Device.560machine # [ 1.947796] hub 2-0:1.0: 2 ports detected561machine # [ 1.803841] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...562machine # [ 1.968052] uhci_hcd 0000:00:1d.1: UHCI Host Controller563machine # [ 1.968781] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3564machine # [ 1.973041] uhci_hcd 0000:00:1d.1: detected 2 ports565machine # [ 1.973810] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0566machine # [ 1.976220] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18567machine # [ 1.978985] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1568machine # [ 1.982002] usb usb3: Product: UHCI Host Controller569machine # [ 1.982708] usb usb3: Manufacturer: Linux 6.18.57 uhci_hcd570machine # [ 1.985070] usb usb3: SerialNumber: 0000:00:1d.1571machine # [ 1.987599] hub 3-0:1.0: USB hub found572machine # [ 1.992028] hub 3-0:1.0: 2 ports detected573machine # [ 1.850408] systemd-fsck[103]: nixos: clean, 12/65536 files, 13019/262144 blocks574machine # [ 1.997974] uhci_hcd 0000:00:1d.2: UHCI Host Controller575machine # [ 1.998678] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4576machine # [ 2.001973] uhci_hcd 0000:00:1d.2: detected 2 ports577machine # [ 2.002743] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0578machine # [ 2.005087] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18579machine # [ 2.008255] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1580machine # [ 1.870665] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.581machine # [ 2.016619] usb usb4: Product: UHCI Host Controller582machine # [ 2.018037] usb usb4: Manufacturer: Linux 6.18.57 uhci_hcd583machine # [ 2.018774] usb usb4: SerialNumber: 0000:00:1d.2584machine # [ 2.021246] hub 4-0:1.0: USB hub found585machine # [ 2.022484] hub 4-0:1.0: 2 ports detected586machine # [ 2.048190] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode587machine # [ 2.053974] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)588machine # [ 2.054823] ahci 0000:00:1f.2: flags: 64bit ncq only589machine # [ 2.060971] scsi host0: ahci590machine # [ 2.062487] scsi host1: ahci591machine # [ 2.063647] scsi host2: ahci592machine # [ 2.065202] scsi host3: ahci593machine # [ 2.066650] scsi host4: ahci594machine # [ 2.067819] scsi host5: ahci595machine # [ 2.069268] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1596machine # [ 2.070550] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1597machine # [ 2.071691] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1598machine # [ 2.072902] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1599machine # [ 2.074108] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1600machine # [ 2.075243] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1601machine # [ 2.080969] usb 1-1: new high-speed USB device number 2 using ehci-pci602machine # [ 2.210409] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00603machine # [ 2.213295] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10604machine # [ 2.216530] usb 1-1: Product: QEMU USB Tablet605machine # [ 2.218345] usb 1-1: Manufacturer: QEMU606machine # [ 2.219923] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1607machine # [ 2.253492] hid: raw HID events driver (C) Jiri Kosina608machine # [ 2.179829] systemd[1]: Mounting /sysroot...609machine # [ 2.386527] ata1: SATA link down (SStatus 0 SControl 300)610machine # [ 2.387421] ata6: SATA link down (SStatus 0 SControl 300)611machine # [ 2.388437] ata4: SATA link down (SStatus 0 SControl 300)612machine # [ 2.389364] ata5: SATA link down (SStatus 0 SControl 300)613machine # [ 2.390323] ata2: SATA link down (SStatus 0 SControl 300)614machine # [ 2.391307] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)615machine # [ 2.392275] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100616machine # [ 2.393122] ata3.00: applying bridge limits617machine # [ 2.393781] ata3.00: configured for UDMA/100618machine # [ 2.394771] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5619machine # [ 2.452313] usbcore: registered new interface driver usbhid620machine # [ 2.453108] usbhid: USB HID core driver621machine # [ 2.475104] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray622machine # [ 2.483199] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2623machine # [ 2.487229] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0624machine # [ 2.491104] cdrom: Uniform CD-ROM driver Revision: 3.20625machine # [ 2.508569] EXT4-fs (vda): mounted filesystem 0404c90c-0a96-4f20-b92a-06db565c32b4 r/w with ordered data mode. Quota mode: none.626machine # [ 2.369434] systemd[1]: Mounted /sysroot.627machine # [ 2.372918] systemd[1]: Reached target Initrd Root File System.628machine # [ 2.374162] systemd[1]: Starting Mountpoints Configured in the Real Root...629machine # [ 2.389950] systemd-sysroot-fstab-check[137]: /sysroot should be mounted in the initrd, will request daemon-reload.630machine # [ 2.396079] systemd[1]: Reload requested from client PID 137 ('systemd-sysroot') (unit initrd-parse-etc.service)...631machine # [ 2.397588] systemd[1]: Reloading...632machine # [ 2.470773] systemd[1]: Reloading finished in 75 ms.633machine # [ 2.478705] systemd-sysroot-fstab-check[137]: Requesting initrd-fs.target/start/replace...634machine # [ 2.483188] systemd-sysroot-fstab-check[137]: Requesting swap.target/start/replace...635machine # [ 2.487155] systemd[1]: initrd-parse-etc.service: Deactivated successfully.636machine # [ 2.488570] systemd[1]: Finished Mountpoints Configured in the Real Root.637machine # [ 2.489899] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.638machine # [ 3.182204] systemd[1]: Mounting /sysroot/nix/.ro-store...639machine # [ 3.188195] systemd[1]: Mounting /sysroot/nix/.rw-store...640machine # [ 3.197179] systemd[1]: Mounting /sysroot/run...641machine # [ 3.208183] systemd[1]: Mounting /sysroot/tmp/shared...642machine # [ 3.219148] systemd[1]: Mounting /sysroot/tmp/xchg...643machine # [ 3.254837] systemd[1]: Mounted /sysroot/nix/.rw-store.644machine # [ 3.265140] systemd[1]: Mounted /sysroot/nix/.ro-store.645machine # [ 3.266086] systemd[1]: Mounted /sysroot/run.646machine # [ 3.266911] systemd[1]: Mounted /sysroot/tmp/shared.647machine # [ 3.267826] systemd[1]: Mounted /sysroot/tmp/xchg.648machine # [ 3.271717] systemd[1]: Starting rw-sysroot-nix-store.service...649machine # [ 3.282728] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.650machine # [ 3.284567] systemd[1]: Finished rw-sysroot-nix-store.service.651machine # [ 4.180868] systemd[1]: Mounting /sysroot/nix/store...652machine # [ 4.235491] systemd[1]: Mounted /sysroot/nix/store.653machine # [ 4.236908] systemd[1]: Reached target Initrd File Systems.654machine # [ 4.239148] systemd[1]: Starting Find NixOS closure...655machine # [ 4.241893] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...656machine # [ 4.265503] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.657machine # [ 4.269097] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.658machine # [ 4.275747] systemd[1]: Finished Find NixOS closure.659machine # [ 4.277202] systemd[1]: Reached target Initrd Default Target.660machine # [ 4.278837] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...661machine # [ 4.293652] systemd[1]: Stopped target Initrd Default Target.662machine # [ 4.294891] systemd[1]: Stopped target Basic System.663machine # [ 4.295735] systemd[1]: Stopped target Initrd Root Device.664machine # [ 4.297138] systemd[1]: Stopped target Path Units.665machine # [ 4.297928] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.666machine # [ 4.298938] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.667machine # [ 4.300241] systemd[1]: Stopped target Slice Units.668machine # [ 4.301209] systemd[1]: Stopped target Socket Units.669machine # [ 4.302177] systemd[1]: Stopped target System Initialization.670machine # [ 4.303313] systemd[1]: Stopped target Swaps.671machine # [ 4.304231] systemd[1]: Stopped target Timer Units.672machine # [ 4.305161] systemd[1]: dbus.socket: Deactivated successfully.673machine # [ 4.306160] systemd[1]: Closed D-Bus System Message Bus Socket.674machine # [ 4.307254] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.675machine # [ 4.309193] systemd[1]: Stopped Find NixOS closure.676machine # [ 4.310344] systemd[1]: Starting rw-sysroot-nix-store.service...677machine # [ 4.312206] systemd[1]: systemd-sysctl.service: Deactivated successfully.678machine # [ 4.313273] systemd[1]: Stopped Apply Kernel Variables.679machine # [ 4.314350] systemd[1]: systemd-modules-load.service: Deactivated successfully.680machine # [ 4.315491] systemd[1]: Stopped Load Kernel Modules.681machine # [ 4.317061] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.682machine # [ 4.318365] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.683machine # [ 4.320153] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.684machine # [ 4.321274] systemd[1]: Stopped Create System Files and Directories.685machine # [ 4.323520] systemd[1]: Stopped target Local File Systems.686machine # [ 4.324434] systemd[1]: Stopped target Preparation for Local File Systems.687machine # [ 4.325845] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.688machine # [ 4.327296] systemd[1]: Stopped Coldplug All udev Devices.689machine # [ 4.328576] systemd[1]: Stopping Rule-based Manager for Device Events and Files...690machine # [ 4.330284] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.691machine # [ 4.331650] systemd[1]: Stopped Virtual Console Setup.692machine # [ 4.341205] systemd[1]: systemd-udevd.service: Deactivated successfully.693machine # [ 4.345108] systemd[1]: Stopped Rule-based Manager for Device Events and Files.694machine # [ 4.347465] systemd[1]: initrd-cleanup.service: Deactivated successfully.695machine # [ 4.351220] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.696machine # [ 4.355773] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully.697machine # [ 4.357649] systemd[1]: Closed udev Varlink Socket.698machine # [ 4.358723] systemd[1]: Starting Cleanup udev Database...699machine # [ 4.360162] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.700machine # [ 4.361339] systemd[1]: Stopped Create Static Device Nodes in /dev.701machine # [ 4.362250] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.702machine # [ 4.364132] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.703machine # [ 4.365132] systemd[1]: kmod-static-nodes.service: Deactivated successfully.704machine # [ 4.366087] systemd[1]: Stopped Create List of Static Device Nodes.705machine # [ 4.367228] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.706machine # [ 4.369125] systemd[1]: Finished rw-sysroot-nix-store.service.707machine # [ 4.386247] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.708machine # [ 4.387504] systemd[1]: Finished Cleanup udev Database.709machine # [ 4.388724] systemd[1]: Reached target Switch Root.710machine # [ 4.390372] systemd[1]: Starting NixOS Activation...711machine # [ 4.457263] initrd-nixos-activation-start[188]: booting system configuration /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test712machine # [ 4.484338] initrd-nixos-activation-start[188]: running activation script...713machine # [ 4.672823] initrd-nixos-activation-start[211]: setting up /etc...714machine # [ 4.778323] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.715machine # [ 4.779608] systemd[1]: Finished NixOS Activation.716machine # [ 4.781750] systemd[1]: Starting Switch Root...717machine # [ 4.795146] systemd[1]: Switching root.718machine # [ 5.069227] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).719machine # [ 5.130240] NET: Registered PF_VSOCK protocol family720machine # [ 5.154512] systemd[1]: systemd 263-c676df8 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 +EXPERIMENTAL-ENVVAR)721machine # [ 5.158654] systemd[1]: Detected virtualization kvm.722machine # [ 5.159425] systemd[1]: Detected architecture x86-64.723machine # [ 5.160219] systemd[1]: Detected first boot.724machine # [ 5.162084] systemd[1]: Initializing machine ID from random generator.725machine # [ 5.255041] systemd[1]: bpf-restrict-fs: LSM BPF program attached726machine # [ 5.359350] systemd[1]: Applying preset policy.727machine # [ 5.532296] systemd[1]: Populated /etc with preset unit settings.728machine # [ 5.719537] systemd[1]: initrd-switch-root.service: Deactivated successfully.729machine # [ 5.721026] systemd[1]: Stopped initrd-switch-root.service.730machine # [ 5.723422] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.731machine # [ 5.725728] systemd[1]: Created slice Slice /system/getty.732machine # [ 5.727272] systemd[1]: Created slice User and Session Slice.733machine # [ 5.728283] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.734machine # [ 5.729596] systemd[1]: Started Forward Password Requests to Wall Directory Watch.735machine # [ 5.730714] systemd[1]: Expecting device /dev/hvc0...736machine # [ 5.731508] systemd[1]: Expecting device /dev/ttyS0...737machine # [ 5.732297] systemd[1]: Reached target Local Encrypted Volumes.738machine # [ 5.733218] systemd[1]: Stopped target initrd-fs.target.739machine # [ 5.734020] systemd[1]: Stopped target initrd-root-fs.target.740machine # [ 5.734853] systemd[1]: Stopped target initrd-switch-root.target.741machine # [ 5.747423] systemd[1]: Reached target Virtual Machines and Containers.742machine # [ 5.748370] systemd[1]: Reached target Path Units.743machine # [ 5.749144] systemd[1]: Reached target Remote File Systems.744machine # [ 5.749984] systemd[1]: Reached target Slice Units.745machine # [ 5.750708] systemd[1]: Reached target Swaps.746machine # [ 5.752738] systemd[1]: Listening on Query the User Interactively for a Password.747machine # [ 5.755239] systemd[1]: Listening on Process Core Dump Socket.748machine # [ 5.757029] systemd[1]: Listening on Credential Encryption/Decryption.749machine # [ 5.758789] systemd[1]: Listening on Factory Reset Management.750machine # [ 5.759767] systemd[1]: Listening on Hostname Service Socket.751machine # [ 5.762463] systemd[1]: Starting Journal Log Access Socket...752machine # [ 5.764212] systemd[1]: Listening on Journal Audit Socket.753machine # [ 5.767057] systemd[1]: Listening on Console Output Muting Service Socket.754machine # [ 5.768257] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.755machine # [ 5.769473] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os756machine # [ 5.770834] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki757machine # [ 5.775160] systemd[1]: Listening on Disk Repartitioning Service Socket.758machine # [ 5.776264] systemd[1]: Listening on udev Varlink Socket.759machine # [ 5.778885] systemd[1]: Mounting Huge Pages File System...760machine # [ 5.783113] systemd[1]: Mounting POSIX Message Queue File System...761machine # [ 5.788537] systemd[1]: Mounting Kernel Debug File System...762machine # [ 5.798034] systemd[1]: Mounting Kernel Trace File System...763machine # [ 5.808694] systemd[1]: Starting Create List of Static Device Nodes...764machine # [ 5.821430] systemd[1]: Starting Load Kernel Module configfs...765machine # [ 5.828960] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm766machine # [ 5.838779] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore767machine # [ 5.853116] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse768machine # [ 5.867046] systemd[1]: Mounting FUSE Control File System...769machine # [ 5.870746] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67770machine # [ 5.887052] systemd[1]: Starting Journal Service...771machine # [ 5.895763] systemd[1]: Starting Load Kernel Modules...772machine # [ 5.906242] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...773machine # [ 5.922396] systemd[1]: Starting Remount Root and Kernel File Systems...774machine # [ 5.928090] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os775machine # [ 5.939300] systemd[1]: Starting Coldplug All udev Devices...776machine # [ 5.951633] systemd[1]: Listening on Journal Log Access Socket.777machine # [ 5.958615] systemd[1]: Mounted Huge Pages File System.778machine # [ 5.959670] systemd-journald[282]: Collecting audit messages is enabled.779machine # [ 5.964387] systemd[1]: Mounted POSIX Message Queue File System.780machine # [ 5.973535] systemd[1]: Mounted Kernel Debug File System.781machine # [ 5.983253] systemd[1]: Mounted Kernel Trace File System.782machine # [ 5.841684] systemd[1]: Queued start job for default target Multi-User System.783machine # [ 5.845352] systemd[1]: Unnecessary job was removed for /sys/devices/pnp0/00:03/00:03:0/00:03:0.0/tty/ttyS0.784machine # [ 5.993761] systemd[1]: Finished Create List of Static Device Nodes.785machine # [ 5.850528] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0.786machine # [ 5.852708] systemd[1]: systemd-journald.service: Deactivated successfully.787machine # [ 6.003042] loop: module loaded788machine # [ 6.005233] systemd[1]: Started Journal Service.789machine # [ 5.862386] systemd-modules-load[283]: Inserted module 'loop'790machine # [ 5.867113] systemd[1]: modprobe@configfs.service: Deactivated successfully.791machine # [ 5.872150] systemd[1]: Finished Load Kernel Module configfs.792machine # [ 5.873263] systemd[1]: Mounted FUSE Control File System.793machine # [ 5.877356] systemd[1]: Finished Load Kernel Modules.794machine # [ 6.035004] EXT4-fs (vda): re-mounted 0404c90c-0a96-4f20-b92a-06db565c32b4.795machine # [ 5.900093] systemd[1]: Mounting Kernel Configuration File System...796machine # [ 5.905079] systemd[1]: Starting Firewall...797machine # [ 5.922090] systemd[1]: Starting Apply Kernel Variables...798machine # [ 5.932115] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...799machine # [ 5.945093] systemd[1]: Finished Remount Root and Kernel File Systems.800machine # [ 5.948274] systemd-oomd[284]: No swap; memory pressure usage will be degraded801machine # [ 5.955146] systemd[1]: Listening on Disk Image Download Service Socket.802machine # [ 5.969702] systemd[1]: Starting Flush Journal to Persistent Storage...803machine # [ 5.970645] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore804machine # [ 5.980246] systemd[1]: Starting Load/Save OS Random Seed...805machine # [ 5.981160] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os806machine # [ 5.990084] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.807machine # [ 6.202195] systemd-journald[282]: Received client request to flush runtime journal.808machine # [ 6.142698] systemd[1]: Mounted Kernel Configuration File System.809machine # [ 6.144884] systemd[1]: Finished Load/Save OS Random Seed.810machine # [ 6.146222] systemd[1]: Reached target First Boot Complete.811machine # [ 6.146993] systemd[1]: Finished Apply Kernel Variables.812machine # [ 6.150228] systemd[1]: Finished Flush Journal to Persistent Storage.813machine # [ 6.197235] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.814machine # [ 6.200399] systemd[1]: Starting Create Static Device Nodes in /dev...815machine # [ 6.264385] systemd[1]: Finished Coldplug All udev Devices.816machine # [ 6.273876] systemd[1]: Finished Create Static Device Nodes in /dev.817machine # [ 6.275443] systemd[1]: Reached target Preparation for Local File Systems.818machine # [ 6.279255] systemd[1]: Starting Rule-based Manager for Device Events and Files...819machine # [ 6.328726] systemd-udevd[325]: Using default interface naming scheme 'v261'.820machine # [ 6.383243] systemd[1]: Started Rule-based Manager for Device Events and Files.821machine # [ 6.454373] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse822machine # [ 6.545721] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.823machine # [ 6.563349] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.824machine # [ 6.580485] systemd[1]: Mounting /run/wrappers...825machine # [ 6.605637] (udev-worker)[363]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.826machine # [ 6.607806] (udev-worker)[363]: Network interface NamePolicy= disabled on kernel command line.827machine # [ 6.612319] (udev-worker)[350]: Network interface NamePolicy= disabled on kernel command line.828machine # [ 6.631423] systemd[1]: Mounted /run/wrappers.829machine # [ 6.632368] systemd[1]: Reached target Local File Systems.830machine # [ 6.637102] systemd[1]: Listening on Boot Loader Control Service Socket.831machine # [ 6.640657] systemd[1]: Starting Create SUID/SGID Wrappers...832machine # [ 6.643535] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.833machine # [ 6.647102] systemd[1]: Starting Save Transient machine-id to Disk...834machine # [ 6.653768] systemd[1]: Starting Create System Files and Directories...835machine # [ 6.778587] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.836machine # [ 6.784574] systemd[1]: Finished Save Transient machine-id to Disk.837machine # [ 6.788964] systemd[1]: Finished Create System Files and Directories.838machine # [ 6.797419] systemd[1]: Starting Rebuild Journal Catalog...839machine # [ 6.804265] systemd[1]: Starting Record System Boot/Shutdown in UTMP...840machine # [ 6.849296] systemd[1]: Condition check resulted in Virtio network device being skipped.841machine # [ 6.851632] systemd[1]: Condition check resulted in Virtio network device being skipped.842machine # [ 6.853753] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore843machine # [ 6.856819] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.844machine # [ 6.858502] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67845machine # [ 6.861140] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore846machine # [ 6.865459] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os847machine # [ 6.866671] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os848machine # [ 6.905085] systemd[1]: Finished Record System Boot/Shutdown in UTMP.849machine # [ 6.932298] systemd[1]: Finished Rebuild Journal Catalog.850machine # [ 6.938107] systemd[1]: Starting Update is Completed...851machine # [ 6.982845] systemd[1]: Finished Update is Completed.852machine # [ 7.215029] mousedev: PS/2 mouse device common for all mice853machine # [ 7.243811] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console854machine # [ 7.140612] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.855machine # [ 7.144180] systemd[1]: Finished Create SUID/SGID Wrappers.856machine # [ 7.145611] systemd[1]: Reached target System Initialization.857machine # [ 7.148510] systemd[1]: Started Discard unused filesystem blocks once a week.858machine # [ 7.149591] systemd[1]: Started Daily Cleanup of Temporary Directories.859machine # [ 7.152179] systemd[1]: Reached target Timer Units.860machine # [ 7.152918] systemd[1]: Listening on D-Bus System Message Bus Socket.861machine # [ 7.153908] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.862machine # [ 7.156277] systemd[1]: Reached target Socket Units.863machine # [ 7.157113] systemd[1]: Reached target Basic System.864machine # [ 7.161507] systemd[1]: Started backdoor.service.865machine # [ 7.164644] systemd[1]: Starting Import lastlog data into lastlog2 database...866machine # [ 7.181089] systemd[1]: Starting Name Service Cache Daemon (nsncd)...867machine # [ 7.190187] systemd[1]: Starting Post-Boot Actions...868machine # [ 7.203535] systemd[1]: Started Reset console on configuration changes.869machine # [ 7.237971] systemd[1]: Starting resolvconf update...870machine # [ 7.262978] systemd[1]: Starting D-Bus System Message Bus...871machine # connecting to host...872machine # [ 7.333097] systemd[1]: Finished Post-Boot Actions.873machine # [ 7.351409] nsncd[484]: Oct 23 03:09:19.988 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"874machine: Guest shell says: b'Spawning backdoor root shell...\n'875machine # [ 7.358444] systemd[1]: Finished Firewall.876machine # [ 7.359131] systemd[1]: Started Name Service Cache Daemon (nsncd).877machine: connected to guest root shell878machine: (connecting took 8.06 seconds)879machine: (finished: waiting for the VM to finish booting, in 8.67 seconds)880machine # [ 7.369746] systemd[1]: Reached target Host and Network Name Lookups.881machine # [ 7.370667] systemd[1]: Reached target User and Group Name Lookups.882machine # [ 7.387970] systemd[1]: Starting User Login Management...883machine # [ 7.436956] systemd[1]: Finished Import lastlog data into lastlog2 database.884machine # [ 7.499972] dbus-broker-launch[495]: Looking up NSS user entry for 'systemd-timesync'...885machine # [ 7.531043] rtc_cmos PNP0B00:00: RTC can wake from S4886machine # [ 7.546679] parport_pc 00:02: reported by Plug and Play ACPI887machine # [ 7.546767] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]888machine # [ 7.616088] rtc_cmos PNP0B00:00: registered as rtc0889machine # [ 7.616157] rtc_cmos PNP0B00:00: setting system clock to 2026-10-23T03:09:20 UTC (1792724960)890machine # [ 7.616234] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs891machine # [ 7.622828] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized892machine # [ 7.627275] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input3893machine # [ 7.652523] Console: switching to colour dummy device 80x25894machine # [ 7.731173] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt895machine # [ 7.731293] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD896machine # [ 7.592050] systemd-logind[520]: New seat seat0.897machine # [ 7.594650] systemd[1]: Started User Login Management.898machine # [ 7.602135] systemd[1]: Stopped target Host and Network Name Lookups.899machine # [ 7.603263] dbus-broker-launch[495]: NSS returned no entry for 'systemd-timesync'900machine # [ 7.604317] dbus-broker-launch[495]: Invalid user-name in /nix/store/hhnipdh1adrbhs1xz6rc4lk05jsfkx89-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"901machine # [ 7.606282] systemd[1]: Stopping Host and Network Name Lookups...902machine # [ 7.607109] systemd[1]: Stopped target User and Group Name Lookups.903machine # [ 7.607919] systemd[1]: Stopping User and Group Name Lookups...904machine # [ 7.612940] systemd[1]: Starting linger-users.service...905machine # [ 7.613740] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...906machine # [ 7.621677] systemd[1]: nscd.service: Deactivated successfully.907machine # [ 7.623778] systemd[1]: Stopped Name Service Cache Daemon (nsncd).908machine # [ 7.797416] [drm] Found bochs VGA, ID 0xb0c5.909machine # [ 7.797947] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.910machine # [ 7.655772] systemd[1]: Starting Name Service Cache Daemon (nsncd)...911machine # [ 7.659840] systemd[1]: Started D-Bus System Message Bus.912machine # [ 7.693299] dbus-broker-launch[495]: Ready913machine # [ 7.875475] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic914machine # [ 7.876221] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0915machine # [ 7.742462] nsncd[576]: Oct 23 03:09:20.768 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"916machine # [ 7.745423] systemd[1]: Started Name Service Cache Daemon (nsncd).917machine # [ 7.772088] systemd[1]: Created slice Slice /user/1001.918machine # [ 7.772838] systemd[1]: Reached target Host and Network Name Lookups.919machine # [ 7.774142] systemd[1]: Reached target User and Group Name Lookups.920machine # [ 7.774978] systemd[1]: Starting User Runtime Directory /run/user/1001...921machine # [ 7.797564] systemd[1]: linger-users.service: Deactivated successfully.922machine # [ 7.798557] systemd[1]: Finished linger-users.service.923machine # [ 7.956934] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5924machine # [ 7.959201] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4925machine # [ 7.824503] systemd[1]: Starting Virtual Console Setup...926machine # [ 7.852507] systemd[1]: Finished resolvconf update.927machine # [ 7.853387] systemd[1]: Reached target Preparation for Network.928machine # [ 7.868366] systemd[1]: Starting DHCP Client...929machine # [ 7.872328] systemd[1]: Starting Address configuration of eth1...930machine # [ 7.884169] systemd[1]: Starting Extra networking commands....931machine # [ 7.891744] systemd-logind[520]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)932machine # [ 7.910826] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.933machine # [ 7.911846] systemd[1]: Stopped Virtual Console Setup.934machine # [ 7.921205] systemd[1]: Starting Virtual Console Setup...935machine # [ 8.073228] Console: switching to colour frame buffer device 160x50936machine # [ 8.088963] ppdev: user-space parallel port driver937machine # [ 8.097637] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device938machine # [ 7.995092] systemd-logind[520]: Watching system buttons on /dev/input/event2 (QEMU Virtio Keyboard)939machine # [ 7.996299] systemd[1]: Finished User Runtime Directory /run/user/1001.940machine # [ 7.997203] systemd[1]: Starting User Manager for UID 1001...941machine # [ 8.152748] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)942machine # [ 8.178387] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)943machine # [ 8.082235] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.944machine # [ 8.083431] systemd[1]: Stopped Virtual Console Setup.945machine # [ 8.092613] systemd[1]: Starting Virtual Console Setup...946machine # [ 8.098288] (systemd)[615]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0)947machine # [ 8.109937] systemd-logind[520]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'.948machine # [ 8.144343] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy949machine # [ 8.255584] network-addresses-eth1-start[609]: adding address 192.168.1.1/24... done950machine # [ 8.293460] network-addresses-eth1-start[609]: adding address 2001:db8:1::1/64... done951machine # [ 8.329338] systemd[1]: Finished Address configuration of eth1.952machine # [ 8.331697] systemd[615]: Queued start job for default target Main User Target.953machine # [ 8.337941] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy954machine # [ 8.341206] systemd[615]: Created slice User Application Slice.955machine # [ 8.342100] systemd[615]: Started Daily Cleanup of User's Temporary Directories.956machine # [ 8.343111] systemd[615]: Reached target Paths.957machine # [ 8.343801] systemd[615]: Reached target Timers.958machine # [ 8.355217] systemd[615]: Starting D-Bus User Message Bus Socket...959machine # [ 8.356161] systemd[615]: Starting Create User Files and Directories...960machine # [ 8.399565] systemd[615]: Finished Create User Files and Directories.961machine # [ 8.416439] systemd[615]: Listening on D-Bus User Message Bus Socket.962machine # [ 8.417381] systemd[615]: Reached target Sockets.963machine # [ 8.422136] systemd[615]: Reached target Basic System.964machine # [ 8.422853] systemd[1]: Started User Manager for UID 1001.965machine # [ 8.426752] systemd[615]: Starting Run user-specific NixOS activation...966machine # [ 8.468607] systemd[615]: Finished Run user-specific NixOS activation.967machine # [ 8.469603] systemd[615]: Reached target Main User Target.968machine # [ 8.472406] systemd[615]: Startup finished in 334ms.969machine # [ 8.640495] kvm_amd: TSC scaling supported970machine # [ 8.642248] kvm_amd: Nested Virtualization enabled971machine # [ 8.642750] kvm_amd: Nested Paging enabled972machine # [ 8.644058] kvm_amd: LBR virtualization supported973machine # [ 8.644502] kvm_amd: Virtual VMLOAD VMSAVE supported974machine # [ 8.646143] kvm_amd: Virtual GIF supported975machine # [ 8.646528] kvm_amd: Virtual NMI enabled976machine # [ 8.504419] dhcpcd[629]: dhcpcd-10.3.2 starting977machine # [ 8.512185] dhcpcd[694]: dev: loaded udev978machine # [ 8.672468] 8021q: 802.1Q VLAN Support v1.8979machine # [ 8.673952] 8021q: adding VLAN 0 to HW filter on device eth1980machine # [ 8.534376] systemd[1]: Finished Extra networking commands..981machine # [ 8.536382] systemd[1]: Reached target Network.982machine # [ 8.540982] systemd[1]: Starting Permit User Sessions...983machine # [ 8.694595] EDAC MC: Ver: 3.0.0984machine # [ 8.573973] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.985machine # [ 8.627615] systemd[1]: Finished Permit User Sessions.986machine # [ 8.634862] systemd[1]: Started Getty on tty1.987machine # [ 8.636403] systemd[1]: Reached target Login Prompts.988machine # [ 8.783463] cfg80211: Loading compiled-in X.509 certificates for regulatory database989machine # [ 8.786580] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'990machine # [ 8.789062] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'991machine # [ 8.790477] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2992machine # [ 8.791345] cfg80211: failed to load regulatory.db993machine # [ 8.824545] 8021q: adding VLAN 0 to HW filter on device eth0994machine # [ 8.681100] dhcpcd[694]: eth0: waiting for carrier995machine # [ 8.682509] dhcpcd[694]: eth0: carrier acquired996machine # [ 8.687972] dhcpcd[694]: DUID 00:01:00:01:32:6d:8c:61:52:54:00:12:34:56997machine # [ 8.689263] dhcpcd[694]: eth0: IAID 00:12:34:56998machine # [ 8.690280] dhcpcd[694]: eth0: adding address fe80::5054:ff:fe12:3456999machine # [ 8.736146] systemd-vconsole-setup[621]: Configuration of first virtual console was skipped, ignoring remaining ones.1000machine # [ 8.740748] systemd[1]: Finished Virtual Console Setup.1001machine # [ 9.554167] dhcpcd[694]: eth0: soliciting a DHCP lease1002machine # [ 9.707253] NET: Registered PF_PACKET protocol family1003machine # [ 9.567558] dhcpcd[694]: eth0: offered 10.0.2.15 from 10.0.2.21004machine # [ 9.570224] dhcpcd[694]: eth0: probing address 10.0.2.15/241005machine # [ 10.858996] dhcpcd[694]: eth0: soliciting an IPv6 router1006machine # [ 10.863717] dhcpcd[694]: eth0: Router Advertisement from fe80::21007machine # [ 10.867844] dhcpcd[694]: eth0: adding address fec0::5054:ff:fe12:3456/641008machine # [ 10.870168] dhcpcd[694]: eth0: adding route to fec0::/641009machine # [ 10.872073] dhcpcd[694]: eth0: adding default route via fe80::21010machine # [ 14.540691] dhcpcd[694]: eth0: leased 10.0.2.15 for 86400 seconds1011machine # [ 14.542464] dhcpcd[694]: eth0: adding route to 10.0.2.0/241012machine # [ 14.543487] dhcpcd[694]: eth0: adding default route via 10.0.2.21013machine # [ 14.602618] systemd[1]: Started DHCP Client.1014machine # [ 14.604393] systemd[1]: Reached target Multi-User System.1015machine # [ 14.605572] systemd[1]: Startup finished in 888ms (kernel) + 4.074s (initrd) + 9.641s (userspace) = 14.605s.1016machine: (finished: waiting for unit multi-user.target, in 16.34 seconds)1017machine: must succeed: /nix/store/hfxhmbp4ynsblplki1wvrcfg9cagq9vd-stderr-runner /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/bin/switch-to-configuration test1018machine # Checking switch inhibitors... done1019machine # [ 15.207709] nixos[837]: switching to system configuration /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test1020machine # [ 15.209893] systemd[1]: Stopped target Local File Systems.1021machine # [ 15.211499] systemd[1]: Stopped target Remote File Systems.1022machine # activating the configuration...1023machine # setting up /etc...1024machine # [ 15.417871] systemd[1]: Reload requested from client PID 837 ('.switch-to-conf') (unit backdoor.service)...1025machine # [ 15.419519] systemd[1]: Reloading...1026machine # [ 15.632204] systemd[1]: Reloading finished in 210 ms.1027machine # reloading user units for usertest...1028machine # [ 15.661273] systemd[615]: Created slice User Core Session Slice.1029machine # [ 15.663725] systemd[615]: Starting D-Bus User Message Bus...1030machine # [ 15.680700] dbus-broker-launch[907]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/hhnipdh1adrbhs1xz6rc4lk05jsfkx89-system-path/share/dbus-1/services/org.freedesktop.import1.service'1031machine # [ 15.683299] dbus-broker-launch[907]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/hhnipdh1adrbhs1xz6rc4lk05jsfkx89-system-path/share/dbus-1/services/org.freedesktop.machine1.service'1032machine # [ 15.685781] dbus-broker-launch[907]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/hhnipdh1adrbhs1xz6rc4lk05jsfkx89-system-path/share/dbus-1/services/org.freedesktop.portable1.service'1033machine # [ 15.688293] dbus-broker-launch[907]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/hhnipdh1adrbhs1xz6rc4lk05jsfkx89-system-path/share/dbus-1/services/org.freedesktop.systemd1.service'1034machine # [ 15.690825] dbus-broker-launch[907]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored1035machine # [ 15.692709] dbus-broker-launch[907]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored1036machine # [ 15.694217] systemd[615]: Started D-Bus User Message Bus.1037machine # [ 15.697196] dbus-broker-launch[907]: Ready1038machine # [ 15.734090] systemd[615]: Reexecution requested from client PID 906 ('switch-to-confi')...1039machine # [ 15.736508] systemd[615]: Reexecuting.1040machine # [ 15.758383] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1041machine # [ 15.831124] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1042machine # [ 15.836396] systemd[615]: Reload requested from client PID 906 ('switch-to-confi')...1043machine # [ 15.837628] systemd[615]: Reloading...1044machine # [ 15.914792] systemd[615]: Reloading finished in 75 ms.1045machine # [ 15.919896] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1046machine # restarting the following user units: nixos-activation.service1047machine # [ 15.927268] systemd[615]: Stopped Run user-specific NixOS activation.1048machine # [ 15.928824] systemd[615]: Stopping Run user-specific NixOS activation...1049machine # [ 15.931311] systemd[615]: Starting Run user-specific NixOS activation...1050machine # [ 15.952379] systemd[615]: Finished Run user-specific NixOS activation.1051machine # restarting sysinit-reactivation.target1052machine # [ 15.960935] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....1053machine # [ 16.031203] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..1054machine # [ 16.034054] systemd[1]: Reached target Reactivate sysinit units.1055machine # [ 16.036681] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1056machine # [ 16.038813] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1057machine # [ 16.042069] systemd[1]: Reached target Local File Systems.1058machine # [ 16.044214] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1059machine # [ 16.047371] systemd[1]: Starting Create SUID/SGID Wrappers...1060machine # [ 16.048976] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1061machine # [ 16.050274] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671062machine # [ 16.052302] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1063machine # [ 16.053778] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1064machine # [ 16.058693] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1065machine # [ 16.059941] systemd[1]: Reached target Remote File Systems.1066machine # [ 16.198194] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1067machine # [ 16.199837] systemd[1]: Finished Create SUID/SGID Wrappers.1068machine # [ 16.204084] systemd[1]: Starting linger-users.service...1069machine # [ 16.232957] systemd[1]: linger-users.service: Deactivated successfully.1070machine # [ 16.235295] systemd[1]: Finished linger-users.service.1071machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service1072machine # [ 16.490446] nixos[837]: finished switching to system configuration /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test1073machine: (finished: must succeed: /nix/store/hfxhmbp4ynsblplki1wvrcfg9cagq9vd-stderr-runner /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/bin/switch-to-configuration test, in 1.45 seconds)1074machine: must succeed: rm /etc/NIXOS1075machine: (finished: must succeed: rm /etc/NIXOS, in 0.01 seconds)1076machine: must succeed: /nix/store/hfxhmbp4ynsblplki1wvrcfg9cagq9vd-stderr-runner /nix/store/i9jcnlzym20jsiyzfybbj8a69nlxxck0-nixos-system-other-test/bin/switch-to-configuration test1077machine # this should succeed (config: /nix/store/i9jcnlzym20jsiyzfybbj8a69nlxxck0-nixos-system-other-test, action: test)1078machine # Checking switch inhibitors... done1079machine # [ 16.710204] nixos[984]: switching to system configuration /nix/store/i9jcnlzym20jsiyzfybbj8a69nlxxck0-nixos-system-other-test1080machine # [ 16.712647] systemd[1]: Stopped target Local File Systems.1081machine # [ 16.714568] systemd[1]: Stopped target Remote File Systems.1082machine # activating the configuration...1083machine # removing user ‘usertest’1084machine # setting up /etc...1085machine # [ 16.947498] systemd[1]: Reload requested from client PID 984 ('.switch-to-conf') (unit backdoor.service)...1086machine # [ 16.949290] systemd[1]: Reloading...1087machine # [ 17.204991] systemd[1]: Reloading finished in 254 ms.1088machine # reloading user units for usertest...1089machine # [ 17.281850] systemd[615]: Reexecution requested from client PID 1055 ('switch-to-confi')...1090machine # [ 17.283368] systemd[615]: Reexecuting.1091machine # [ 17.306817] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1092machine # [ 17.383494] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1093machine # [ 17.388947] systemd[615]: Reload requested from client PID 1055 ('switch-to-confi')...1094machine # [ 17.390476] systemd[615]: Reloading...1095machine # [ 17.462878] systemd[615]: Reloading finished in 70 ms.1096machine # [ 17.467885] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1097machine # restarting the following user units: nixos-activation.service1098machine # [ 17.476090] systemd[615]: Stopped Run user-specific NixOS activation.1099machine # [ 17.476975] systemd[615]: Stopping Run user-specific NixOS activation...1100machine # [ 17.478683] systemd[615]: Starting Run user-specific NixOS activation...1101machine # [ 17.500302] systemd[615]: Finished Run user-specific NixOS activation.1102machine # restarting sysinit-reactivation.target1103machine # [ 17.504242] systemd[1]: Stopped target Reactivate sysinit units.1104machine # [ 17.505546] systemd[1]: Stopping Reactivate sysinit units...1105machine # reloading the following units: dbus-broker.service[ 17.507303] systemd[1]: Reached target Reactivate sysinit units.1106machine # 1107machine # [ 17.509316] dbus-broker-launch[495]: Caught SIGHUP, trigger reload.1108machine # [ 17.511512] systemd[1]: Reloading D-Bus System Message Bus...1109machine # [ 17.516270] dbus-broker-launch[495]: Looking up NSS user entry for 'systemd-timesync'...1110machine # [ 17.518135] dbus-broker-launch[495]: NSS returned no entry for 'systemd-timesync'1111machine # [ 17.519206] dbus-broker-launch[495]: Invalid user-name in /nix/store/1pjj63ccabn2cs8rwc07v2h2wvxv0gf5-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1112machine # [ 17.527807] systemd[1]: Reloaded D-Bus System Message Bus.1113machine # restarting the following units: network-addresses-eth1.service1114machine # [ 17.532971] systemd[1]: Stopping Address configuration of eth1...1115machine # [ 17.553391] network-addresses-eth1-pre-stop[1067]: deleting address 192.168.1.1/24... done1116machine # [ 17.558327] network-addresses-eth1-pre-stop[1067]: deleting address 2001:db8:1::1/64... done1117machine # [ 17.563595] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1118machine # [ 17.565268] systemd[1]: Stopped Address configuration of eth1.1119machine # [ 17.568876] systemd[1]: Starting Address configuration of eth1...1120machine # [ 17.599617] network-addresses-eth1-start[1072]: adding address 192.168.1.2/24... done1121machine # [ 17.605453] network-addresses-eth1-start[1072]: adding address 2001:db8:1::2/64... done1122machine # [ 17.613260] systemd[1]: Finished Address configuration of eth1.1123machine # [ 17.616495] systemd[1]: Reached target Remote File Systems.1124machine # [ 17.624291] systemd[1]: Reached target Local File Systems.1125machine # [ 17.626205] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1126machine # [ 17.628884] systemd[1]: Starting Create SUID/SGID Wrappers...1127machine # [ 17.630728] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1128machine # [ 17.633063] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671129machine # [ 17.635035] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1130machine # [ 17.636422] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1131machine # [ 17.639297] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1132machine # [ 17.644779] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1133machine # [ 17.646386] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1134machine # [ 17.791408] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1135machine # [ 17.793085] systemd[1]: Finished Create SUID/SGID Wrappers.1136machine # [ 17.796958] systemd[1]: Starting linger-users.service...1137machine # [ 17.816902] linger-users-start[1144]: id: ‘usertest’: no such user1138machine # [ 17.818514] linger-users-start[1142]: Removing linger for missing user usertest1139machine # [ 17.823388] systemd[1]: linger-users.service: Deactivated successfully.1140machine # [ 17.824865] systemd[1]: Finished linger-users.service.1141machine # [ 18.081712] nixos[984]: finished switching to system configuration /nix/store/i9jcnlzym20jsiyzfybbj8a69nlxxck0-nixos-system-other-test1142machine: (finished: must succeed: /nix/store/hfxhmbp4ynsblplki1wvrcfg9cagq9vd-stderr-runner /nix/store/i9jcnlzym20jsiyzfybbj8a69nlxxck0-nixos-system-other-test/bin/switch-to-configuration test, in 1.58 seconds)1143subtest: pre-switch checks1144machine: must succeed: /nix/store/hfxhmbp4ynsblplki1wvrcfg9cagq9vd-stderr-runner /nix/store/i9jcnlzym20jsiyzfybbj8a69nlxxck0-nixos-system-other-test/bin/switch-to-configuration check1145machine # this should succeed (config: /nix/store/i9jcnlzym20jsiyzfybbj8a69nlxxck0-nixos-system-other-test, action: check)1146machine # Checking switch inhibitors... done1147machine: (finished: must succeed: /nix/store/hfxhmbp4ynsblplki1wvrcfg9cagq9vd-stderr-runner /nix/store/i9jcnlzym20jsiyzfybbj8a69nlxxck0-nixos-system-other-test/bin/switch-to-configuration check, in 0.06 seconds)1148machine: must fail: /nix/store/i9jcnlzym20jsiyzfybbj8a69nlxxck0-nixos-system-other-test/specialisation/failingCheck/bin/switch-to-configuration check 2>&11149machine: (finished: must fail: /nix/store/i9jcnlzym20jsiyzfybbj8a69nlxxck0-nixos-system-other-test/specialisation/failingCheck/bin/switch-to-configuration check 2>&1, in 0.02 seconds)1150machine: must fail: /nix/store/i9jcnlzym20jsiyzfybbj8a69nlxxck0-nixos-system-other-test/specialisation/failingMidCheck/bin/switch-to-configuration check 2>&11151machine: (finished: must fail: /nix/store/i9jcnlzym20jsiyzfybbj8a69nlxxck0-nixos-system-other-test/specialisation/failingMidCheck/bin/switch-to-configuration check 2>&1, in 0.02 seconds)1152(finished: subtest: pre-switch checks, in 0.11 seconds)1153subtest: switch inhibitors1154machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&11155machine # [ 18.408556] nixos[1172]: switching to system configuration /nix/store/7y1nccw4yd2hycif8dqx4s2fzhjkq8r5-nixos-system-machine-test1156machine # [ 18.410804] systemd[1]: Stopped target Remote File Systems.1157machine # [ 18.412416] systemd[1]: Stopped target Local File Systems.1158machine # [ 18.618677] systemd[1]: Reload requested from client PID 1172 ('.switch-to-conf') (unit backdoor.service)...1159machine # [ 18.620371] systemd[1]: Reloading...1160machine # [ 18.859885] systemd[1]: Reloading finished in 237 ms.1161machine # [ 18.923199] systemd[615]: Reexecution requested from client PID 1243 ('switch-to-confi')...1162machine # [ 18.925132] systemd[615]: Reexecuting.1163machine # [ 18.945295] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1164machine # [ 19.021542] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1165machine # [ 19.026991] systemd[615]: Reload requested from client PID 1243 ('switch-to-confi')...1166machine # [ 19.028675] systemd[615]: Reloading...1167machine # [ 19.103339] systemd[615]: Reloading finished in 73 ms.1168machine # [ 19.109035] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1169machine # [ 19.117552] systemd[615]: Stopped Run user-specific NixOS activation.1170machine # [ 19.119227] systemd[615]: Stopping Run user-specific NixOS activation...1171machine # [ 19.121491] systemd[615]: Starting Run user-specific NixOS activation...1172machine # [ 19.142412] systemd[615]: Finished Run user-specific NixOS activation.1173machine # [ 19.145566] systemd[1]: Stopped target Reactivate sysinit units.1174machine # [ 19.146950] systemd[1]: Stopping Reactivate sysinit units...1175machine # [ 19.148191] systemd[1]: Reached target Reactivate sysinit units.1176machine # [ 19.150941] dbus-broker-launch[495]: Caught SIGHUP, trigger reload.1177machine # [ 19.152398] systemd[1]: Reloading D-Bus System Message Bus...1178machine # [ 19.156270] dbus-broker-launch[495]: Looking up NSS user entry for 'systemd-timesync'...1179machine # [ 19.158345] dbus-broker-launch[495]: NSS returned no entry for 'systemd-timesync'1180machine # [ 19.159473] dbus-broker-launch[495]: Invalid user-name in /nix/store/hhnipdh1adrbhs1xz6rc4lk05jsfkx89-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1181machine # [ 19.166516] systemd[1]: Reloaded D-Bus System Message Bus.1182machine # [ 19.170995] systemd[1]: Stopping Address configuration of eth1...1183machine # [ 19.190417] network-addresses-eth1-pre-stop[1255]: deleting address 192.168.1.2/24... done1184machine # [ 19.195300] network-addresses-eth1-pre-stop[1255]: deleting address 2001:db8:1::2/64... done1185machine # [ 19.199931] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1186machine # [ 19.201789] systemd[1]: Stopped Address configuration of eth1.1187machine # [ 19.205184] systemd[1]: Starting Address configuration of eth1...1188machine # [ 19.233837] network-addresses-eth1-start[1260]: adding address 192.168.1.1/24... done1189machine # [ 19.239089] network-addresses-eth1-start[1260]: adding address 2001:db8:1::1/64... done1190machine # [ 19.246637] systemd[1]: Finished Address configuration of eth1.1191machine # [ 19.250779] systemd[1]: Reached target Local File Systems.1192machine # [ 19.253232] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1193machine # [ 19.256405] systemd[1]: Starting Create SUID/SGID Wrappers...1194machine # [ 19.257275] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1195machine # [ 19.258420] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671196machine # [ 19.261470] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1197machine # [ 19.264260] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1198machine # [ 19.267241] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1199machine # [ 19.268434] systemd[1]: Reached target Remote File Systems.1200machine # [ 19.276060] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1201machine # [ 19.277740] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1202machine # [ 19.396285] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1203machine # [ 19.398083] systemd[1]: Finished Create SUID/SGID Wrappers.1204machine # [ 19.402318] systemd[1]: Starting linger-users.service...1205machine # [ 19.424709] systemd[1]: linger-users.service: Deactivated successfully.1206machine # [ 19.426209] systemd[1]: Finished linger-users.service.1207machine # [ 19.682801] nixos[1172]: finished switching to system configuration /nix/store/7y1nccw4yd2hycif8dqx4s2fzhjkq8r5-nixos-system-machine-test1208machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&1, in 1.49 seconds)1209machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/inhibitors/bin/switch-to-configuration switch 2>&11210machine # [ 19.882473] nixos[1329]: switching to system configuration /nix/store/v9qc8dq6vvri8512mq4941hv2dl2hl5z-nixos-system-machine-test1211machine # [ 19.885354] systemd[1]: Stopped target Local File Systems.1212machine # [ 19.886649] systemd[1]: Stopped target Remote File Systems.1213machine # [ 20.094166] systemd[1]: Reload requested from client PID 1329 ('.switch-to-conf') (unit backdoor.service)...1214machine # [ 20.095880] systemd[1]: Reloading...1215machine # [ 20.331807] systemd[1]: Reloading finished in 234 ms.1216machine # [ 20.386745] systemd[615]: Reexecution requested from client PID 1399 ('switch-to-confi')...1217machine # [ 20.388681] systemd[615]: Reexecuting.1218machine # [ 20.406974] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1219machine # [ 20.471895] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1220machine # [ 20.476900] systemd[615]: Reload requested from client PID 1399 ('switch-to-confi')...1221machine # [ 20.479096] systemd[615]: Reloading...1222machine # [ 20.545805] systemd[615]: Reloading finished in 66 ms.1223machine # [ 20.550970] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1224machine # [ 20.557337] systemd[615]: Stopped Run user-specific NixOS activation.1225machine # [ 20.559123] systemd[615]: Stopping Run user-specific NixOS activation...1226machine # [ 20.561056] systemd[615]: Starting Run user-specific NixOS activation...1227machine # [ 20.581565] systemd[615]: Finished Run user-specific NixOS activation.1228machine # [ 20.584881] systemd[1]: Stopped target Reactivate sysinit units.1229machine # [ 20.586292] systemd[1]: Stopping Reactivate sysinit units...1230machine # [ 20.587353] systemd[1]: Reached target Reactivate sysinit units.1231machine # [ 20.590866] systemd[1]: Reached target Local File Systems.1232machine # [ 20.592298] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1233machine # [ 20.599351] systemd[1]: Starting Create SUID/SGID Wrappers...1234machine # [ 20.600245] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1235machine # [ 20.601475] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671236machine # [ 20.603436] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1237machine # [ 20.606138] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1238machine # [ 20.607367] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1239machine # [ 20.609495] systemd[1]: Reached target Remote File Systems.1240machine # [ 20.613632] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1241machine # [ 20.614901] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1242machine # [ 20.745133] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1243machine # [ 20.746866] systemd[1]: Finished Create SUID/SGID Wrappers.1244machine # [ 20.751203] systemd[1]: Starting linger-users.service...1245machine # [ 20.779945] systemd[1]: linger-users.service: Deactivated successfully.1246machine # [ 20.781532] systemd[1]: Finished linger-users.service.1247machine # [ 21.036130] nixos[1329]: finished switching to system configuration /nix/store/v9qc8dq6vvri8512mq4941hv2dl2hl5z-nixos-system-machine-test1248machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/inhibitors/bin/switch-to-configuration switch 2>&1, in 1.35 seconds)1249machine: must fail: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration switch 2>&11250machine: (finished: must fail: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration switch 2>&1, in 0.02 seconds)1251machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration boot 2>&11252machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration boot 2>&1, in 0.02 seconds)1253machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration dry-activate 2>&11254machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration dry-activate 2>&1, in 0.21 seconds)1255machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/inhibitors_new/bin/switch-to-configuration switch 2>&11256machine # [ 21.485782] nixos[1494]: switching to system configuration /nix/store/gcrb9xipbhfrkssnknjglhzacbdrql2x-nixos-system-machine-test1257machine # [ 21.488635] systemd[1]: Stopped target Remote File Systems.1258machine # [ 21.489746] systemd[1]: Stopped target Local File Systems.1259machine # [ 21.696307] systemd[1]: Reload requested from client PID 1494 ('.switch-to-conf') (unit backdoor.service)...1260machine # [ 21.697700] systemd[1]: Reloading...1261machine # [ 21.931174] systemd[1]: Reloading finished in 231 ms.1262machine # [ 21.994178] systemd[615]: Reexecution requested from client PID 1565 ('switch-to-confi')...1263machine # [ 21.996190] systemd[615]: Reexecuting.1264machine # [ 22.016529] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1265machine # [ 22.087954] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1266machine # [ 22.093762] systemd[615]: Reload requested from client PID 1565 ('switch-to-confi')...1267machine # [ 22.094894] systemd[615]: Reloading...1268machine # [ 22.170586] systemd[615]: Reloading finished in 74 ms.1269machine # [ 22.176835] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1270machine # [ 22.184200] systemd[615]: Stopped Run user-specific NixOS activation.1271machine # [ 22.185151] systemd[615]: Stopping Run user-specific NixOS activation...1272machine # [ 22.187231] systemd[615]: Starting Run user-specific NixOS activation...1273machine # [ 22.208167] systemd[615]: Finished Run user-specific NixOS activation.1274machine # [ 22.211317] systemd[1]: Stopped target Reactivate sysinit units.1275machine # [ 22.212679] systemd[1]: Stopping Reactivate sysinit units...1276machine # [ 22.213890] systemd[1]: Reached target Reactivate sysinit units.1277machine # [ 22.218763] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1278machine # [ 22.220925] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1279machine # [ 22.222756] systemd[1]: Reached target Local File Systems.1280machine # [ 22.226317] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1281machine # [ 22.229497] systemd[1]: Starting Create SUID/SGID Wrappers...1282machine # [ 22.231329] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1283machine # [ 22.234459] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671284machine # [ 22.237112] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1285machine # [ 22.238584] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1286machine # [ 22.241329] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1287machine # [ 22.242758] systemd[1]: Reached target Remote File Systems.1288machine # [ 22.381283] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1289machine # [ 22.384135] systemd[1]: Finished Create SUID/SGID Wrappers.1290machine # [ 22.386634] systemd[1]: Starting linger-users.service...1291machine # [ 22.417112] systemd[1]: linger-users.service: Deactivated successfully.1292machine # [ 22.419189] systemd[1]: Finished linger-users.service.1293machine # [ 22.673383] nixos[1494]: finished switching to system configuration /nix/store/gcrb9xipbhfrkssnknjglhzacbdrql2x-nixos-system-machine-test1294machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/inhibitors_new/bin/switch-to-configuration switch 2>&1, in 1.39 seconds)1295machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&11296machine # [ 22.852067] nixos[1636]: switching to system configuration /nix/store/7y1nccw4yd2hycif8dqx4s2fzhjkq8r5-nixos-system-machine-test1297machine # [ 22.854490] systemd[1]: Stopped target Remote File Systems.1298machine # [ 22.856426] systemd[1]: Stopped target Local File Systems.1299machine # [ 23.060421] systemd[1]: Reload requested from client PID 1636 ('.switch-to-conf') (unit backdoor.service)...1300machine # [ 23.062259] systemd[1]: Reloading...1301machine # [ 23.296332] systemd[1]: Reloading finished in 233 ms.1302machine # [ 23.360626] systemd[615]: Reexecution requested from client PID 1706 ('switch-to-confi')...1303machine # [ 23.361917] systemd[615]: Reexecuting.1304machine # [ 23.383199] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1305machine # [ 23.457306] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1306machine # [ 23.462234] systemd[615]: Reload requested from client PID 1706 ('switch-to-confi')...1307machine # [ 23.464574] systemd[615]: Reloading...1308machine # [ 23.534321] systemd[615]: Reloading finished in 70 ms.1309machine # [ 23.539851] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1310machine # [ 23.547115] systemd[615]: Stopped Run user-specific NixOS activation.1311machine # [ 23.547991] systemd[615]: Stopping Run user-specific NixOS activation...1312machine # [ 23.549974] systemd[615]: Starting Run user-specific NixOS activation...1313machine # [ 23.570093] systemd[615]: Finished Run user-specific NixOS activation.1314machine # [ 23.573416] systemd[1]: Stopped target Reactivate sysinit units.1315machine # [ 23.574564] systemd[1]: Stopping Reactivate sysinit units...1316machine # [ 23.575856] systemd[1]: Reached target Reactivate sysinit units.1317machine # [ 23.578524] systemd[1]: Reached target Remote File Systems.1318machine # [ 23.581127] systemd[1]: Reached target Local File Systems.1319machine # [ 23.583245] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1320machine # [ 23.585930] systemd[1]: Starting Create SUID/SGID Wrappers...1321machine # [ 23.588150] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1322machine # [ 23.590686] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671323machine # [ 23.593570] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1324machine # [ 23.595122] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1325machine # [ 23.598330] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1326machine # [ 23.606718] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1327machine # [ 23.608324] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1328machine # [ 23.736805] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1329machine # [ 23.740323] systemd[1]: Finished Create SUID/SGID Wrappers.1330machine # [ 23.742765] systemd[1]: Starting linger-users.service...1331machine # [ 23.773142] systemd[1]: linger-users.service: Deactivated successfully.1332machine # [ 23.774796] systemd[1]: Finished linger-users.service.1333machine # [ 24.029924] nixos[1636]: finished switching to system configuration /nix/store/7y1nccw4yd2hycif8dqx4s2fzhjkq8r5-nixos-system-machine-test1334machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&1, in 1.36 seconds)1335(finished: subtest: switch inhibitors, in 5.84 seconds)1336subtest: actions1337machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration boot 2>&11338machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration boot 2>&1, in 0.03 seconds)1339machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/bin/switch-to-configuration switch 2>&11340machine # [ 24.230208] nixos[1784]: switching to system configuration /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test1341machine # [ 24.232711] systemd[1]: Stopped target Remote File Systems.1342machine # [ 24.234525] systemd[1]: Stopped target Local File Systems.1343machine # [ 24.445377] systemd[1]: Reload requested from client PID 1784 ('.switch-to-conf') (unit backdoor.service)...1344machine # [ 24.446985] systemd[1]: Reloading...1345machine # [ 24.710645] systemd[1]: Reloading finished in 262 ms.1346machine # [ 24.794192] systemd[615]: Reexecution requested from client PID 1854 ('switch-to-confi')...1347machine # [ 24.796202] systemd[615]: Reexecuting.1348machine # [ 24.816473] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1349machine # [ 24.887099] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1350machine # [ 24.893375] systemd[615]: Reload requested from client PID 1854 ('switch-to-confi')...1351machine # [ 24.894613] systemd[615]: Reloading...1352machine # [ 24.967813] systemd[615]: Reloading finished in 71 ms.1353machine # [ 24.973929] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1354machine # [ 24.981091] systemd[615]: Stopped Run user-specific NixOS activation.1355machine # [ 24.982316] systemd[615]: Stopping Run user-specific NixOS activation...1356machine # [ 24.984616] systemd[615]: Starting Run user-specific NixOS activation...1357machine # [ 25.006789] systemd[615]: Finished Run user-specific NixOS activation.1358machine # [ 25.010396] systemd[1]: Stopped target Reactivate sysinit units.1359machine # [ 25.011602] systemd[1]: Stopping Reactivate sysinit units...1360machine # [ 25.012843] systemd[1]: Reached target Reactivate sysinit units.1361machine # [ 25.015433] systemd[1]: Reached target Local File Systems.1362machine # [ 25.019335] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1363machine # [ 25.024661] systemd[1]: Starting Create SUID/SGID Wrappers...1364machine # [ 25.025574] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1365machine # [ 25.026843] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671366machine # [ 25.028837] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1367machine # [ 25.030259] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1368machine # [ 25.031563] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1369machine # [ 25.037430] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1370machine # [ 25.038741] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1371machine # [ 25.046216] systemd[1]: Reached target Remote File Systems.1372machine # [ 25.177464] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1373machine # [ 25.179775] systemd[1]: Finished Create SUID/SGID Wrappers.1374machine # [ 25.183688] systemd[1]: Starting linger-users.service...1375machine # [ 25.214697] systemd[1]: linger-users.service: Deactivated successfully.1376machine # [ 25.217197] systemd[1]: Finished linger-users.service.1377machine # [ 25.473731] nixos[1784]: finished switching to system configuration /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test1378machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/bin/switch-to-configuration switch 2>&1, in 1.42 seconds)1379machine: must fail: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/bin/switch-to-configuration broken-action 2>&11380machine: (finished: must fail: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/bin/switch-to-configuration broken-action 2>&1, in 0.03 seconds)1381machine: must fail: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/bin/switch-to-configuration 2>&11382machine: (finished: must fail: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/bin/switch-to-configuration 2>&1, in 0.03 seconds)1383(finished: subtest: actions, in 1.51 seconds)1384subtest: init interface version1385machine: must fail: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/brokenInitInterface/bin/switch-to-configuration test 2>&11386machine: (finished: must fail: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/brokenInitInterface/bin/switch-to-configuration test 2>&1, in 0.03 seconds)1387(finished: subtest: init interface version, in 0.03 seconds)1388subtest: systemd restarts1389machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&11390machine # [ 25.739727] nixos[1941]: switching to system configuration /nix/store/hr12249ckni06ixysm6jp63yvb4fl08s-nixos-system-machine-test1391machine # [ 25.742459] systemd[1]: Stopped target Remote File Systems.1392machine # [ 25.743869] systemd[1]: Stopped target Local File Systems.1393machine # [ 25.976661] systemd[1]: Reexecution requested from client PID 1941 ('.switch-to-conf') (unit backdoor.service)...1394machine # [ 25.980557] systemd[1]: Reexecuting.1395machine # [ 26.268883] systemd[1]: systemd 263-c676df8 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 +EXPERIMENTAL-ENVVAR)1396machine # [ 26.276438] systemd[1]: Detected virtualization kvm.1397machine # [ 26.278407] systemd[1]: Detected architecture x86-64.1398machine # [ 26.369689] systemd[1]: bpf-restrict-fs: LSM BPF program attached1399machine # [ 26.461822] systemd[1]: Reload requested from client PID 1941 ('.switch-to-conf') (unit backdoor.service)...1400machine # [ 26.463462] systemd[1]: Reloading...1401machine # [ 26.701290] systemd[1]: Reloading finished in 236 ms.1402machine # [ 26.761437] systemd[615]: Reexecution requested from client PID 2044 ('switch-to-confi')...1403machine # [ 26.763835] systemd[615]: Reexecuting.1404machine # [ 26.785168] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1405machine # [ 26.856864] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1406machine # [ 26.861894] systemd[615]: Reload requested from client PID 2044 ('switch-to-confi')...1407machine # [ 26.863174] systemd[615]: Reloading...1408machine # [ 26.936193] systemd[615]: Reloading finished in 71 ms.1409machine # [ 26.941840] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1410machine # [ 26.948087] systemd[615]: Stopped Run user-specific NixOS activation.1411machine # [ 26.950074] systemd[615]: Stopping Run user-specific NixOS activation...1412machine # [ 26.951654] systemd[615]: Starting Run user-specific NixOS activation...1413machine # [ 26.972394] systemd[615]: Finished Run user-specific NixOS activation.1414machine # [ 26.975809] systemd[1]: Stopped target Reactivate sysinit units.1415machine # [ 26.977529] systemd[1]: Stopping Reactivate sysinit units...1416machine # [ 26.978698] systemd[1]: Reached target Reactivate sysinit units.1417machine # [ 26.981287] systemd[1]: Reached target Local File Systems.1418machine # [ 26.983353] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1419machine # [ 26.985729] systemd[1]: Starting Create SUID/SGID Wrappers...1420machine # [ 26.987749] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1421machine # [ 26.989606] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671422machine # [ 26.991502] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1423machine # [ 26.992887] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1424machine # [ 26.996120] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1425machine # [ 27.000832] systemd[1]: Reached target Remote File Systems.1426machine # [ 27.004102] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1427machine # [ 27.005330] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1428machine # [ 27.136632] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1429machine # [ 27.138491] systemd[1]: Finished Create SUID/SGID Wrappers.1430machine # [ 27.142981] systemd[1]: Starting linger-users.service...1431machine # [ 27.171094] systemd[1]: linger-users.service: Deactivated successfully.1432machine # [ 27.172572] systemd[1]: Finished linger-users.service.1433machine # [ 27.430447] nixos[1941]: finished switching to system configuration /nix/store/hr12249ckni06ixysm6jp63yvb4fl08s-nixos-system-machine-test1434machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&1, in 1.87 seconds)1435(finished: subtest: systemd restarts, in 1.87 seconds)1436subtest: continuing from an aborted switch1437machine: must succeed: echo dbus-broker.service > /run/nixos/start-list1438machine: (finished: must succeed: echo dbus-broker.service > /run/nixos/start-list, in 0.02 seconds)1439machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&11440machine # [ 27.638206] nixos[2118]: switching to system configuration /nix/store/hr12249ckni06ixysm6jp63yvb4fl08s-nixos-system-machine-test1441machine # [ 27.641459] systemd[1]: Stopped target Local File Systems.1442machine # [ 27.642653] systemd[1]: Stopped target Remote File Systems.1443machine # [ 27.884471] systemd[1]: Reload requested from client PID 2118 ('.switch-to-conf') (unit backdoor.service)...1444machine # [ 27.886399] systemd[1]: Reloading...1445machine # [ 28.130330] systemd[1]: Reloading finished in 241 ms.1446machine # [ 28.195298] systemd[615]: Reexecution requested from client PID 2188 ('switch-to-confi')...1447machine # [ 28.198163] systemd[615]: Reexecuting.1448machine # [ 28.219291] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1449machine # [ 28.293531] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1450machine # [ 28.298837] systemd[615]: Reload requested from client PID 2188 ('switch-to-confi')...1451machine # [ 28.301118] systemd[615]: Reloading...1452machine # [ 28.372670] systemd[615]: Reloading finished in 71 ms.1453machine # [ 28.377875] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1454machine # [ 28.384846] systemd[615]: Stopped Run user-specific NixOS activation.1455machine # [ 28.386404] systemd[615]: Stopping Run user-specific NixOS activation...1456machine # [ 28.388868] systemd[615]: Starting Run user-specific NixOS activation...1457machine # [ 28.410862] systemd[615]: Finished Run user-specific NixOS activation.1458machine # [ 28.414141] systemd[1]: Stopped target Reactivate sysinit units.1459machine # [ 28.415818] systemd[1]: Stopping Reactivate sysinit units...1460machine # [ 28.416724] systemd[1]: Reached target Reactivate sysinit units.1461machine # [ 28.420077] systemd[1]: Reached target Remote File Systems.1462machine # [ 28.423078] systemd[1]: Starting linger-users.service...1463machine # [ 28.430071] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1464machine # [ 28.431333] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1465machine # [ 28.433725] systemd[1]: Reached target Local File Systems.1466machine # [ 28.438125] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1467machine # [ 28.440900] systemd[1]: Starting Create SUID/SGID Wrappers...1468machine # [ 28.442939] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1469machine # [ 28.445843] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671470machine # [ 28.448776] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1471machine # [ 28.453310] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1472machine # [ 28.455372] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1473machine # [ 28.494922] systemd[1]: linger-users.service: Deactivated successfully.1474machine # [ 28.497493] systemd[1]: Finished linger-users.service.1475machine # [ 28.611164] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1476machine # [ 28.612786] systemd[1]: Finished Create SUID/SGID Wrappers.1477machine # [ 28.871500] nixos[2118]: finished switching to system configuration /nix/store/hr12249ckni06ixysm6jp63yvb4fl08s-nixos-system-machine-test1478machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&1, in 1.42 seconds)1479(finished: subtest: continuing from an aborted switch, in 1.44 seconds)1480subtest: aborts on already locked lock file1481??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.1482 File "/nix/store/9a17m19ckncxr4bg1lfalvqxs7gnfj0f-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 391483machine # Could not acquire lock1484(finished: subtest: aborts on already locked lock file, in 0.06 seconds)1485subtest: fstab mounts1486machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/bin/switch-to-configuration test 2>&11487machine # [ 29.123731] nixos[2264]: switching to system configuration /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test1488machine # [ 29.127741] systemd[1]: Stopped target Local File Systems.1489machine # [ 29.129196] systemd[1]: Stopped target Remote File Systems.1490machine # [ 29.342237] systemd[1]: Reexecution requested from client PID 2264 ('.switch-to-conf') (unit backdoor.service)...1491machine # [ 29.345099] systemd[1]: Reexecuting.1492machine # [ 29.638170] systemd[1]: systemd 263-c676df8 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 +EXPERIMENTAL-ENVVAR)1493machine # [ 29.646418] systemd[1]: Detected virtualization kvm.1494machine # [ 29.648364] systemd[1]: Detected architecture x86-64.1495machine # [ 29.741404] systemd[1]: bpf-restrict-fs: LSM BPF program attached1496machine # [ 29.839682] systemd[1]: Reload requested from client PID 2264 ('.switch-to-conf') (unit backdoor.service)...1497machine # [ 29.841396] systemd[1]: Reloading...1498machine # [ 30.083642] systemd[1]: Reloading finished in 240 ms.1499machine # [ 30.147694] systemd[615]: Reexecution requested from client PID 2367 ('switch-to-confi')...1500machine # [ 30.149389] systemd[615]: Reexecuting.1501machine # [ 30.169201] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1502machine # [ 30.243660] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1503machine # [ 30.249232] systemd[615]: Reload requested from client PID 2367 ('switch-to-confi')...1504machine # [ 30.250608] systemd[615]: Reloading...1505machine # [ 30.323972] systemd[615]: Reloading finished in 72 ms.1506machine # [ 30.328826] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1507machine # [ 30.335341] systemd[615]: Stopped Run user-specific NixOS activation.1508machine # [ 30.337071] systemd[615]: Stopping Run user-specific NixOS activation...1509machine # [ 30.338807] systemd[615]: Starting Run user-specific NixOS activation...1510machine # [ 30.359086] systemd[615]: Finished Run user-specific NixOS activation.1511machine # [ 30.362318] systemd[1]: Stopped target Reactivate sysinit units.1512machine # [ 30.363925] systemd[1]: Stopping Reactivate sysinit units...1513machine # [ 30.365186] systemd[1]: Reached target Reactivate sysinit units.1514machine # [ 30.369832] systemd[1]: Reached target Local File Systems.1515machine # [ 30.371493] systemd[1]: Reached target Remote File Systems.1516machine # [ 30.373560] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1517machine # [ 30.375262] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1518machine # [ 30.379317] systemd[1]: Starting linger-users.service...1519machine # [ 30.388140] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1520machine # [ 30.394095] systemd[1]: Starting Create SUID/SGID Wrappers...1521machine # [ 30.394873] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1522machine # [ 30.396329] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671523machine # [ 30.398884] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1524machine # [ 30.401140] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1525machine # [ 30.402392] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1526machine # [ 30.436822] systemd[1]: linger-users.service: Deactivated successfully.1527machine # [ 30.438602] systemd[1]: Finished linger-users.service.1528machine # [ 30.561070] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1529machine # [ 30.562201] systemd[1]: Finished Create SUID/SGID Wrappers.1530machine # [ 30.816578] nixos[2264]: finished switching to system configuration /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test1531machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.88 seconds)1532machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&11533machine # [ 31.044372] nixos[2438]: switching to system configuration /nix/store/2236pwj7p9sgs5sydc7b2wj2h7sz8777-nixos-system-machine-test1534machine # [ 31.047355] systemd[1]: Stopped target Remote File Systems.1535machine # [ 31.048888] systemd[1]: Stopped target Local File Systems.1536machine # [ 31.286155] systemd[1]: Reload requested from client PID 2438 ('.switch-to-conf') (unit backdoor.service)...1537machine # [ 31.287819] systemd[1]: Reloading...1538machine # [ 31.524688] systemd[1]: Reloading finished in 235 ms.1539machine # [ 31.586359] systemd[615]: Reexecution requested from client PID 2508 ('switch-to-confi')...1540machine # [ 31.588247] systemd[615]: Reexecuting.1541machine # [ 31.608097] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1542machine # [ 31.679783] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1543machine # [ 31.685044] systemd[615]: Reload requested from client PID 2508 ('switch-to-confi')...1544machine # [ 31.686358] systemd[615]: Reloading...1545machine # [ 31.757824] systemd[615]: Reloading finished in 69 ms.1546machine # [ 31.762875] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1547machine # [ 31.770103] systemd[615]: Stopped Run user-specific NixOS activation.1548machine # [ 31.771069] systemd[615]: Stopping Run user-specific NixOS activation...1549machine # [ 31.772666] systemd[615]: Starting Run user-specific NixOS activation...1550machine # [ 31.794387] systemd[615]: Finished Run user-specific NixOS activation.1551machine # [ 31.797811] systemd[1]: Stopped target Reactivate sysinit units.1552machine # [ 31.799176] systemd[1]: Stopping Reactivate sysinit units...1553machine # [ 31.799903] systemd[1]: Reached target Reactivate sysinit units.1554machine # [ 31.803714] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1555machine # [ 31.806263] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1556machine # [ 31.807505] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1557machine # [ 31.811059] systemd[1]: Starting Create SUID/SGID Wrappers...1558machine # [ 31.811836] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671559machine # [ 31.815222] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1560machine # [ 31.817359] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1561machine # [ 31.818537] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1562machine # [ 31.825217] systemd[1]: Reached target Remote File Systems.1563machine # [ 31.957250] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1564machine # [ 31.959440] systemd[1]: Finished Create SUID/SGID Wrappers.1565machine # [ 32.151094] systemd[1]: Mounting /test...1566machine # [ 32.169258] systemd[1]: Mounted /test.1567machine # [ 32.171294] systemd[1]: Reached target Local File Systems.1568machine # [ 32.173287] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1569machine # [ 32.176070] systemd[1]: Starting linger-users.service...1570machine # [ 32.203061] systemd[1]: linger-users.service: Deactivated successfully.1571machine # [ 32.205298] systemd[1]: Finished linger-users.service.1572machine # [ 32.462525] nixos[2438]: finished switching to system configuration /nix/store/2236pwj7p9sgs5sydc7b2wj2h7sz8777-nixos-system-machine-test1573machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&1, in 1.65 seconds)1574machine: must succeed: systemctl stop test.mount1575machine # [ 32.500258] systemd[1]: Stopped target Local File Systems.1576machine # [ 32.507190] systemd[1]: Unmounting /test...1577machine # [ 32.538513] systemd[1]: test.mount: Deactivated successfully.1578machine # [ 32.539462] systemd[1]: Unmounted /test.1579machine: (finished: must succeed: systemctl stop test.mount, in 0.07 seconds)1580machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&11581machine # [ 32.720563] nixos[2587]: switching to system configuration /nix/store/2236pwj7p9sgs5sydc7b2wj2h7sz8777-nixos-system-machine-test1582machine # [ 32.723696] systemd[1]: Stopped target Remote File Systems.1583machine # [ 32.931704] systemd[1]: Reload requested from client PID 2587 ('.switch-to-conf') (unit backdoor.service)...1584machine # [ 32.933438] systemd[1]: Reloading...1585machine # [ 33.172923] systemd[1]: Reloading finished in 238 ms.1586machine # [ 33.236760] systemd[615]: Reexecution requested from client PID 2656 ('switch-to-confi')...1587machine # [ 33.238459] systemd[615]: Reexecuting.1588machine # [ 33.254889] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1589machine # [ 33.326767] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1590machine # [ 33.331859] systemd[615]: Reload requested from client PID 2656 ('switch-to-confi')...1591machine # [ 33.333552] systemd[615]: Reloading...1592machine # [ 33.403189] systemd[615]: Reloading finished in 68 ms.1593machine # [ 33.408850] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1594machine # [ 33.414920] systemd[615]: Stopped Run user-specific NixOS activation.1595machine # [ 33.415878] systemd[615]: Stopping Run user-specific NixOS activation...1596machine # [ 33.418504] systemd[615]: Starting Run user-specific NixOS activation...1597machine # [ 33.439805] systemd[615]: Finished Run user-specific NixOS activation.1598machine # [ 33.442922] systemd[1]: Stopped target Reactivate sysinit units.1599machine # [ 33.444246] systemd[1]: Stopping Reactivate sysinit units...1600machine # [ 33.445252] systemd[1]: Reached target Reactivate sysinit units.1601machine # [ 33.451317] systemd[1]: Mounting /test...1602machine # [ 33.451931] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1603machine # [ 33.455155] systemd[1]: Starting Create SUID/SGID Wrappers...1604machine # [ 33.455911] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671605machine # [ 33.458987] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1606machine # [ 33.461546] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1607machine # [ 33.462689] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1608machine # [ 33.466691] systemd[1]: Reached target Remote File Systems.1609machine # [ 33.477563] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1610machine # [ 33.479658] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1611machine # [ 33.496679] systemd[1]: Mounted /test.1612machine # [ 33.500720] systemd[1]: Reached target Local File Systems.1613machine # [ 33.501510] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1614machine # [ 33.612811] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1615machine # [ 33.615255] systemd[1]: Finished Create SUID/SGID Wrappers.1616machine # [ 33.618529] systemd[1]: Starting linger-users.service...1617machine # [ 33.647850] systemd[1]: linger-users.service: Deactivated successfully.1618machine # [ 33.649420] systemd[1]: Finished linger-users.service.1619machine # [ 33.906961] nixos[2587]: finished switching to system configuration /nix/store/2236pwj7p9sgs5sydc7b2wj2h7sz8777-nixos-system-machine-test1620machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&1, in 1.37 seconds)1621machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/addedMountOptsModified/bin/switch-to-configuration test 2>&11622machine # [ 34.119423] nixos[2729]: switching to system configuration /nix/store/dx31syyrawlr43r21jmsjrvz7l8454q7-nixos-system-machine-test1623machine # [ 34.121741] systemd[1]: Stopped target Local File Systems.1624machine # [ 34.123415] systemd[1]: Stopped target Remote File Systems.1625machine # [ 34.388795] systemd[1]: Reload requested from client PID 2729 ('.switch-to-conf') (unit backdoor.service)...1626machine # [ 34.390478] systemd[1]: Reloading...1627machine # [ 34.643766] systemd[1]: Reloading finished in 251 ms.1628machine # [ 34.705357] systemd[615]: Reexecution requested from client PID 2799 ('switch-to-confi')...1629machine # [ 34.706628] systemd[615]: Reexecuting.1630machine # [ 34.727305] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1631machine # [ 34.795319] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1632machine # [ 34.800736] systemd[615]: Reload requested from client PID 2799 ('switch-to-confi')...1633machine # [ 34.802062] systemd[615]: Reloading...1634machine # [ 34.871943] systemd[615]: Reloading finished in 68 ms.1635machine # [ 34.877825] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1636machine # [ 34.884078] systemd[615]: Stopped Run user-specific NixOS activation.1637machine # [ 34.885971] systemd[615]: Stopping Run user-specific NixOS activation...1638machine # [ 34.887545] systemd[615]: Starting Run user-specific NixOS activation...1639machine # [ 34.907650] systemd[615]: Finished Run user-specific NixOS activation.1640machine # [ 34.910816] systemd[1]: Stopped target Reactivate sysinit units.1641machine # [ 34.912333] systemd[1]: Stopping Reactivate sysinit units...1642machine # [ 34.913389] systemd[1]: Reached target Reactivate sysinit units.1643machine # [ 34.915555] systemd[1]: Reloading /test...1644machine # [ 34.932554] systemd[1]: Reloaded /test.1645machine # [ 34.937389] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1646machine # [ 34.939161] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1647machine # [ 34.942685] systemd[1]: Reached target Remote File Systems.1648machine # [ 34.945432] systemd[1]: Starting linger-users.service...1649machine # [ 34.949566] systemd[1]: Reached target Local File Systems.1650machine # [ 34.956304] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1651machine # [ 34.959849] systemd[1]: Starting Create SUID/SGID Wrappers...1652machine # [ 34.961367] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1653machine # [ 34.962569] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671654machine # [ 34.964519] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1655machine # [ 34.965919] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1656machine # [ 34.967170] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1657machine # [ 35.003563] systemd[1]: linger-users.service: Deactivated successfully.1658machine # [ 35.006132] systemd[1]: Finished linger-users.service.1659machine # [ 35.105097] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1660machine # [ 35.107100] systemd[1]: Finished Create SUID/SGID Wrappers.1661machine # [ 35.362181] nixos[2729]: finished switching to system configuration /nix/store/dx31syyrawlr43r21jmsjrvz7l8454q7-nixos-system-machine-test1662machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/addedMountOptsModified/bin/switch-to-configuration test 2>&1, in 1.45 seconds)1663machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/addedMountDevModified/bin/switch-to-configuration test 2>&11664machine # [ 35.525708] nixos[2872]: switching to system configuration /nix/store/bbfa59y9fgrq9avlhw3r58ii4hhhk146-nixos-system-machine-test1665machine # [ 35.527924] systemd[1]: Stopped target Local File Systems.1666machine # [ 35.529489] systemd[1]: Stopped target Remote File Systems.1667machine # [ 35.764452] systemd[1]: Reload requested from client PID 2872 ('.switch-to-conf') (unit backdoor.service)...1668machine # [ 35.766344] systemd[1]: Reloading...1669machine # [ 35.988464] systemd[1]: Reloading finished in 220 ms.1670machine # [ 36.051353] systemd[615]: Reexecution requested from client PID 2941 ('switch-to-confi')...1671machine # [ 36.052728] systemd[615]: Reexecuting.1672machine # [ 36.073135] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1673machine # [ 36.145149] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1674machine # [ 36.150804] systemd[615]: Reload requested from client PID 2941 ('switch-to-confi')...1675machine # [ 36.152602] systemd[615]: Reloading...1676machine # [ 36.223491] systemd[615]: Reloading finished in 69 ms.1677machine # [ 36.228832] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1678machine # [ 36.235764] systemd[615]: Stopped Run user-specific NixOS activation.1679machine # [ 36.237691] systemd[615]: Stopping Run user-specific NixOS activation...1680machine # [ 36.239204] systemd[615]: Starting Run user-specific NixOS activation...1681machine # [ 36.258342] systemd[615]: Finished Run user-specific NixOS activation.1682machine # [ 36.261330] systemd[1]: Stopped target Reactivate sysinit units.1683machine # [ 36.262625] systemd[1]: Stopping Reactivate sysinit units...1684machine # [ 36.263649] systemd[1]: Reached target Reactivate sysinit units.1685machine # [ 36.265685] systemd[1]: Unmounting /test...1686machine # [ 36.280937] systemd[1]: test.mount: Deactivated successfully.1687machine # [ 36.281900] systemd[1]: Unmounted /test.1688machine # [ 36.285859] systemd[1]: Mounting /test...1689machine # [ 36.302801] systemd[1]: Mounted /test.1690machine # [ 36.307645] systemd[1]: Reached target Remote File Systems.1691machine # [ 36.310119] systemd[1]: Starting linger-users.service...1692machine # [ 36.312976] systemd[1]: Reached target Local File Systems.1693machine # [ 36.315143] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1694machine # [ 36.318244] systemd[1]: Starting Create SUID/SGID Wrappers...1695machine # [ 36.320110] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1696machine # [ 36.321554] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671697machine # [ 36.323484] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1698machine # [ 36.324908] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1699machine # [ 36.328238] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1700machine # [ 36.335578] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1701machine # [ 36.336788] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1702machine # [ 36.375089] systemd[1]: linger-users.service: Deactivated successfully.1703machine # [ 36.376297] systemd[1]: Finished linger-users.service.1704machine # [ 36.479108] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1705machine # [ 36.480883] systemd[1]: Finished Create SUID/SGID Wrappers.1706machine # [ 36.738513] nixos[2872]: finished switching to system configuration /nix/store/bbfa59y9fgrq9avlhw3r58ii4hhhk146-nixos-system-machine-test1707machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/addedMountDevModified/bin/switch-to-configuration test 2>&1, in 1.38 seconds)1708machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&11709machine # [ 36.926359] nixos[3016]: switching to system configuration /nix/store/2236pwj7p9sgs5sydc7b2wj2h7sz8777-nixos-system-machine-test1710machine # [ 36.928672] systemd[1]: Stopped target Remote File Systems.1711machine # [ 36.930732] systemd[1]: Stopped target Local File Systems.1712machine # [ 37.133705] systemd[1]: Reload requested from client PID 3016 ('.switch-to-conf') (unit backdoor.service)...1713machine # [ 37.135438] systemd[1]: Reloading...1714machine # [ 37.385125] systemd[1]: Reloading finished in 247 ms.1715machine # [ 37.479320] systemd[615]: Reexecution requested from client PID 3085 ('switch-to-confi')...1716machine # [ 37.481787] systemd[615]: Reexecuting.1717machine # [ 37.502231] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1718machine # [ 37.572737] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1719machine # [ 37.578481] systemd[615]: Reload requested from client PID 3085 ('switch-to-confi')...1720machine # [ 37.580835] systemd[615]: Reloading...1721machine # [ 37.650420] systemd[615]: Reloading finished in 69 ms.1722machine # [ 37.655852] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1723machine # [ 37.663080] systemd[615]: Stopped Run user-specific NixOS activation.1724machine # [ 37.663985] systemd[615]: Stopping Run user-specific NixOS activation...1725machine # [ 37.665870] systemd[615]: Starting Run user-specific NixOS activation...1726machine # [ 37.689311] systemd[615]: Finished Run user-specific NixOS activation.1727machine # [ 37.692533] systemd[1]: Stopped target Reactivate sysinit units.1728machine # [ 37.694409] systemd[1]: Stopping Reactivate sysinit units...1729machine # [ 37.695627] systemd[1]: Reached target Reactivate sysinit units.1730machine # [ 37.697988] systemd[1]: Unmounting /test...1731machine # [ 37.714221] systemd[1]: test.mount: Deactivated successfully.1732machine # [ 37.715677] systemd[1]: Unmounted /test.1733machine # [ 37.719347] systemd[1]: Mounting /test...1734machine # [ 37.737376] systemd[1]: Mounted /test.1735machine # [ 37.741538] systemd[1]: Reached target Local File Systems.1736machine # [ 37.743308] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1737machine # [ 37.746330] systemd[1]: Starting Create SUID/SGID Wrappers...1738machine # [ 37.748227] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1739machine # [ 37.749578] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671740machine # [ 37.753370] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1741machine # [ 37.756168] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1742machine # [ 37.758074] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1743machine # [ 37.759377] systemd[1]: Reached target Remote File Systems.1744machine # [ 37.769725] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1745machine # [ 37.771732] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1746machine # [ 37.895468] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1747machine # [ 37.898228] systemd[1]: Finished Create SUID/SGID Wrappers.1748machine # [ 37.901414] systemd[1]: Starting linger-users.service...1749machine # [ 37.930622] systemd[1]: linger-users.service: Deactivated successfully.1750machine # [ 37.933056] systemd[1]: Finished linger-users.service.1751machine # [ 38.190422] nixos[3016]: finished switching to system configuration /nix/store/2236pwj7p9sgs5sydc7b2wj2h7sz8777-nixos-system-machine-test1752machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&1, in 1.45 seconds)1753machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/bin/switch-to-configuration test 2>&11754machine # [ 38.398802] nixos[3161]: switching to system configuration /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test1755machine # [ 38.401064] systemd[1]: Stopped target Remote File Systems.1756machine # [ 38.402732] systemd[1]: Stopped target Local File Systems.1757machine # [ 38.405544] systemd[1]: Unmounting /test...1758machine # [ 38.423119] systemd[1]: test.mount: Deactivated successfully.1759machine # [ 38.423910] systemd[1]: Unmounted /test.1760machine # [ 38.625247] systemd[1]: Reload requested from client PID 3161 ('.switch-to-conf') (unit backdoor.service)...1761machine # [ 38.626957] systemd[1]: Reloading...1762machine # [ 38.855191] systemd[1]: Reloading finished in 227 ms.1763machine # [ 38.915427] systemd[615]: Reexecution requested from client PID 3232 ('switch-to-confi')...1764machine # [ 38.917912] systemd[615]: Reexecuting.1765machine # [ 38.938305] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1766machine # [ 39.008343] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1767machine # [ 39.013925] systemd[615]: Reload requested from client PID 3232 ('switch-to-confi')...1768machine # [ 39.016078] systemd[615]: Reloading...1769machine # [ 39.083920] systemd[615]: Reloading finished in 68 ms.1770machine # [ 39.088824] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1771machine # [ 39.095803] systemd[615]: Stopped Run user-specific NixOS activation.1772machine # [ 39.096651] systemd[615]: Stopping Run user-specific NixOS activation...1773machine # [ 39.098242] systemd[615]: Starting Run user-specific NixOS activation...1774machine # [ 39.117260] systemd[615]: Finished Run user-specific NixOS activation.1775machine # [ 39.120493] systemd[1]: Stopped target Reactivate sysinit units.1776machine # [ 39.122094] systemd[1]: Stopping Reactivate sysinit units...1777machine # [ 39.122939] systemd[1]: Reached target Reactivate sysinit units.1778machine # [ 39.124644] systemd[1]: Reached target Local File Systems.1779machine # [ 39.127676] systemd[1]: Reached target Remote File Systems.1780machine # [ 39.130837] systemd[1]: Starting linger-users.service...1781machine # [ 39.134433] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1782machine # [ 39.137129] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1783machine # [ 39.143426] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1784machine # [ 39.149370] systemd[1]: Starting Create SUID/SGID Wrappers...1785machine # [ 39.151780] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1786machine # [ 39.153866] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671787machine # [ 39.156956] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1788machine # [ 39.160555] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1789machine # [ 39.161807] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1790machine # [ 39.194498] systemd[1]: linger-users.service: Deactivated successfully.1791machine # [ 39.196087] systemd[1]: Finished linger-users.service.1792machine # [ 39.303983] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1793machine # [ 39.306206] systemd[1]: Finished Create SUID/SGID Wrappers.1794machine # [ 39.562552] nixos[3161]: finished switching to system configuration /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test1795machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.37 seconds)1796machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/storeMountModified/bin/switch-to-configuration test 2>&11797machine # [ 39.768893] nixos[3303]: switching to system configuration /nix/store/m76gzqhvd7002f16x5sn2g5wia965m7l-nixos-system-machine-test1798machine # [ 39.771161] systemd[1]: Stopped target Remote File Systems.1799machine # [ 39.772799] systemd[1]: Stopped target Local File Systems.1800machine # [ 39.997390] systemd[1]: Reload requested from client PID 3303 ('.switch-to-conf') (unit backdoor.service)...1801machine # [ 39.999164] systemd[1]: Reloading...1802machine # [ 40.250350] systemd[1]: Reloading finished in 248 ms.1803machine # [ 40.313273] systemd[615]: Reexecution requested from client PID 3372 ('switch-to-confi')...1804machine # [ 40.314522] systemd[615]: Reexecuting.1805machine # [ 40.335120] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1806machine # [ 40.406637] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1807machine # [ 40.412474] systemd[615]: Reload requested from client PID 3372 ('switch-to-confi')...1808machine # [ 40.413667] systemd[615]: Reloading...1809machine # [ 40.484108] systemd[615]: Reloading finished in 69 ms.1810machine # [ 40.489835] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1811machine # [ 40.496074] systemd[615]: Stopped Run user-specific NixOS activation.1812machine # [ 40.496978] systemd[615]: Stopping Run user-specific NixOS activation...1813machine # [ 40.499665] systemd[615]: Starting Run user-specific NixOS activation...1814machine # [ 40.519486] systemd[615]: Finished Run user-specific NixOS activation.1815machine # [ 40.522488] systemd[1]: Stopped target Reactivate sysinit units.1816machine # [ 40.523865] systemd[1]: Stopping Reactivate sysinit units...1817machine # [ 40.524804] systemd[1]: Reached target Reactivate sysinit units.1818machine # [ 40.526842] systemd[1]: Reached target Remote File Systems.1819machine # [ 40.529456] systemd[1]: Starting linger-users.service...1820machine # [ 40.537296] systemd[1]: Reached target Local File Systems.1821machine # [ 40.540411] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1822machine # [ 40.544362] systemd[1]: Starting Create SUID/SGID Wrappers...1823machine # [ 40.546158] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1824machine # [ 40.548105] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671825machine # [ 40.551109] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1826machine # [ 40.552553] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1827machine # [ 40.556345] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1828machine # [ 40.557890] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1829machine # [ 40.559119] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1830machine # [ 40.593823] systemd[1]: linger-users.service: Deactivated successfully.1831machine # [ 40.595738] systemd[1]: Finished linger-users.service.1832machine # [ 40.739850] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1833machine # [ 40.742290] systemd[1]: Finished Create SUID/SGID Wrappers.1834machine # [ 40.999591] nixos[3303]: finished switching to system configuration /nix/store/m76gzqhvd7002f16x5sn2g5wia965m7l-nixos-system-machine-test1835machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/storeMountModified/bin/switch-to-configuration test 2>&1, in 1.44 seconds)1836machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/automount/bin/switch-to-configuration test 2>&11837machine # [ 41.210236] nixos[3444]: switching to system configuration /nix/store/fn1lf868qixdw48nmrf78mb29rh11zhw-nixos-system-machine-test1838machine # [ 41.212868] systemd[1]: Stopped target Local File Systems.1839machine # [ 41.214134] systemd[1]: Stopped target Remote File Systems.1840machine # [ 41.440770] systemd[1]: Reload requested from client PID 3444 ('.switch-to-conf') (unit backdoor.service)...1841machine # [ 41.442465] systemd[1]: Reloading...1842machine # [ 41.674963] systemd[1]: Reloading finished in 231 ms.1843machine # [ 41.735571] systemd[615]: Reexecution requested from client PID 3513 ('switch-to-confi')...1844machine # [ 41.737391] systemd[615]: Reexecuting.1845machine # [ 41.758152] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1846machine # [ 41.830395] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1847machine # [ 41.835956] systemd[615]: Reload requested from client PID 3513 ('switch-to-confi')...1848machine # [ 41.838093] systemd[615]: Reloading...1849machine # [ 41.908673] systemd[615]: Reloading finished in 70 ms.1850machine # [ 41.912838] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1851machine # [ 41.918901] systemd[615]: Stopped Run user-specific NixOS activation.1852machine # [ 41.920362] systemd[615]: Stopping Run user-specific NixOS activation...1853machine # [ 41.922505] systemd[615]: Starting Run user-specific NixOS activation...1854machine # [ 41.941703] systemd[615]: Finished Run user-specific NixOS activation.1855machine # [ 41.944941] systemd[1]: Stopped target Reactivate sysinit units.1856machine # [ 41.946357] systemd[1]: Stopping Reactivate sysinit units...1857machine # [ 41.947357] systemd[1]: Reached target Reactivate sysinit units.1858machine # [ 41.954214] systemd[1]: Set up automount testauto.automount.1859machine # [ 41.954994] systemd[1]: Reached target Local File Systems.1860machine # [ 41.957194] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1861machine # [ 41.960233] systemd[1]: Starting Create SUID/SGID Wrappers...1862machine # [ 41.962592] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1863machine # [ 41.963815] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671864machine # [ 41.966184] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1865machine # [ 41.967662] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1866machine # [ 41.968805] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1867machine # [ 41.974852] systemd[1]: Reached target Remote File Systems.1868machine # [ 41.979204] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1869machine # [ 41.980437] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1870machine # [ 42.103202] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1871machine # [ 42.105087] systemd[1]: Finished Create SUID/SGID Wrappers.1872machine # [ 42.108676] systemd[1]: Starting linger-users.service...1873machine # [ 42.137389] systemd[1]: linger-users.service: Deactivated successfully.1874machine # [ 42.139663] systemd[1]: Finished linger-users.service.1875machine # [ 42.396544] nixos[3444]: finished switching to system configuration /nix/store/fn1lf868qixdw48nmrf78mb29rh11zhw-nixos-system-machine-test1876machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/automount/bin/switch-to-configuration test 2>&1, in 1.40 seconds)1877machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/bin/switch-to-configuration test 2>&11878machine # [ 42.612398] nixos[3584]: switching to system configuration /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test1879machine # [ 42.615825] systemd[1]: Stopped target Local File Systems.1880machine # [ 42.616995] systemd[1]: Stopped target Remote File Systems.1881machine # [ 42.619718] systemd[1]: testauto.automount: Deactivated successfully.1882machine # [ 42.621279] systemd[1]: Unset automount testauto.automount.1883machine # [ 42.828263] systemd[1]: Reload requested from client PID 3584 ('.switch-to-conf') (unit backdoor.service)...1884machine # [ 42.829720] systemd[1]: Reloading...1885machine # [ 43.078683] systemd[1]: Reloading finished in 247 ms.1886machine # [ 43.140324] systemd[615]: Reexecution requested from client PID 3653 ('switch-to-confi')...1887machine # [ 43.142988] systemd[615]: Reexecuting.1888machine # [ 43.164089] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1889machine # [ 43.235296] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1890machine # [ 43.240498] systemd[615]: Reload requested from client PID 3653 ('switch-to-confi')...1891machine # [ 43.242793] systemd[615]: Reloading...1892machine # [ 43.313354] systemd[615]: Reloading finished in 70 ms.1893machine # [ 43.318856] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1894machine # [ 43.325240] systemd[615]: Stopped Run user-specific NixOS activation.1895machine # [ 43.326246] systemd[615]: Stopping Run user-specific NixOS activation...1896machine # [ 43.328823] systemd[615]: Starting Run user-specific NixOS activation...1897machine # [ 43.349702] systemd[615]: Finished Run user-specific NixOS activation.1898machine # [ 43.352770] systemd[1]: Stopped target Reactivate sysinit units.1899machine # [ 43.354303] systemd[1]: Stopping Reactivate sysinit units...1900machine # [ 43.355598] systemd[1]: Reached target Reactivate sysinit units.1901machine # [ 43.358319] systemd[1]: Reached target Local File Systems.1902machine # [ 43.359591] systemd[1]: Reached target Remote File Systems.1903machine # [ 43.362861] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1904machine # [ 43.364658] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1905machine # [ 43.367767] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1906machine # [ 43.371433] systemd[1]: Starting Create SUID/SGID Wrappers...1907machine # [ 43.373295] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1908machine # [ 43.375306] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671909machine # [ 43.378121] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1910machine # [ 43.381122] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1911machine # [ 43.382373] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1912machine # [ 43.509835] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1913machine # [ 43.511533] systemd[1]: Finished Create SUID/SGID Wrappers.1914machine # [ 43.515435] systemd[1]: Starting linger-users.service...1915machine # [ 43.542995] systemd[1]: linger-users.service: Deactivated successfully.1916machine # [ 43.544591] systemd[1]: Finished linger-users.service.1917machine # [ 43.802214] nixos[3584]: finished switching to system configuration /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test1918machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.40 seconds)1919(finished: subtest: fstab mounts, in 14.87 seconds)1920subtest: swaps1921machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/swap/bin/switch-to-configuration test 2>&11922machine # [ 44.020159] nixos[3724]: switching to system configuration /nix/store/8mzga7skkss5p2ylpmmb7b0nx0d9bxph-nixos-system-machine-test1923machine # [ 44.023605] systemd[1]: Stopped target Remote File Systems.1924machine # [ 44.024851] systemd[1]: Stopped target Local File Systems.1925machine # [ 44.247118] systemd[1]: Reload requested from client PID 3724 ('.switch-to-conf') (unit backdoor.service)...1926machine # [ 44.248737] systemd[1]: Reloading...1927machine # [ 44.491531] systemd[1]: Reloading finished in 241 ms.1928machine # [ 44.552861] systemd[615]: Reexecution requested from client PID 3793 ('switch-to-confi')...1929machine # [ 44.554717] systemd[615]: Reexecuting.1930machine # [ 44.575405] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1931machine # [ 44.646891] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1932machine # [ 44.652875] systemd[615]: Reload requested from client PID 3793 ('switch-to-confi')...1933machine # [ 44.654606] systemd[615]: Reloading...1934machine # [ 44.725460] systemd[615]: Reloading finished in 69 ms.1935machine # [ 44.730829] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1936machine # [ 44.736804] systemd[615]: Stopped Run user-specific NixOS activation.1937machine # [ 44.737771] systemd[615]: Stopping Run user-specific NixOS activation...1938machine # [ 44.740198] systemd[615]: Starting Run user-specific NixOS activation...1939machine # [ 44.759772] systemd[615]: Finished Run user-specific NixOS activation.1940machine # [ 44.762785] systemd[1]: Stopped target Reactivate sysinit units.1941machine # [ 44.764337] systemd[1]: Stopping Reactivate sysinit units...1942machine # [ 44.765650] systemd[1]: Reached target Reactivate sysinit units.1943machine # [ 44.771146] systemd[1]: Starting Initialisation of swap device /swapfile...1944machine # [ 44.777077] systemd[1]: Reached target Local File Systems.1945machine # [ 44.777895] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1946machine # [ 44.781357] systemd[1]: Starting Create SUID/SGID Wrappers...1947machine # [ 44.783031] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1948machine # [ 44.784188] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671949machine # [ 44.786110] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1950machine # [ 44.787523] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1951machine # [ 44.788685] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1952machine # [ 44.792569] systemd[1]: Reached target Remote File Systems.1953machine # [ 44.799400] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1954machine # [ 44.800663] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1955machine # [ 44.842555] mkswap-swapfile-start[3805]: Creating swap file using dd and mkswap.1956machine # [ 44.858871] mkswap-swapfile-start[3824]: 1+0 records in1957machine # [ 44.860508] mkswap-swapfile-start[3824]: 1+0 records out1958machine # [ 44.861328] mkswap-swapfile-start[3824]: 1048576 bytes (1.0 MB, 1.0 MiB) copied, 0.00380439 s, 276 MB/s1959machine # [ 44.873319] mkswap-swapfile-start[3826]: Setting up swapspace version 1, size = 1020 KiB (1044480 bytes)1960machine # [ 44.875078] mkswap-swapfile-start[3826]: no label, UUID=cc790c51-e807-48b6-a72a-2316d59ebf1d1961machine # [ 44.878388] systemd[1]: mkswap-swapfile.service: Deactivated successfully.1962machine # [ 44.880364] systemd[1]: Finished Initialisation of swap device /swapfile.1963machine # [ 44.881689] systemd[1]: mkswap-swapfile.service: Consumed 29ms CPU time over 109ms wall clock time, 3.4M memory peak, 1M written to disk.1964machine # [ 44.886422] systemd[1]: Activating swap /swapfile...1965machine # [ 45.056761] Adding 1020k swap on /swapfile. Priority:-2 extents:1 across:1020k1966machine # [ 44.914511] systemd[1]: Activated swap /swapfile.1967machine # [ 44.979844] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1968machine # [ 44.982500] systemd[1]: Finished Create SUID/SGID Wrappers.1969machine # [ 44.985436] systemd[1]: Starting linger-users.service...1970machine # [ 45.012923] systemd[1]: linger-users.service: Deactivated successfully.1971machine # [ 45.015284] systemd[1]: Finished linger-users.service.1972machine # [ 45.272564] nixos[3724]: finished switching to system configuration /nix/store/8mzga7skkss5p2ylpmmb7b0nx0d9bxph-nixos-system-machine-test1973machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/specialisation/swap/bin/switch-to-configuration test 2>&1, in 1.47 seconds)1974machine: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/bin/switch-to-configuration test 2>&11975machine # [ 45.472770] systemd[1]: swapfile.swap: Deactivated successfully.1976machine # [ 45.475446] nixos[3878]: switching to system configuration /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test1977machine # [ 45.477529] systemd[1]: Stopped target Local File Systems.1978machine # [ 45.479100] systemd[1]: Stopped target Remote File Systems.1979machine # [ 45.689473] systemd[1]: Reload requested from client PID 3878 ('.switch-to-conf') (unit backdoor.service)...1980machine # [ 45.691160] systemd[1]: Reloading...1981machine # [ 45.926296] systemd[1]: Reloading finished in 233 ms.1982machine # [ 45.990311] systemd[615]: Reexecution requested from client PID 3947 ('switch-to-confi')...1983machine # [ 45.992178] systemd[615]: Reexecuting.1984machine # [ 46.012175] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1985machine # [ 46.083326] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1986machine # [ 46.088685] systemd[615]: Reload requested from client PID 3947 ('switch-to-confi')...1987machine # [ 46.090451] systemd[615]: Reloading...1988machine # [ 46.163801] systemd[615]: Reloading finished in 71 ms.1989machine # [ 46.167857] systemd[615]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1990machine # [ 46.175076] systemd[615]: Stopped Run user-specific NixOS activation.1991machine # [ 46.175943] systemd[615]: Stopping Run user-specific NixOS activation...1992machine # [ 46.177754] systemd[615]: Starting Run user-specific NixOS activation...1993machine # [ 46.197350] systemd[615]: Finished Run user-specific NixOS activation.1994machine # [ 46.200596] systemd[1]: Stopped target Reactivate sysinit units.1995machine # [ 46.201922] systemd[1]: Stopping Reactivate sysinit units...1996machine # [ 46.202925] systemd[1]: Reached target Reactivate sysinit units.1997machine # [ 46.206946] systemd[1]: Reached target Local File Systems.1998machine # [ 46.208363] systemd[1]: Reached target Remote File Systems.1999machine # [ 46.210347] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2000machine # [ 46.213321] systemd[1]: Starting Create SUID/SGID Wrappers...2001machine # [ 46.215043] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2002machine # [ 46.216190] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672003machine # [ 46.218121] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2004machine # [ 46.219575] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2005machine # [ 46.220753] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2006machine # [ 46.230740] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2007machine # [ 46.232340] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2008machine # [ 46.360801] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2009machine # [ 46.362440] systemd[1]: Finished Create SUID/SGID Wrappers.2010machine # [ 46.366396] systemd[1]: Starting linger-users.service...2011machine # [ 46.393703] systemd[1]: linger-users.service: Deactivated successfully.2012machine # [ 46.396138] systemd[1]: Finished linger-users.service.2013machine # [ 46.651647] nixos[3878]: finished switching to system configuration /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test2014machine: (finished: must succeed: /nix/store/khjdcfcnqfz38dfmrj6phcnhl8ckk23w-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.38 seconds)2015(finished: subtest: swaps, in 2.85 seconds)2016(finished: run the VM test script, in 47.96 seconds)2017test script finished in 48.94s2018cleanup2019kill QemuMachine (pid 45)2020machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/xahxrjs30p3mw0a42bqg9ikgkikskw8m-python3-3.14.8/bin/python3.14)2021machine # [2026-10-23T03:10:00Z INFO virtiofsd] Client disconnected, shutting down2022machine # [2026-10-23T03:10:00Z INFO virtiofsd] Client disconnected, shutting down2023machine # [2026-10-23T03:10:00Z INFO virtiofsd] Client disconnected, shutting down2024(finished: cleanup, in 0.15 seconds)2025additionally exposed symbols:2026 machine, other,2027 vlan1,2028 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